{"level":"warn","ts":"2026-10-13T11:09:53.69435Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T11:09:53.694433Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.191: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.191:2380","--initial-cluster=instance=https://162.253.55.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.191: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-10-13T11:09:53.694496Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T11:09:53.694505Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.191:2380"]} {"level":"info","ts":"2026-10-13T11:09:53.694526Z","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-10-13T11:09:53.696504Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"]} {"level":"info","ts":"2026-10-13T11:09:53.696751Z","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.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.191: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-10-13T11:09:53.701538Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.211331ms"} {"level":"info","ts":"2026-10-13T11:09:53.715776Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adb6690514c92321","cluster-id":"ee04900e3a861beb"} {"level":"info","ts":"2026-10-13T11:09:53.715887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T11:09:53.715912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 0"} {"level":"info","ts":"2026-10-13T11:09:53.715943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adb6690514c92321 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T11:09:53.715952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 1"} {"level":"info","ts":"2026-10-13T11:09:53.7161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"} {"level":"warn","ts":"2026-10-13T11:09:53.723341Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T11:09:53.72478Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T11:09:53.727612Z","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-10-13T11:09:53.729583Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adb6690514c92321","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T11:09:53.729937Z","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-10-13T11:09:53.729994Z","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-10-13T11:09:53.730009Z","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-10-13T11:09:53.729822Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adb6690514c92321","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T11:09:53.73282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"} {"level":"info","ts":"2026-10-13T11:09:53.733329Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","added-peer-id":"adb6690514c92321","added-peer-peer-urls":["https://162.253.55.191:2380"]} {"level":"info","ts":"2026-10-13T11:09:53.735825Z","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-10-13T11:09:53.736017Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adb6690514c92321","initial-advertise-peer-urls":["https://162.253.55.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T11:09:53.736041Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T11:09:53.7361Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.191:2380"} {"level":"info","ts":"2026-10-13T11:09:53.736148Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.191:2380"} {"level":"info","ts":"2026-10-13T11:09:54.716906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T11:09:54.716973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T11:09:54.71699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgPreVoteResp from adb6690514c92321 at term 1"} {"level":"info","ts":"2026-10-13T11:09:54.717001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became candidate at term 2"} {"level":"info","ts":"2026-10-13T11:09:54.717006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgVoteResp from adb6690514c92321 at term 2"} {"level":"info","ts":"2026-10-13T11:09:54.717015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became leader at term 2"} {"level":"info","ts":"2026-10-13T11:09:54.717022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adb6690514c92321 elected leader adb6690514c92321 at term 2"} {"level":"info","ts":"2026-10-13T11:09:54.71812Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adb6690514c92321","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.191:2379]}","request-path":"/0/members/adb6690514c92321/attributes","cluster-id":"ee04900e3a861beb","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T11:09:54.718228Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:09:54.718291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T11:09:54.718178Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:09:54.718579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T11:09:54.71863Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T11:09:54.7193Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:09:54.719373Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:09:54.719389Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T11:09:54.720776Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T11:09:54.720915Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.191:2379"} {"level":"warn","ts":"2026-10-13T11:09:57.488945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.480012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:09:57.489094Z","caller":"traceutil/trace.go:171","msg":"trace[911650444] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"413.406822ms","start":"2026-10-13T11:09:57.075673Z","end":"2026-10-13T11:09:57.48908Z","steps":["trace[911650444] 'compare' (duration: 402.371839ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:09:57.489163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:09:57.075643Z","time spent":"413.500114ms","remote":"127.0.0.1:35080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:09:58.03569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.799081ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:09:58.035831Z","caller":"traceutil/trace.go:171","msg":"trace[62315981] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"541.999918ms","start":"2026-10-13T11:09:57.493808Z","end":"2026-10-13T11:09:58.035808Z","steps":["trace[62315981] 'process raft request' (duration: 203.020333ms)","trace[62315981] 'compare' (duration: 338.651918ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:09:58.035959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:09:57.493791Z","time spent":"542.094561ms","remote":"127.0.0.1:35080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T11:09:58.085391Z","caller":"traceutil/trace.go:171","msg":"trace[2041982316] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"533.023443ms","start":"2026-10-13T11:09:57.552353Z","end":"2026-10-13T11:09:58.085376Z","steps":["trace[2041982316] 'process raft request' (duration: 532.892321ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:09:58.085398Z","caller":"traceutil/trace.go:171","msg":"trace[1669167294] linearizableReadLoop","detail":"{readStateIndex:148; appliedIndex:147; }","duration":"222.336854ms","start":"2026-10-13T11:09:57.863021Z","end":"2026-10-13T11:09:58.085358Z","steps":["trace[1669167294] 'read index received' (duration: 222.176511ms)","trace[1669167294] 'applied index is now lower than readState.Index' (duration: 158.373µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:09:58.085474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:09:57.552329Z","time spent":"533.108936ms","remote":"127.0.0.1:34922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:09:58.085584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.167534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-13T11:09:58.085583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.548308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:09:58.085639Z","caller":"traceutil/trace.go:171","msg":"trace[846516072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:143; }","duration":"104.257147ms","start":"2026-10-13T11:09:57.981367Z","end":"2026-10-13T11:09:58.085624Z","steps":["trace[846516072] 'agreement among raft nodes before linearized reading' (duration: 104.129454ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:09:58.085705Z","caller":"traceutil/trace.go:171","msg":"trace[412307080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:143; }","duration":"222.64887ms","start":"2026-10-13T11:09:57.862984Z","end":"2026-10-13T11:09:58.085632Z","steps":["trace[412307080] 'agreement among raft nodes before linearized reading' (duration: 222.514267ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:38.559632Z","caller":"traceutil/trace.go:171","msg":"trace[1896336170] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"116.893812ms","start":"2026-10-13T11:10:38.442704Z","end":"2026-10-13T11:10:38.559598Z","steps":["trace[1896336170] 'process raft request' (duration: 67.112568ms)","trace[1896336170] 'compare' (duration: 49.457298ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:10:38.864264Z","caller":"traceutil/trace.go:171","msg":"trace[583161508] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"126.122329ms","start":"2026-10-13T11:10:38.738113Z","end":"2026-10-13T11:10:38.864236Z","steps":["trace[583161508] 'process raft request' (duration: 118.621963ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:38.864387Z","caller":"traceutil/trace.go:171","msg":"trace[1443261382] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:564; }","duration":"124.206445ms","start":"2026-10-13T11:10:38.740166Z","end":"2026-10-13T11:10:38.864372Z","steps":["trace[1443261382] 'read index received' (duration: 56.955734ms)","trace[1443261382] 'applied index is now lower than readState.Index' (duration: 67.249771ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:10:38.864532Z","caller":"traceutil/trace.go:171","msg":"trace[26571615] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"115.825183ms","start":"2026-10-13T11:10:38.748644Z","end":"2026-10-13T11:10:38.864469Z","steps":["trace[26571615] 'process raft request' (duration: 115.504777ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:38.864559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.356127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-10-13T11:10:38.8647Z","caller":"traceutil/trace.go:171","msg":"trace[2028468149] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:548; }","duration":"124.53662ms","start":"2026-10-13T11:10:38.74013Z","end":"2026-10-13T11:10:38.864667Z","steps":["trace[2028468149] 'agreement among raft nodes before linearized reading' (duration: 124.310686ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:41.181553Z","caller":"traceutil/trace.go:171","msg":"trace[1464574592] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"335.883882ms","start":"2026-10-13T11:10:40.845652Z","end":"2026-10-13T11:10:41.181536Z","steps":["trace[1464574592] 'process raft request' (duration: 335.611857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:41.181818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:40.845631Z","time spent":"335.975735ms","remote":"127.0.0.1:34772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:10:41.31024Z","caller":"traceutil/trace.go:171","msg":"trace[1527236525] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"450.122127ms","start":"2026-10-13T11:10:40.860081Z","end":"2026-10-13T11:10:41.310203Z","steps":["trace[1527236525] 'process raft request' (duration: 445.82987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:41.310414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:40.860067Z","time spent":"450.264759ms","remote":"127.0.0.1:34772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T11:10:41.310848Z","caller":"traceutil/trace.go:171","msg":"trace[1016807704] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:629; }","duration":"382.213241ms","start":"2026-10-13T11:10:40.928613Z","end":"2026-10-13T11:10:41.310826Z","steps":["trace[1016807704] 'read index received' (duration: 252.543098ms)","trace[1016807704] 'applied index is now lower than readState.Index' (duration: 129.668633ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:10:41.311066Z","caller":"traceutil/trace.go:171","msg":"trace[1561020926] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"437.59721ms","start":"2026-10-13T11:10:40.873414Z","end":"2026-10-13T11:10:41.311011Z","steps":["trace[1561020926] 'process raft request' (duration: 436.562172ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:41.311278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:40.873395Z","time spent":"437.765443ms","remote":"127.0.0.1:34772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:10:41.3114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.763711ms","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-10-13T11:10:41.311487Z","caller":"traceutil/trace.go:171","msg":"trace[1601386889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"382.880382ms","start":"2026-10-13T11:10:40.928574Z","end":"2026-10-13T11:10:41.311455Z","steps":["trace[1601386889] 'agreement among raft nodes before linearized reading' (duration: 382.647258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:41.311536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:40.928544Z","time spent":"382.982325ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-13T11:10:41.331115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.974059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:10:41.3313Z","caller":"traceutil/trace.go:171","msg":"trace[1512320319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"215.212202ms","start":"2026-10-13T11:10:41.116063Z","end":"2026-10-13T11:10:41.331275Z","steps":["trace[1512320319] 'agreement among raft nodes before linearized reading' (duration: 214.959538ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:47.714112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.057854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-42rkm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-13T11:10:47.714213Z","caller":"traceutil/trace.go:171","msg":"trace[306927037] range","detail":"{range_begin:/registry/pods/kube-system/cilium-42rkm; range_end:; response_count:1; response_revision:665; }","duration":"143.258387ms","start":"2026-10-13T11:10:47.570935Z","end":"2026-10-13T11:10:47.714193Z","steps":["trace[306927037] 'range keys from in-memory index tree' (duration: 142.850061ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:47.813095Z","caller":"traceutil/trace.go:171","msg":"trace[1526932652] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"168.673737ms","start":"2026-10-13T11:10:47.644389Z","end":"2026-10-13T11:10:47.813063Z","steps":["trace[1526932652] 'process raft request' (duration: 168.094027ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:48.184286Z","caller":"traceutil/trace.go:171","msg":"trace[424491232] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"452.401516ms","start":"2026-10-13T11:10:47.731858Z","end":"2026-10-13T11:10:48.184259Z","steps":["trace[424491232] 'process raft request' (duration: 452.235283ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:48.184494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:47.731804Z","time spent":"452.578379ms","remote":"127.0.0.1:34922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:10:48.205395Z","caller":"traceutil/trace.go:171","msg":"trace[689512166] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:689; }","duration":"258.095423ms","start":"2026-10-13T11:10:47.947269Z","end":"2026-10-13T11:10:48.205364Z","steps":["trace[689512166] 'read index received' (duration: 236.963019ms)","trace[689512166] 'applied index is now lower than readState.Index' (duration: 21.131134ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:10:48.205731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.436279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:10:48.20574Z","caller":"traceutil/trace.go:171","msg":"trace[1326876958] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"322.514134ms","start":"2026-10-13T11:10:47.882933Z","end":"2026-10-13T11:10:48.205447Z","steps":["trace[1326876958] 'process raft request' (duration: 322.320681ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:48.205994Z","caller":"traceutil/trace.go:171","msg":"trace[201696513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"258.568482ms","start":"2026-10-13T11:10:47.947232Z","end":"2026-10-13T11:10:48.205801Z","steps":["trace[201696513] 'agreement among raft nodes before linearized reading' (duration: 258.233326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:48.205995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:47.882902Z","time spent":"323.000673ms","remote":"127.0.0.1:34984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:10:48.831979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.050518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:10:48.83211Z","caller":"traceutil/trace.go:171","msg":"trace[717182433] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"368.900088ms","start":"2026-10-13T11:10:48.46319Z","end":"2026-10-13T11:10:48.83209Z","steps":["trace[717182433] 'read index received' (duration: 92.609286ms)","trace[717182433] 'applied index is now lower than readState.Index' (duration: 276.289202ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:10:48.832138Z","caller":"traceutil/trace.go:171","msg":"trace[1872650253] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"607.488903ms","start":"2026-10-13T11:10:48.224629Z","end":"2026-10-13T11:10:48.832118Z","steps":["trace[1872650253] 'process raft request' (duration: 331.228331ms)","trace[1872650253] 'compare' (duration: 275.837624ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:10:48.83221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:48.224614Z","time spent":"607.563614ms","remote":"127.0.0.1:34922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T11:10:48.832629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.57964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.191\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-10-13T11:10:48.83268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.813119ms","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-10-13T11:10:48.832725Z","caller":"traceutil/trace.go:171","msg":"trace[897416620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:669; }","duration":"118.930041ms","start":"2026-10-13T11:10:48.713785Z","end":"2026-10-13T11:10:48.832715Z","steps":["trace[897416620] 'agreement among raft nodes before linearized reading' (duration: 118.692647ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:48.832767Z","caller":"traceutil/trace.go:171","msg":"trace[1596390788] range","detail":"{range_begin:/registry/masterleases/162.253.55.191; range_end:; response_count:1; response_revision:669; }","duration":"176.683552ms","start":"2026-10-13T11:10:48.656026Z","end":"2026-10-13T11:10:48.83271Z","steps":["trace[1596390788] 'agreement among raft nodes before linearized reading' (duration: 176.460158ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:48.832963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.442406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-13T11:10:48.833053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.854995ms","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-10-13T11:10:48.833123Z","caller":"traceutil/trace.go:171","msg":"trace[2129256601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:669; }","duration":"369.959207ms","start":"2026-10-13T11:10:48.463144Z","end":"2026-10-13T11:10:48.833103Z","steps":["trace[2129256601] 'agreement among raft nodes before linearized reading' (duration: 369.084732ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:10:48.833177Z","caller":"traceutil/trace.go:171","msg":"trace[1754964875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:669; }","duration":"305.613379ms","start":"2026-10-13T11:10:48.52746Z","end":"2026-10-13T11:10:48.833074Z","steps":["trace[1754964875] 'agreement among raft nodes before linearized reading' (duration: 304.866646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:10:48.83332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:48.527449Z","time spent":"305.826644ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-13T11:10:48.833213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:10:48.463124Z","time spent":"370.073079ms","remote":"127.0.0.1:35014","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":"info","ts":"2026-10-13T11:11:05.161498Z","caller":"traceutil/trace.go:171","msg":"trace[1283297307] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"128.447154ms","start":"2026-10-13T11:11:05.03303Z","end":"2026-10-13T11:11:05.161477Z","steps":["trace[1283297307] 'process raft request' (duration: 128.403623ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:05.161675Z","caller":"traceutil/trace.go:171","msg":"trace[1399741118] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"129.066865ms","start":"2026-10-13T11:11:05.032598Z","end":"2026-10-13T11:11:05.161665Z","steps":["trace[1399741118] 'process raft request' (duration: 119.875679ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:35.279415Z","caller":"traceutil/trace.go:171","msg":"trace[1184436939] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"306.447652ms","start":"2026-10-13T11:11:34.972929Z","end":"2026-10-13T11:11:35.279377Z","steps":["trace[1184436939] 'process raft request' (duration: 306.211009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:11:35.2796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:11:34.972904Z","time spent":"306.604525ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T11:11:35.418502Z","caller":"traceutil/trace.go:171","msg":"trace[164848003] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"113.646741ms","start":"2026-10-13T11:11:35.304826Z","end":"2026-10-13T11:11:35.418473Z","steps":["trace[164848003] 'read index received' (duration: 106.373623ms)","trace[164848003] 'applied index is now lower than readState.Index' (duration: 7.271398ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:11:35.4188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.951275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-13T11:11:35.418901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.332552ms","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-10-13T11:11:35.418927Z","caller":"traceutil/trace.go:171","msg":"trace[1755100621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"114.156588ms","start":"2026-10-13T11:11:35.304745Z","end":"2026-10-13T11:11:35.418902Z","steps":["trace[1755100621] 'agreement among raft nodes before linearized reading' (duration: 113.851914ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:35.418958Z","caller":"traceutil/trace.go:171","msg":"trace[1388144357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"106.458304ms","start":"2026-10-13T11:11:35.312475Z","end":"2026-10-13T11:11:35.418933Z","steps":["trace[1388144357] 'agreement among raft nodes before linearized reading' (duration: 106.173549ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:11:35.419934Z","caller":"traceutil/trace.go:171","msg":"trace[1607168562] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"134.899634ms","start":"2026-10-13T11:11:35.284203Z","end":"2026-10-13T11:11:35.419103Z","steps":["trace[1607168562] 'process raft request' (duration: 127.83355ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:12:27.889031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.719702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T11:12:27.889063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.588637ms","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-10-13T11:12:27.889162Z","caller":"traceutil/trace.go:171","msg":"trace[574658142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1931; }","duration":"164.727441ms","start":"2026-10-13T11:12:27.724407Z","end":"2026-10-13T11:12:27.889135Z","steps":["trace[574658142] 'range keys from in-memory index tree' (duration: 164.38209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:12:27.889397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.551733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-13T11:12:27.889417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.560334ms","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-10-13T11:12:27.889468Z","caller":"traceutil/trace.go:171","msg":"trace[871282393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1931; }","duration":"139.625065ms","start":"2026-10-13T11:12:27.749826Z","end":"2026-10-13T11:12:27.889451Z","steps":["trace[871282393] 'range keys from in-memory index tree' (duration: 138.966115ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:27.889518Z","caller":"traceutil/trace.go:171","msg":"trace[1180573158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1931; }","duration":"139.710878ms","start":"2026-10-13T11:12:27.749786Z","end":"2026-10-13T11:12:27.889497Z","steps":["trace[1180573158] 'range keys from in-memory index tree' (duration: 139.088049ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:27.889133Z","caller":"traceutil/trace.go:171","msg":"trace[376596671] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1931; }","duration":"143.904527ms","start":"2026-10-13T11:12:27.745206Z","end":"2026-10-13T11:12:27.889111Z","steps":["trace[376596671] 'count revisions from in-memory index tree' (duration: 143.596827ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:28.190422Z","caller":"traceutil/trace.go:171","msg":"trace[1983036542] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"296.425741ms","start":"2026-10-13T11:12:27.893971Z","end":"2026-10-13T11:12:28.190397Z","steps":["trace[1983036542] 'process raft request' (duration: 296.255355ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:28.253352Z","caller":"traceutil/trace.go:171","msg":"trace[685012429] linearizableReadLoop","detail":"{readStateIndex:2005; appliedIndex:2002; }","duration":"274.833926ms","start":"2026-10-13T11:12:27.978488Z","end":"2026-10-13T11:12:28.253322Z","steps":["trace[685012429] 'read index received' (duration: 211.734633ms)","trace[685012429] 'applied index is now lower than readState.Index' (duration: 63.097423ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:12:28.253494Z","caller":"traceutil/trace.go:171","msg":"trace[2139930781] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"358.490392ms","start":"2026-10-13T11:12:27.894977Z","end":"2026-10-13T11:12:28.253467Z","steps":["trace[2139930781] 'process raft request' (duration: 358.292486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:12:28.253624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:12:27.894923Z","time spent":"358.625366ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:12:28.253662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.139375ms","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-10-13T11:12:28.253692Z","caller":"traceutil/trace.go:171","msg":"trace[546901475] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1934; }","duration":"275.239398ms","start":"2026-10-13T11:12:27.978443Z","end":"2026-10-13T11:12:28.253683Z","steps":["trace[546901475] 'agreement among raft nodes before linearized reading' (duration: 275.060303ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:28.253806Z","caller":"traceutil/trace.go:171","msg":"trace[1511662641] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"359.181993ms","start":"2026-10-13T11:12:27.89461Z","end":"2026-10-13T11:12:28.253792Z","steps":["trace[1511662641] 'process raft request' (duration: 336.483084ms)","trace[1511662641] 'compare' (duration: 21.957576ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:12:28.253857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T11:12:27.894591Z","time spent":"359.240825ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T11:12:28.253913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.841265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T11:12:28.25403Z","caller":"traceutil/trace.go:171","msg":"trace[1821844061] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1934; }","duration":"238.02544ms","start":"2026-10-13T11:12:28.015982Z","end":"2026-10-13T11:12:28.254007Z","steps":["trace[1821844061] 'agreement among raft nodes before linearized reading' (duration: 237.560136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:12:28.253971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.242754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85c66a21-678d-4c89-bf32-c0cdb0d42ad9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-13T11:12:28.254294Z","caller":"traceutil/trace.go:171","msg":"trace[315575437] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85c66a21-678d-4c89-bf32-c0cdb0d42ad9; range_end:; response_count:1; response_revision:1934; }","duration":"122.595276ms","start":"2026-10-13T11:12:28.131681Z","end":"2026-10-13T11:12:28.254276Z","steps":["trace[315575437] 'agreement among raft nodes before linearized reading' (duration: 122.215134ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:28.406212Z","caller":"traceutil/trace.go:171","msg":"trace[5123838] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"141.798967ms","start":"2026-10-13T11:12:28.264391Z","end":"2026-10-13T11:12:28.40619Z","steps":["trace[5123838] 'process raft request' (duration: 121.525732ms)","trace[5123838] 'compare' (duration: 20.153241ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:12:28.409047Z","caller":"traceutil/trace.go:171","msg":"trace[312659886] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"144.309144ms","start":"2026-10-13T11:12:28.264726Z","end":"2026-10-13T11:12:28.409035Z","steps":["trace[312659886] 'process raft request' (duration: 144.234262ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:35.770643Z","caller":"traceutil/trace.go:171","msg":"trace[1956687701] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"181.369279ms","start":"2026-10-13T11:12:35.589255Z","end":"2026-10-13T11:12:35.770625Z","steps":["trace[1956687701] 'process raft request' (duration: 180.966577ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:12:56.505303Z","caller":"traceutil/trace.go:171","msg":"trace[215605876] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"162.514512ms","start":"2026-10-13T11:12:56.342764Z","end":"2026-10-13T11:12:56.505278Z","steps":["trace[215605876] 'process raft request' (duration: 86.05736ms)","trace[215605876] 'compare' (duration: 76.127883ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:13:02.56742Z","caller":"traceutil/trace.go:171","msg":"trace[428869748] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"153.015386ms","start":"2026-10-13T11:13:02.414381Z","end":"2026-10-13T11:13:02.567396Z","steps":["trace[428869748] 'process raft request' (duration: 152.840821ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:13:03.164379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.837342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T11:13:03.164476Z","caller":"traceutil/trace.go:171","msg":"trace[64488328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2174; }","duration":"215.040207ms","start":"2026-10-13T11:13:02.949412Z","end":"2026-10-13T11:13:03.164452Z","steps":["trace[64488328] 'range keys from in-memory index tree' (duration: 214.701208ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:13:03.455925Z","caller":"traceutil/trace.go:171","msg":"trace[1978067773] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"121.041017ms","start":"2026-10-13T11:13:03.334792Z","end":"2026-10-13T11:13:03.455833Z","steps":["trace[1978067773] 'process raft request' (duration: 36.769158ms)","trace[1978067773] 'compare' (duration: 83.609661ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:14:43.256808Z","caller":"traceutil/trace.go:171","msg":"trace[562632537] transaction","detail":"{read_only:false; response_revision:2818; number_of_response:1; }","duration":"106.212761ms","start":"2026-10-13T11:14:43.150571Z","end":"2026-10-13T11:14:43.256783Z","steps":["trace[562632537] 'process raft request' (duration: 106.077438ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:14:43.300425Z","caller":"traceutil/trace.go:171","msg":"trace[1700477955] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"146.249234ms","start":"2026-10-13T11:14:43.154146Z","end":"2026-10-13T11:14:43.300395Z","steps":["trace[1700477955] 'process raft request' (duration: 114.717674ms)","trace[1700477955] 'compare' (duration: 31.104971ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:14:43.300576Z","caller":"traceutil/trace.go:171","msg":"trace[1364439332] linearizableReadLoop","detail":"{readStateIndex:2920; appliedIndex:2918; }","duration":"116.043553ms","start":"2026-10-13T11:14:43.184486Z","end":"2026-10-13T11:14:43.300529Z","steps":["trace[1364439332] 'read index received' (duration: 72.109595ms)","trace[1364439332] 'applied index is now lower than readState.Index' (duration: 43.930668ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:14:43.300807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.291968ms","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-10-13T11:14:43.300921Z","caller":"traceutil/trace.go:171","msg":"trace[1463998951] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2820; }","duration":"116.457332ms","start":"2026-10-13T11:14:43.184439Z","end":"2026-10-13T11:14:43.300897Z","steps":["trace[1463998951] 'agreement among raft nodes before linearized reading' (duration: 116.192416ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:14:48.690325Z","caller":"traceutil/trace.go:171","msg":"trace[652507025] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"117.141924ms","start":"2026-10-13T11:14:48.573153Z","end":"2026-10-13T11:14:48.690295Z","steps":["trace[652507025] 'process raft request' (duration: 116.787617ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:09.639207Z","caller":"traceutil/trace.go:171","msg":"trace[1920937913] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"253.110993ms","start":"2026-10-13T11:19:09.386073Z","end":"2026-10-13T11:19:09.639184Z","steps":["trace[1920937913] 'process raft request' (duration: 252.96834ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:09.672373Z","caller":"traceutil/trace.go:171","msg":"trace[1108322661] linearizableReadLoop","detail":"{readStateIndex:5163; appliedIndex:5161; }","duration":"271.156653ms","start":"2026-10-13T11:19:09.401192Z","end":"2026-10-13T11:19:09.672349Z","steps":["trace[1108322661] 'read index received' (duration: 237.813607ms)","trace[1108322661] 'applied index is now lower than readState.Index' (duration: 33.341676ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:19:09.672502Z","caller":"traceutil/trace.go:171","msg":"trace[1234704233] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"276.394964ms","start":"2026-10-13T11:19:09.396075Z","end":"2026-10-13T11:19:09.67247Z","steps":["trace[1234704233] 'process raft request' (duration: 252.739806ms)","trace[1234704233] 'compare' (duration: 23.411674ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:19:09.67261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.394687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-10-13T11:19:09.672721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.847133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fe8aae35-6857-4ce6-9fdd-c42b44125fdd\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-13T11:19:09.672686Z","caller":"traceutil/trace.go:171","msg":"trace[1424259268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4978; }","duration":"271.489329ms","start":"2026-10-13T11:19:09.401158Z","end":"2026-10-13T11:19:09.672647Z","steps":["trace[1424259268] 'agreement among raft nodes before linearized reading' (duration: 271.330467ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:09.672791Z","caller":"traceutil/trace.go:171","msg":"trace[679495401] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fe8aae35-6857-4ce6-9fdd-c42b44125fdd; range_end:; response_count:1; response_revision:4978; }","duration":"224.945846ms","start":"2026-10-13T11:19:09.447827Z","end":"2026-10-13T11:19:09.672772Z","steps":["trace[679495401] 'agreement among raft nodes before linearized reading' (duration: 224.738822ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:10.302968Z","caller":"traceutil/trace.go:171","msg":"trace[675377816] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"188.651399ms","start":"2026-10-13T11:19:10.114288Z","end":"2026-10-13T11:19:10.302939Z","steps":["trace[675377816] 'process raft request' (duration: 188.466356ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:23.3641Z","caller":"traceutil/trace.go:171","msg":"trace[655688987] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"109.918343ms","start":"2026-10-13T11:19:23.254152Z","end":"2026-10-13T11:19:23.36407Z","steps":["trace[655688987] 'process raft request' (duration: 109.215011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:19:23.648825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.523872ms","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-10-13T11:19:23.648944Z","caller":"traceutil/trace.go:171","msg":"trace[2010308989] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5148; }","duration":"200.653174ms","start":"2026-10-13T11:19:23.448273Z","end":"2026-10-13T11:19:23.648926Z","steps":["trace[2010308989] 'range keys from in-memory index tree' (duration: 200.508642ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:19:23.649448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.262214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:19:23.649809Z","caller":"traceutil/trace.go:171","msg":"trace[2026175398] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"279.583433ms","start":"2026-10-13T11:19:23.370197Z","end":"2026-10-13T11:19:23.649781Z","steps":["trace[2026175398] 'process raft request' (duration: 145.885961ms)","trace[2026175398] 'compare' (duration: 132.712515ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:19:23.649846Z","caller":"traceutil/trace.go:171","msg":"trace[348463780] linearizableReadLoop","detail":"{readStateIndex:5342; appliedIndex:5338; }","duration":"219.434738ms","start":"2026-10-13T11:19:23.430393Z","end":"2026-10-13T11:19:23.649827Z","steps":["trace[348463780] 'read index received' (duration: 85.704246ms)","trace[348463780] 'applied index is now lower than readState.Index' (duration: 133.728872ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:19:23.649885Z","caller":"traceutil/trace.go:171","msg":"trace[590708468] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"278.765399ms","start":"2026-10-13T11:19:23.371097Z","end":"2026-10-13T11:19:23.649862Z","steps":["trace[590708468] 'process raft request' (duration: 278.506145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T11:19:23.650093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.686692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-10-13T11:19:23.65011Z","caller":"traceutil/trace.go:171","msg":"trace[10539087] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"278.405032ms","start":"2026-10-13T11:19:23.371694Z","end":"2026-10-13T11:19:23.650099Z","steps":["trace[10539087] 'process raft request' (duration: 278.022736ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:23.650148Z","caller":"traceutil/trace.go:171","msg":"trace[867831133] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5152; }","duration":"219.783704ms","start":"2026-10-13T11:19:23.43035Z","end":"2026-10-13T11:19:23.650134Z","steps":["trace[867831133] 'agreement among raft nodes before linearized reading' (duration: 219.5333ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:23.650244Z","caller":"traceutil/trace.go:171","msg":"trace[487466227] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"278.127418ms","start":"2026-10-13T11:19:23.372086Z","end":"2026-10-13T11:19:23.650214Z","steps":["trace[487466227] 'process raft request' (duration: 277.682051ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:19:54.74346Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2880} {"level":"info","ts":"2026-10-13T11:19:54.832177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2880,"took":"86.945686ms","hash":3766524845,"current-db-size-bytes":52514816,"current-db-size":"52 MB","current-db-size-in-use-bytes":27648000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-13T11:19:54.832226Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3766524845,"revision":2880,"compact-revision":-1} {"level":"warn","ts":"2026-10-13T11:23:36.451578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.356137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T11:23:36.451959Z","caller":"traceutil/trace.go:171","msg":"trace[1028549868] linearizableReadLoop","detail":"{readStateIndex:7234; appliedIndex:7233; }","duration":"223.449771ms","start":"2026-10-13T11:23:36.228479Z","end":"2026-10-13T11:23:36.451929Z","steps":["trace[1028549868] 'read index received' (duration: 12.615842ms)","trace[1028549868] 'applied index is now lower than readState.Index' (duration: 210.832359ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T11:23:36.452205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.719299ms","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-10-13T11:23:36.452244Z","caller":"traceutil/trace.go:171","msg":"trace[988321358] transaction","detail":"{read_only:false; response_revision:6981; number_of_response:1; }","duration":"263.395823ms","start":"2026-10-13T11:23:36.188555Z","end":"2026-10-13T11:23:36.451951Z","steps":["trace[988321358] 'process raft request' (duration: 52.590854ms)","trace[988321358] 'compare' (duration: 210.043419ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T11:23:36.45242Z","caller":"traceutil/trace.go:171","msg":"trace[330570429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6981; }","duration":"223.898504ms","start":"2026-10-13T11:23:36.228427Z","end":"2026-10-13T11:23:36.452325Z","steps":["trace[330570429] 'agreement among raft nodes before linearized reading' (duration: 223.675268ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:24:54.749281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5363} {"level":"info","ts":"2026-10-13T11:24:54.848133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5363,"took":"97.777112ms","hash":3121599374,"current-db-size-bytes":52514816,"current-db-size":"52 MB","current-db-size-in-use-bytes":18616320,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-13T11:24:54.848206Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3121599374,"revision":5363,"compact-revision":2880}