{"level":"warn","ts":"2026-02-26T03:02:24.853837Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T03:02:24.853981Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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://199.204.45.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-02-26T03:02:24.854052Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T03:02:24.85407Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-02-26T03:02:24.854094Z","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-02-26T03:02:24.854975Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-02-26T03:02:24.855127Z","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://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-02-26T03:02:24.860267Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.910497ms"} {"level":"info","ts":"2026-02-26T03:02:24.867488Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-02-26T03:02:24.867595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T03:02:24.867619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-02-26T03:02:24.867629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T03:02:24.867637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-02-26T03:02:24.867681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-02-26T03:02:24.877284Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T03:02:24.881309Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T03:02:24.883673Z","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-02-26T03:02:24.887091Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T03:02:24.887206Z","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-02-26T03:02:24.887319Z","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-02-26T03:02:24.887328Z","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-02-26T03:02:24.887701Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T03:02:24.890252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-02-26T03:02:24.890672Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-02-26T03:02:24.892561Z","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-02-26T03:02:24.892869Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T03:02:24.892896Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T03:02:24.893569Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-02-26T03:02:24.893621Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-02-26T03:02:24.968044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T03:02:24.968146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T03:02:24.968193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-02-26T03:02:24.968218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-02-26T03:02:24.968239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-02-26T03:02:24.968507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-02-26T03:02:24.968524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-02-26T03:02:24.969881Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T03:02:24.969968Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:02:24.97024Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T03:02:24.970283Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T03:02:24.970522Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T03:02:24.970605Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T03:02:24.971668Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:02:24.971824Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:02:24.97191Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:02:24.974138Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-02-26T03:02:24.974723Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T03:02:28.674587Z","caller":"traceutil/trace.go:171","msg":"trace[48751786] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"147.973525ms","start":"2026-02-26T03:02:28.52656Z","end":"2026-02-26T03:02:28.674533Z","steps":["trace[48751786] 'process raft request' (duration: 114.97013ms)","trace[48751786] 'compare' (duration: 32.807354ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:02:30.802266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000457726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-26T03:02:30.802459Z","caller":"traceutil/trace.go:171","msg":"trace[1425317759] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000762038s","start":"2026-02-26T03:02:28.801671Z","end":"2026-02-26T03:02:30.802433Z","steps":["trace[1425317759] 'agreement among raft nodes before linearized reading' (duration: 2.000499816s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:30.802534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:28.801644Z","time spent":"2.000876879s","remote":"127.0.0.1:40616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/26 03:02:30 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-26T03:02:30.854251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000594563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-26T03:02:30.854391Z","caller":"traceutil/trace.go:171","msg":"trace[827238954] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000853375s","start":"2026-02-26T03:02:28.85351Z","end":"2026-02-26T03:02:30.854363Z","steps":["trace[827238954] 'agreement among raft nodes before linearized reading' (duration: 2.000638704s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:30.854453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:28.853483Z","time spent":"2.000956385s","remote":"127.0.0.1:40624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/26 03:02:30 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-26T03:02:31.464833Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.229695408s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-26T03:02:31.545019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.245226691s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:02:31.545258Z","caller":"traceutil/trace.go:171","msg":"trace[986261276] linearizableReadLoop","detail":"{readStateIndex:194; appliedIndex:193; }","duration":"2.743499683s","start":"2026-02-26T03:02:28.801741Z","end":"2026-02-26T03:02:31.545241Z","steps":["trace[986261276] 'read index received' (duration: 497.074834ms)","trace[986261276] 'applied index is now lower than readState.Index' (duration: 2.246422819s)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:02:31.545361Z","caller":"traceutil/trace.go:171","msg":"trace[1384241731] transaction","detail":"{read_only:false; response_revision:190; number_of_response:1; }","duration":"2.862715434s","start":"2026-02-26T03:02:28.682477Z","end":"2026-02-26T03:02:31.545192Z","steps":["trace[1384241731] 'process raft request' (duration: 616.510147ms)","trace[1384241731] 'compare' (duration: 2.239900373s)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:02:31.545485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:28.682461Z","time spent":"2.862935986s","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":718,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T03:02:31.545706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:30.234334Z","time spent":"1.311366189s","remote":"127.0.0.1:40696","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-26T03:02:32.046328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309635559810269,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T03:02:32.480888Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.011520602s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T03:02:32.481792Z","caller":"traceutil/trace.go:171","msg":"trace[1200038665] transaction","detail":"{read_only:false; response_revision:192; number_of_response:1; }","duration":"1.431622551s","start":"2026-02-26T03:02:31.050135Z","end":"2026-02-26T03:02:32.481757Z","steps":["trace[1200038665] 'process raft request' (duration: 1.431559581s)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:02:32.48183Z","caller":"traceutil/trace.go:171","msg":"trace[1167335744] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"1.917933804s","start":"2026-02-26T03:02:30.56386Z","end":"2026-02-26T03:02:32.481793Z","steps":["trace[1167335744] 'process raft request' (duration: 1.917581761s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.482009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:31.050106Z","time spent":"1.431802803s","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T03:02:32.482044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:30.563822Z","time spent":"1.918101535s","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5872,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T03:02:32.484019Z","caller":"traceutil/trace.go:171","msg":"trace[1379543317] linearizableReadLoop","detail":"{readStateIndex:198; appliedIndex:195; }","duration":"938.667394ms","start":"2026-02-26T03:02:31.545323Z","end":"2026-02-26T03:02:32.48399Z","steps":["trace[1379543317] 'read index received' (duration: 936.022415ms)","trace[1379543317] 'applied index is now lower than readState.Index' (duration: 2.643569ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:02:32.484158Z","caller":"traceutil/trace.go:171","msg":"trace[64496255] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"937.391774ms","start":"2026-02-26T03:02:31.546752Z","end":"2026-02-26T03:02:32.484143Z","steps":["trace[64496255] 'process raft request' (duration: 937.094582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.48426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:31.546727Z","time spent":"937.465025ms","remote":"127.0.0.1:40696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T03:02:32.484527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.863549382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T03:02:32.484551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.530807677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T03:02:32.484627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.675015206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:02:32.484637Z","caller":"traceutil/trace.go:171","msg":"trace[297884311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:193; }","duration":"1.530961819s","start":"2026-02-26T03:02:30.953651Z","end":"2026-02-26T03:02:32.484613Z","steps":["trace[297884311] 'agreement among raft nodes before linearized reading' (duration: 1.530769788s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.484667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.498678171s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:02:32.484623Z","caller":"traceutil/trace.go:171","msg":"trace[1752859155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:193; }","duration":"2.863693383s","start":"2026-02-26T03:02:29.620907Z","end":"2026-02-26T03:02:32.4846Z","steps":["trace[1752859155] 'agreement among raft nodes before linearized reading' (duration: 2.863483101s)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:02:32.484712Z","caller":"traceutil/trace.go:171","msg":"trace[1844604794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:193; }","duration":"1.498805301s","start":"2026-02-26T03:02:30.985894Z","end":"2026-02-26T03:02:32.4847Z","steps":["trace[1844604794] 'agreement among raft nodes before linearized reading' (duration: 1.498718861s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.484715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:30.953622Z","time spent":"1.531079139s","remote":"127.0.0.1:40616","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-02-26T03:02:32.484702Z","caller":"traceutil/trace.go:171","msg":"trace[412493241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:193; }","duration":"3.675137046s","start":"2026-02-26T03:02:28.809549Z","end":"2026-02-26T03:02:32.484686Z","steps":["trace[412493241] 'agreement among raft nodes before linearized reading' (duration: 3.675046966s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.484759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.886575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T03:02:32.484769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:29.620883Z","time spent":"2.863869624s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T03:02:32.484787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:28.809521Z","time spent":"3.675260427s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-26T03:02:32.484799Z","caller":"traceutil/trace.go:171","msg":"trace[2022918359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:193; }","duration":"181.974135ms","start":"2026-02-26T03:02:32.302814Z","end":"2026-02-26T03:02:32.484788Z","steps":["trace[2022918359] 'agreement among raft nodes before linearized reading' (duration: 181.915135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.484554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.854851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:02:32.4849Z","caller":"traceutil/trace.go:171","msg":"trace[1322510644] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:token-cleaner; range_end:; response_count:0; response_revision:193; }","duration":"937.250505ms","start":"2026-02-26T03:02:31.547638Z","end":"2026-02-26T03:02:32.484889Z","steps":["trace[1322510644] 'agreement among raft nodes before linearized reading' (duration: 936.845192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.484758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:30.985865Z","time spent":"1.498886302s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T03:02:32.484937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:31.547627Z","time spent":"937.301695ms","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/kube-system/system:controller:token-cleaner\" "} {"level":"warn","ts":"2026-02-26T03:02:32.484917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.147039697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:02:32.484987Z","caller":"traceutil/trace.go:171","msg":"trace[1797235873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:193; }","duration":"2.147193218s","start":"2026-02-26T03:02:30.337776Z","end":"2026-02-26T03:02:32.484969Z","steps":["trace[1797235873] 'agreement among raft nodes before linearized reading' (duration: 2.146667135s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:32.485047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:02:30.337748Z","time spent":"2.147286569s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T03:02:38.671286Z","caller":"traceutil/trace.go:171","msg":"trace[454350875] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"100.03352ms","start":"2026-02-26T03:02:38.57122Z","end":"2026-02-26T03:02:38.671254Z","steps":["trace[454350875] 'process raft request' (duration: 99.637398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:58.753713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.884136ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-26T03:02:58.753867Z","caller":"traceutil/trace.go:171","msg":"trace[2136892863] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"232.263277ms","start":"2026-02-26T03:02:58.521581Z","end":"2026-02-26T03:02:58.753844Z","steps":["trace[2136892863] 'read index received' (duration: 91.124259ms)","trace[2136892863] 'applied index is now lower than readState.Index' (duration: 141.137258ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:02:58.754093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.102386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-26T03:02:58.754079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.446246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:02:58.754174Z","caller":"traceutil/trace.go:171","msg":"trace[167886629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:481; }","duration":"104.217201ms","start":"2026-02-26T03:02:58.649921Z","end":"2026-02-26T03:02:58.754138Z","steps":["trace[167886629] 'agreement among raft nodes before linearized reading' (duration: 104.067184ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:02:58.754201Z","caller":"traceutil/trace.go:171","msg":"trace[1775455880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:481; }","duration":"232.621124ms","start":"2026-02-26T03:02:58.521551Z","end":"2026-02-26T03:02:58.754172Z","steps":["trace[1775455880] 'agreement among raft nodes before linearized reading' (duration: 232.408654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:02:58.754291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.012266ms","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-02-26T03:02:58.754359Z","caller":"traceutil/trace.go:171","msg":"trace[1355851709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:481; }","duration":"103.095579ms","start":"2026-02-26T03:02:58.651243Z","end":"2026-02-26T03:02:58.754339Z","steps":["trace[1355851709] 'agreement among raft nodes before linearized reading' (duration: 102.917621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:01.276377Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309635559810920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T03:03:01.777043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309635559810920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T03:03:01.998343Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.232733415s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T03:03:01.998672Z","caller":"traceutil/trace.go:171","msg":"trace[1332738821] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"1.222650402s","start":"2026-02-26T03:03:00.775996Z","end":"2026-02-26T03:03:01.998646Z","steps":["trace[1332738821] 'read index received' (duration: 1.222494755s)","trace[1332738821] 'applied index is now lower than readState.Index' (duration: 154.547µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:03:01.998798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.222775778s","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-02-26T03:03:01.998832Z","caller":"traceutil/trace.go:171","msg":"trace[1839314581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"1.222862581s","start":"2026-02-26T03:03:00.775958Z","end":"2026-02-26T03:03:01.99882Z","steps":["trace[1839314581] 'agreement among raft nodes before linearized reading' (duration: 1.222781808s)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:01.998807Z","caller":"traceutil/trace.go:171","msg":"trace[1573650614] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.233229307s","start":"2026-02-26T03:03:00.765531Z","end":"2026-02-26T03:03:01.99876Z","steps":["trace[1573650614] 'process raft request' (duration: 1.232976896s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:01.998894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.222244014s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T03:03:01.998941Z","caller":"traceutil/trace.go:171","msg":"trace[1607536266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"1.222298426s","start":"2026-02-26T03:03:00.776627Z","end":"2026-02-26T03:03:01.998925Z","steps":["trace[1607536266] 'agreement among raft nodes before linearized reading' (duration: 1.222221173s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:01.998973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:00.776623Z","time spent":"1.222342219s","remote":"127.0.0.1:40882","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-02-26T03:03:01.998864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:00.775941Z","time spent":"1.222915054s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T03:03:01.998981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220850781s","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-02-26T03:03:01.999047Z","caller":"traceutil/trace.go:171","msg":"trace[852403600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"1.220935375s","start":"2026-02-26T03:03:00.778102Z","end":"2026-02-26T03:03:01.999037Z","steps":["trace[852403600] 'agreement among raft nodes before linearized reading' (duration: 1.22082759s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:01.999174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.014689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:03:01.999235Z","caller":"traceutil/trace.go:171","msg":"trace[623920760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"474.290292ms","start":"2026-02-26T03:03:01.524927Z","end":"2026-02-26T03:03:01.999217Z","steps":["trace[623920760] 'agreement among raft nodes before linearized reading' (duration: 473.973758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:01.999263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:01.524905Z","time spent":"474.352425ms","remote":"127.0.0.1:40616","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-02-26T03:03:01.999287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:00.765512Z","time spent":"1.233394694s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:03:01.99939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:00.778076Z","time spent":"1.221015638s","remote":"127.0.0.1:40882","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-02-26T03:03:01.999814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.519961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4373"} {"level":"info","ts":"2026-02-26T03:03:01.999863Z","caller":"traceutil/trace.go:171","msg":"trace[1334436334] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:521; }","duration":"307.608395ms","start":"2026-02-26T03:03:01.692243Z","end":"2026-02-26T03:03:01.999852Z","steps":["trace[1334436334] 'agreement among raft nodes before linearized reading' (duration: 307.529361ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:01.999898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:01.692219Z","time spent":"307.672128ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4396,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-26T03:03:02.271763Z","caller":"traceutil/trace.go:171","msg":"trace[1779774318] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"266.731991ms","start":"2026-02-26T03:03:02.005003Z","end":"2026-02-26T03:03:02.271735Z","steps":["trace[1779774318] 'process raft request' (duration: 266.25855ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:02.272052Z","caller":"traceutil/trace.go:171","msg":"trace[1832597582] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"266.704619ms","start":"2026-02-26T03:03:02.005335Z","end":"2026-02-26T03:03:02.272039Z","steps":["trace[1832597582] 'process raft request' (duration: 266.073962ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:02.272221Z","caller":"traceutil/trace.go:171","msg":"trace[1179280100] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"260.059928ms","start":"2026-02-26T03:03:02.012119Z","end":"2026-02-26T03:03:02.272178Z","steps":["trace[1179280100] 'process raft request' (duration: 259.353438ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:04.249849Z","caller":"traceutil/trace.go:171","msg":"trace[1844755353] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"212.299986ms","start":"2026-02-26T03:03:04.037519Z","end":"2026-02-26T03:03:04.249819Z","steps":["trace[1844755353] 'process raft request' (duration: 212.128699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.919891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.977998ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-26T03:03:08.920413Z","caller":"traceutil/trace.go:171","msg":"trace[1516027191] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:573; }","duration":"872.340004ms","start":"2026-02-26T03:03:08.048058Z","end":"2026-02-26T03:03:08.920398Z","steps":["trace[1516027191] 'read index received' (duration: 119.817564ms)","trace[1516027191] 'applied index is now lower than readState.Index' (duration: 752.52175ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:08.920483Z","caller":"traceutil/trace.go:171","msg":"trace[212283346] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"902.077766ms","start":"2026-02-26T03:03:08.018371Z","end":"2026-02-26T03:03:08.920449Z","steps":["trace[212283346] 'process raft request' (duration: 901.91653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.920638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.566983ms","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-02-26T03:03:08.920669Z","caller":"traceutil/trace.go:171","msg":"trace[13383854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"872.644426ms","start":"2026-02-26T03:03:08.048015Z","end":"2026-02-26T03:03:08.920659Z","steps":["trace[13383854] 'agreement among raft nodes before linearized reading' (duration: 872.479579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.920689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.047996Z","time spent":"872.689118ms","remote":"127.0.0.1:40882","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-02-26T03:03:08.920701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.018348Z","time spent":"902.227053ms","remote":"127.0.0.1:40882","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-02-26T03:03:08.92107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.635108ms","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-02-26T03:03:08.921194Z","caller":"traceutil/trace.go:171","msg":"trace[91424122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"654.851357ms","start":"2026-02-26T03:03:08.266321Z","end":"2026-02-26T03:03:08.921173Z","steps":["trace[91424122] 'agreement among raft nodes before linearized reading' (duration: 654.508643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.921255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.131884ms","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-02-26T03:03:08.921299Z","caller":"traceutil/trace.go:171","msg":"trace[1403117592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"623.240878ms","start":"2026-02-26T03:03:08.298049Z","end":"2026-02-26T03:03:08.92129Z","steps":["trace[1403117592] 'agreement among raft nodes before linearized reading' (duration: 623.061591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.921325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.298016Z","time spent":"623.304151ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T03:03:08.921369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.266281Z","time spent":"654.989624ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T03:03:08.921426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.403166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:03:08.921979Z","caller":"traceutil/trace.go:171","msg":"trace[2064290985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"390.210089ms","start":"2026-02-26T03:03:08.531691Z","end":"2026-02-26T03:03:08.921901Z","steps":["trace[2064290985] 'agreement among raft nodes before linearized reading' (duration: 389.422576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.922048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.531667Z","time spent":"390.364295ms","remote":"127.0.0.1:40616","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-02-26T03:03:08.921054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.848122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T03:03:08.922191Z","caller":"traceutil/trace.go:171","msg":"trace[1359744942] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"624.054742ms","start":"2026-02-26T03:03:08.298121Z","end":"2026-02-26T03:03:08.922176Z","steps":["trace[1359744942] 'agreement among raft nodes before linearized reading' (duration: 622.752959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:08.922294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.298092Z","time spent":"624.189677ms","remote":"127.0.0.1:40882","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":"info","ts":"2026-02-26T03:03:09.240624Z","caller":"traceutil/trace.go:171","msg":"trace[1434115547] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"314.102462ms","start":"2026-02-26T03:03:08.926499Z","end":"2026-02-26T03:03:09.240602Z","steps":["trace[1434115547] 'process raft request' (duration: 313.921285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:09.240788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.926488Z","time spent":"314.212097ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:03:09.240938Z","caller":"traceutil/trace.go:171","msg":"trace[1828560521] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"313.849422ms","start":"2026-02-26T03:03:08.927064Z","end":"2026-02-26T03:03:09.240913Z","steps":["trace[1828560521] 'process raft request' (duration: 313.506508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:09.241144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:08.927055Z","time spent":"314.013869ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:03:09.882542Z","caller":"traceutil/trace.go:171","msg":"trace[1169265491] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"362.198074ms","start":"2026-02-26T03:03:09.520252Z","end":"2026-02-26T03:03:09.88245Z","steps":["trace[1169265491] 'process raft request' (duration: 361.886121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:09.88274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:09.520227Z","time spent":"362.409642ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:03:10.516991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.463245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:03:10.517061Z","caller":"traceutil/trace.go:171","msg":"trace[1160538099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"300.59638ms","start":"2026-02-26T03:03:10.216449Z","end":"2026-02-26T03:03:10.517046Z","steps":["trace[1160538099] 'range keys from in-memory index tree' (duration: 300.384662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:10.517088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:10.216431Z","time spent":"300.651843ms","remote":"127.0.0.1:40616","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-02-26T03:03:11.74584Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309635559811018,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T03:03:11.801442Z","caller":"traceutil/trace.go:171","msg":"trace[1368196878] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"780.147088ms","start":"2026-02-26T03:03:11.021263Z","end":"2026-02-26T03:03:11.801411Z","steps":["trace[1368196878] 'process raft request' (duration: 779.965621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:11.801666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:11.021241Z","time spent":"780.312764ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:03:13.210613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287548318s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:03:13.210723Z","caller":"traceutil/trace.go:171","msg":"trace[1196802574] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:583; }","duration":"1.965851868s","start":"2026-02-26T03:03:11.244852Z","end":"2026-02-26T03:03:13.210704Z","steps":["trace[1196802574] 'read index received' (duration: 556.397101ms)","trace[1196802574] 'applied index is now lower than readState.Index' (duration: 1.409453397s)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:13.210957Z","caller":"traceutil/trace.go:171","msg":"trace[35244002] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"2.188419669s","start":"2026-02-26T03:03:11.022523Z","end":"2026-02-26T03:03:13.210942Z","steps":["trace[35244002] 'process raft request' (duration: 900.437363ms)","trace[35244002] 'compare' (duration: 1.287348621s)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:03:13.211019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:11.022516Z","time spent":"2.188470281s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:03:13.211217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.966361438s","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-02-26T03:03:13.211251Z","caller":"traceutil/trace.go:171","msg":"trace[1792114564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:568; }","duration":"1.96642732s","start":"2026-02-26T03:03:11.244809Z","end":"2026-02-26T03:03:13.211237Z","steps":["trace[1792114564] 'agreement among raft nodes before linearized reading' (duration: 1.966369048s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:13.211278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:11.244788Z","time spent":"1.966484452s","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T03:03:13.211629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.21324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-02-26T03:03:13.21166Z","caller":"traceutil/trace.go:171","msg":"trace[1423512996] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:568; }","duration":"655.245301ms","start":"2026-02-26T03:03:12.556406Z","end":"2026-02-26T03:03:13.211651Z","steps":["trace[1423512996] 'agreement among raft nodes before linearized reading' (duration: 655.102775ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:13.211688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:12.556349Z","time spent":"655.332224ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-02-26T03:03:13.211853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.684648778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T03:03:13.211915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.967023453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T03:03:13.212012Z","caller":"traceutil/trace.go:171","msg":"trace[1027397870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:568; }","duration":"1.967160169s","start":"2026-02-26T03:03:11.244827Z","end":"2026-02-26T03:03:13.211987Z","steps":["trace[1027397870] 'agreement among raft nodes before linearized reading' (duration: 1.96692581s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:13.212062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:11.24481Z","time spent":"1.967242641s","remote":"127.0.0.1:40882","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":"info","ts":"2026-02-26T03:03:13.211951Z","caller":"traceutil/trace.go:171","msg":"trace[600481616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"1.684800284s","start":"2026-02-26T03:03:11.527125Z","end":"2026-02-26T03:03:13.211925Z","steps":["trace[600481616] 'agreement among raft nodes before linearized reading' (duration: 1.684616217s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:13.212246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:11.527109Z","time spent":"1.685092486s","remote":"127.0.0.1:40616","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-02-26T03:03:14.941794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.844361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:03:14.941876Z","caller":"traceutil/trace.go:171","msg":"trace[340649144] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"230.886168ms","start":"2026-02-26T03:03:14.710976Z","end":"2026-02-26T03:03:14.941862Z","steps":["trace[340649144] 'process raft request' (duration: 32.909242ms)","trace[340649144] 'compare' (duration: 197.671464ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:15.268833Z","caller":"traceutil/trace.go:171","msg":"trace[1289951733] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"143.827785ms","start":"2026-02-26T03:03:15.12498Z","end":"2026-02-26T03:03:15.268808Z","steps":["trace[1289951733] 'process raft request' (duration: 142.675553ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:17.881272Z","caller":"traceutil/trace.go:171","msg":"trace[111098700] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"130.772345ms","start":"2026-02-26T03:03:17.750472Z","end":"2026-02-26T03:03:17.881244Z","steps":["trace[111098700] 'process raft request' (duration: 130.614309ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:23.914196Z","caller":"traceutil/trace.go:171","msg":"trace[1624386432] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"181.309688ms","start":"2026-02-26T03:03:23.732866Z","end":"2026-02-26T03:03:23.914176Z","steps":["trace[1624386432] 'process raft request' (duration: 181.222566ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:25.451876Z","caller":"traceutil/trace.go:171","msg":"trace[1212124611] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"116.62911ms","start":"2026-02-26T03:03:25.335212Z","end":"2026-02-26T03:03:25.451841Z","steps":["trace[1212124611] 'process raft request' (duration: 103.339843ms)","trace[1212124611] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 13.184323ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:25.7335Z","caller":"traceutil/trace.go:171","msg":"trace[51587438] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:721; }","duration":"375.627023ms","start":"2026-02-26T03:03:25.357847Z","end":"2026-02-26T03:03:25.733474Z","steps":["trace[51587438] 'read index received' (duration: 81.917052ms)","trace[51587438] 'applied index is now lower than readState.Index' (duration: 293.708651ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:25.733643Z","caller":"traceutil/trace.go:171","msg":"trace[1479733997] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"393.097741ms","start":"2026-02-26T03:03:25.34052Z","end":"2026-02-26T03:03:25.733617Z","steps":["trace[1479733997] 'process raft request' (duration: 392.79095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:25.733735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:25.34049Z","time spent":"393.177853ms","remote":"127.0.0.1:40696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":802,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T03:03:25.734078Z","caller":"traceutil/trace.go:171","msg":"trace[511826265] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"371.65977ms","start":"2026-02-26T03:03:25.362406Z","end":"2026-02-26T03:03:25.734066Z","steps":["trace[511826265] 'process raft request' (duration: 371.010909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:25.734155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:25.362378Z","time spent":"371.735373ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:03:25.73437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.527283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T03:03:25.734408Z","caller":"traceutil/trace.go:171","msg":"trace[392891329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:702; }","duration":"376.603946ms","start":"2026-02-26T03:03:25.357794Z","end":"2026-02-26T03:03:25.734398Z","steps":["trace[392891329] 'agreement among raft nodes before linearized reading' (duration: 376.486672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:25.734437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:25.357781Z","time spent":"376.649078ms","remote":"127.0.0.1:40882","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-02-26T03:03:25.73479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.459288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-26T03:03:25.734946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.919824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T03:03:25.734953Z","caller":"traceutil/trace.go:171","msg":"trace[1217937398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:702; }","duration":"364.684345ms","start":"2026-02-26T03:03:25.370241Z","end":"2026-02-26T03:03:25.734926Z","steps":["trace[1217937398] 'agreement among raft nodes before linearized reading' (duration: 364.314353ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:25.734985Z","caller":"traceutil/trace.go:171","msg":"trace[1518866950] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:702; }","duration":"345.987987ms","start":"2026-02-26T03:03:25.388988Z","end":"2026-02-26T03:03:25.734976Z","steps":["trace[1518866950] 'agreement among raft nodes before linearized reading' (duration: 345.888043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:25.735011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:25.388976Z","time spent":"346.029158ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-26T03:03:25.73502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:25.370227Z","time spent":"364.777649ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T03:03:26.075888Z","caller":"traceutil/trace.go:171","msg":"trace[1102325013] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"105.788989ms","start":"2026-02-26T03:03:25.970072Z","end":"2026-02-26T03:03:26.07586Z","steps":["trace[1102325013] 'process raft request' (duration: 105.362665ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:26.288075Z","caller":"traceutil/trace.go:171","msg":"trace[1567685438] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:731; }","duration":"115.881473ms","start":"2026-02-26T03:03:26.17216Z","end":"2026-02-26T03:03:26.288042Z","steps":["trace[1567685438] 'read index received' (duration: 37.57667ms)","trace[1567685438] 'applied index is now lower than readState.Index' (duration: 78.303533ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:26.288137Z","caller":"traceutil/trace.go:171","msg":"trace[175455268] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"133.718035ms","start":"2026-02-26T03:03:26.154385Z","end":"2026-02-26T03:03:26.288103Z","steps":["trace[175455268] 'process raft request' (duration: 55.429163ms)","trace[175455268] 'compare' (duration: 78.037624ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:03:26.288256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.063109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:03:26.288296Z","caller":"traceutil/trace.go:171","msg":"trace[1999093950] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:710; }","duration":"116.166152ms","start":"2026-02-26T03:03:26.172117Z","end":"2026-02-26T03:03:26.288283Z","steps":["trace[1999093950] 'agreement among raft nodes before linearized reading' (duration: 116.045158ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:26.428036Z","caller":"traceutil/trace.go:171","msg":"trace[1353350903] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"133.295921ms","start":"2026-02-26T03:03:26.29471Z","end":"2026-02-26T03:03:26.428006Z","steps":["trace[1353350903] 'process raft request' (duration: 133.140576ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:27.979076Z","caller":"traceutil/trace.go:171","msg":"trace[1632583105] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"171.794369ms","start":"2026-02-26T03:03:27.807242Z","end":"2026-02-26T03:03:27.979036Z","steps":["trace[1632583105] 'read index received' (duration: 171.652875ms)","trace[1632583105] 'applied index is now lower than readState.Index' (duration: 139.934µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:27.979234Z","caller":"traceutil/trace.go:171","msg":"trace[1019866344] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"317.461879ms","start":"2026-02-26T03:03:27.661728Z","end":"2026-02-26T03:03:27.97919Z","steps":["trace[1019866344] 'process raft request' (duration: 317.112558ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:27.979376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.080928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T03:03:27.979418Z","caller":"traceutil/trace.go:171","msg":"trace[2140698802] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:724; }","duration":"165.167941ms","start":"2026-02-26T03:03:27.814237Z","end":"2026-02-26T03:03:27.979404Z","steps":["trace[2140698802] 'agreement among raft nodes before linearized reading' (duration: 164.998016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:27.979419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:03:27.661699Z","time spent":"317.616264ms","remote":"127.0.0.1:40804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:03:27.979461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.176952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T03:03:27.9796Z","caller":"traceutil/trace.go:171","msg":"trace[1483484126] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"172.360758ms","start":"2026-02-26T03:03:27.807176Z","end":"2026-02-26T03:03:27.979536Z","steps":["trace[1483484126] 'agreement among raft nodes before linearized reading' (duration: 172.038767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:03:27.979671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.253044ms","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-02-26T03:03:27.979703Z","caller":"traceutil/trace.go:171","msg":"trace[1267621699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:724; }","duration":"165.330347ms","start":"2026-02-26T03:03:27.814362Z","end":"2026-02-26T03:03:27.979693Z","steps":["trace[1267621699] 'agreement among raft nodes before linearized reading' (duration: 165.186472ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:29.867729Z","caller":"traceutil/trace.go:171","msg":"trace[504679133] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"144.52039ms","start":"2026-02-26T03:03:29.723186Z","end":"2026-02-26T03:03:29.867706Z","steps":["trace[504679133] 'process raft request' (duration: 144.367365ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:30.267411Z","caller":"traceutil/trace.go:171","msg":"trace[58242146] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"141.758834ms","start":"2026-02-26T03:03:30.125622Z","end":"2026-02-26T03:03:30.26738Z","steps":["trace[58242146] 'process raft request' (duration: 141.593489ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:30.280206Z","caller":"traceutil/trace.go:171","msg":"trace[1509967183] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"153.313782ms","start":"2026-02-26T03:03:30.126878Z","end":"2026-02-26T03:03:30.280192Z","steps":["trace[1509967183] 'process raft request' (duration: 153.176647ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:30.280295Z","caller":"traceutil/trace.go:171","msg":"trace[779561137] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"153.439655ms","start":"2026-02-26T03:03:30.126843Z","end":"2026-02-26T03:03:30.280283Z","steps":["trace[779561137] 'process raft request' (duration: 153.035543ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:30.280544Z","caller":"traceutil/trace.go:171","msg":"trace[1139338881] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"152.746954ms","start":"2026-02-26T03:03:30.127674Z","end":"2026-02-26T03:03:30.280421Z","steps":["trace[1139338881] 'process raft request' (duration: 152.421084ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:52.723945Z","caller":"traceutil/trace.go:171","msg":"trace[2034361633] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"102.486086ms","start":"2026-02-26T03:03:52.62143Z","end":"2026-02-26T03:03:52.723916Z","steps":["trace[2034361633] 'process raft request' (duration: 31.498644ms)","trace[2034361633] 'compare' (duration: 70.53841ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:03:54.824371Z","caller":"traceutil/trace.go:171","msg":"trace[755120556] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"190.251555ms","start":"2026-02-26T03:03:54.634098Z","end":"2026-02-26T03:03:54.82435Z","steps":["trace[755120556] 'process raft request' (duration: 190.216945ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:03:54.824463Z","caller":"traceutil/trace.go:171","msg":"trace[328661777] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"190.83509ms","start":"2026-02-26T03:03:54.633587Z","end":"2026-02-26T03:03:54.824422Z","steps":["trace[328661777] 'process raft request' (duration: 142.91976ms)","trace[328661777] 'compare' (duration: 47.697195ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:04:42.554253Z","caller":"traceutil/trace.go:171","msg":"trace[237825464] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"280.719202ms","start":"2026-02-26T03:04:42.273496Z","end":"2026-02-26T03:04:42.554215Z","steps":["trace[237825464] 'process raft request' (duration: 280.496798ms)"],"step_count":1}