{"level":"warn","ts":"2026-02-27T20:24:32.057104Z","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-27T20:24:32.057181Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-27T20:24:32.057239Z","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-27T20:24:32.057251Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-02-27T20:24:32.057268Z","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-27T20:24:32.057874Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-02-27T20:24:32.057949Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-27T20:24:32.088574Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"30.434415ms"} {"level":"info","ts":"2026-02-27T20:24:32.110964Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-02-27T20:24:32.111039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-02-27T20:24:32.111059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-02-27T20:24:32.111073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-27T20:24:32.111105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-02-27T20:24:32.11114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-02-27T20:24:32.194822Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-27T20:24:32.203804Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-27T20:24:32.208778Z","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-27T20:24:32.212143Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-27T20:24:32.212522Z","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-27T20:24:32.212656Z","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-27T20:24:32.212682Z","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-27T20:24:32.212362Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-27T20:24:32.214918Z","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-27T20:24:32.215103Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-27T20:24:32.21513Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-27T20:24:32.215243Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-02-27T20:24:32.215254Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-02-27T20:24:32.215578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-02-27T20:24:32.215797Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-02-27T20:24:32.61176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-02-27T20:24:32.611833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-27T20:24:32.611863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-02-27T20:24:32.611882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-02-27T20:24:32.611897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-02-27T20:24:32.611917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-02-27T20:24:32.611933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-02-27T20:24:32.612999Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-02-27T20:24:32.613031Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:24:32.613154Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-27T20:24:32.613255Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-27T20:24:32.613679Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-27T20:24:32.613724Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-27T20:24:32.616658Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-02-27T20:24:32.616905Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:24:32.617119Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:24:32.617182Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-27T20:24:32.617729Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-27T20:24:37.258058Z","caller":"traceutil/trace.go:171","msg":"trace[111588975] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"223.576898ms","start":"2026-02-27T20:24:37.034454Z","end":"2026-02-27T20:24:37.258031Z","steps":["trace[111588975] 'process raft request' (duration: 223.413787ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:37.616944Z","caller":"traceutil/trace.go:171","msg":"trace[2050808725] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"352.342998ms","start":"2026-02-27T20:24:37.26456Z","end":"2026-02-27T20:24:37.616903Z","steps":["trace[2050808725] 'process raft request' (duration: 271.277176ms)","trace[2050808725] 'compare' (duration: 80.903421ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:24:37.61741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:37.264547Z","time spent":"352.466579ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:24:38.749008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.836058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-27T20:24:38.749186Z","caller":"traceutil/trace.go:171","msg":"trace[547434639] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:262; }","duration":"723.019781ms","start":"2026-02-27T20:24:38.02615Z","end":"2026-02-27T20:24:38.74917Z","steps":["trace[547434639] 'read index received' (duration: 315.892938ms)","trace[547434639] 'applied index is now lower than readState.Index' (duration: 407.125843ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:24:38.749264Z","caller":"traceutil/trace.go:171","msg":"trace[392257693] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"1.439199082s","start":"2026-02-27T20:24:37.310055Z","end":"2026-02-27T20:24:38.749254Z","steps":["trace[392257693] 'process raft request' (duration: 603.931381ms)","trace[392257693] 'compare' (duration: 834.237144ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:24:38.749316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:37.310035Z","time spent":"1.439258974s","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:24:38.74945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.300003ms","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-27T20:24:38.749506Z","caller":"traceutil/trace.go:171","msg":"trace[931411210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:258; }","duration":"723.397634ms","start":"2026-02-27T20:24:38.026099Z","end":"2026-02-27T20:24:38.749497Z","steps":["trace[931411210] 'agreement among raft nodes before linearized reading' (duration: 723.286393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:38.749506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.197085ms","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-02-27T20:24:38.749529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.02608Z","time spent":"723.443574ms","remote":"127.0.0.1:55062","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":"info","ts":"2026-02-27T20:24:38.749534Z","caller":"traceutil/trace.go:171","msg":"trace[168398918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:258; }","duration":"667.261345ms","start":"2026-02-27T20:24:38.082264Z","end":"2026-02-27T20:24:38.749525Z","steps":["trace[168398918] 'agreement among raft nodes before linearized reading' (duration: 667.206755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:38.749562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.082243Z","time spent":"667.311006ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-27T20:24:38.749572Z","caller":"traceutil/trace.go:171","msg":"trace[1177797418] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"1.128570705s","start":"2026-02-27T20:24:37.62096Z","end":"2026-02-27T20:24:38.749531Z","steps":["trace[1177797418] 'process raft request' (duration: 1.128154542s)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:38.749635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.051863ms","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-27T20:24:38.749659Z","caller":"traceutil/trace.go:171","msg":"trace[1931059164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:258; }","duration":"516.098923ms","start":"2026-02-27T20:24:38.233553Z","end":"2026-02-27T20:24:38.749652Z","steps":["trace[1931059164] 'agreement among raft nodes before linearized reading' (duration: 516.066393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:38.749683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.233538Z","time spent":"516.138314ms","remote":"127.0.0.1:55062","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":"warn","ts":"2026-02-27T20:24:38.749728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:37.620936Z","time spent":"1.128727306s","remote":"127.0.0.1:55164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":290,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-27T20:24:39.090341Z","caller":"traceutil/trace.go:171","msg":"trace[195727287] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"337.298105ms","start":"2026-02-27T20:24:38.753009Z","end":"2026-02-27T20:24:39.090308Z","steps":["trace[195727287] 'process raft request' (duration: 333.330216ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:39.090393Z","caller":"traceutil/trace.go:171","msg":"trace[597659493] linearizableReadLoop","detail":"{readStateIndex:268; appliedIndex:264; }","duration":"290.653791ms","start":"2026-02-27T20:24:38.799717Z","end":"2026-02-27T20:24:39.090371Z","steps":["trace[597659493] 'read index received' (duration: 286.728051ms)","trace[597659493] 'applied index is now lower than readState.Index' (duration: 3.92465ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:24:39.090491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.752982Z","time spent":"337.443636ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:24:39.090532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.806832ms","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-27T20:24:39.090578Z","caller":"traceutil/trace.go:171","msg":"trace[13974667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:262; }","duration":"290.903232ms","start":"2026-02-27T20:24:38.799665Z","end":"2026-02-27T20:24:39.090568Z","steps":["trace[13974667] 'agreement among raft nodes before linearized reading' (duration: 290.789661ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:39.090724Z","caller":"traceutil/trace.go:171","msg":"trace[712439190] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"336.804422ms","start":"2026-02-27T20:24:38.753909Z","end":"2026-02-27T20:24:39.090713Z","steps":["trace[712439190] 'process raft request' (duration: 336.420109ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:39.090686Z","caller":"traceutil/trace.go:171","msg":"trace[1269117307] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"337.030364ms","start":"2026-02-27T20:24:38.753602Z","end":"2026-02-27T20:24:39.090632Z","steps":["trace[1269117307] 'process raft request' (duration: 336.648441ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:39.090741Z","caller":"traceutil/trace.go:171","msg":"trace[1790504181] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"336.844372ms","start":"2026-02-27T20:24:38.753844Z","end":"2026-02-27T20:24:39.090688Z","steps":["trace[1790504181] 'process raft request' (duration: 336.443259ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:39.090854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.753578Z","time spent":"337.201655ms","remote":"127.0.0.1:55168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":454,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:24:39.090908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.753835Z","time spent":"336.988493ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:24:39.091008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:38.753902Z","time spent":"336.855652ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:24:39.434634Z","caller":"traceutil/trace.go:171","msg":"trace[2044727060] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"267.130809ms","start":"2026-02-27T20:24:39.167468Z","end":"2026-02-27T20:24:39.434599Z","steps":["trace[2044727060] 'process raft request' (duration: 262.811016ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:39.683322Z","caller":"traceutil/trace.go:171","msg":"trace[915770845] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"110.438455ms","start":"2026-02-27T20:24:39.572862Z","end":"2026-02-27T20:24:39.6833Z","steps":["trace[915770845] 'process raft request' (duration: 110.269474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:39.996622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.323895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-27T20:24:39.996801Z","caller":"traceutil/trace.go:171","msg":"trace[810762717] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"290.052963ms","start":"2026-02-27T20:24:39.70673Z","end":"2026-02-27T20:24:39.996783Z","steps":["trace[810762717] 'read index received' (duration: 81.501196ms)","trace[810762717] 'applied index is now lower than readState.Index' (duration: 208.550607ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:24:39.99685Z","caller":"traceutil/trace.go:171","msg":"trace[1970633368] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"291.05494ms","start":"2026-02-27T20:24:39.705743Z","end":"2026-02-27T20:24:39.996798Z","steps":["trace[1970633368] 'process raft request' (duration: 82.498483ms)","trace[1970633368] 'compare' (duration: 208.181534ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:24:39.997126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.337915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:24:39.997251Z","caller":"traceutil/trace.go:171","msg":"trace[1483939039] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:299; }","duration":"290.520546ms","start":"2026-02-27T20:24:39.706703Z","end":"2026-02-27T20:24:39.997224Z","steps":["trace[1483939039] 'agreement among raft nodes before linearized reading' (duration: 290.181274ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:40.000767Z","caller":"traceutil/trace.go:171","msg":"trace[2100495043] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"286.826137ms","start":"2026-02-27T20:24:39.713917Z","end":"2026-02-27T20:24:40.000743Z","steps":["trace[2100495043] 'process raft request' (duration: 286.660786ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:40.187446Z","caller":"traceutil/trace.go:171","msg":"trace[937305670] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"113.174999ms","start":"2026-02-27T20:24:40.074245Z","end":"2026-02-27T20:24:40.18742Z","steps":["trace[937305670] 'process raft request' (duration: 35.328235ms)","trace[937305670] 'compare' (duration: 77.702163ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:24:40.623183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.901667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-02-27T20:24:40.623243Z","caller":"traceutil/trace.go:171","msg":"trace[537591434] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:310; }","duration":"109.066578ms","start":"2026-02-27T20:24:40.514165Z","end":"2026-02-27T20:24:40.623231Z","steps":["trace[537591434] 'range keys from in-memory index tree' (duration: 108.745315ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:40.623582Z","caller":"traceutil/trace.go:171","msg":"trace[1734739442] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"109.080197ms","start":"2026-02-27T20:24:40.514486Z","end":"2026-02-27T20:24:40.623566Z","steps":["trace[1734739442] 'process raft request' (duration: 109.019557ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:40.649859Z","caller":"traceutil/trace.go:171","msg":"trace[1143493047] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:320; }","duration":"105.004568ms","start":"2026-02-27T20:24:40.544833Z","end":"2026-02-27T20:24:40.649838Z","steps":["trace[1143493047] 'read index received' (duration: 78.632ms)","trace[1143493047] 'applied index is now lower than readState.Index' (duration: 26.371508ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:24:40.649934Z","caller":"traceutil/trace.go:171","msg":"trace[1275290871] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"135.468147ms","start":"2026-02-27T20:24:40.514436Z","end":"2026-02-27T20:24:40.649904Z","steps":["trace[1275290871] 'process raft request' (duration: 135.297266ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:40.649948Z","caller":"traceutil/trace.go:171","msg":"trace[838233750] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"135.137463ms","start":"2026-02-27T20:24:40.514787Z","end":"2026-02-27T20:24:40.649924Z","steps":["trace[838233750] 'process raft request' (duration: 135.026032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:40.650004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.153969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-27T20:24:40.65004Z","caller":"traceutil/trace.go:171","msg":"trace[591670356] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:310; }","duration":"105.23431ms","start":"2026-02-27T20:24:40.544794Z","end":"2026-02-27T20:24:40.650029Z","steps":["trace[591670356] 'agreement among raft nodes before linearized reading' (duration: 105.153159ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:43.425595Z","caller":"traceutil/trace.go:171","msg":"trace[719235639] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:353; }","duration":"321.028682ms","start":"2026-02-27T20:24:43.10453Z","end":"2026-02-27T20:24:43.425559Z","steps":["trace[719235639] 'read index received' (duration: 81.091754ms)","trace[719235639] 'applied index is now lower than readState.Index' (duration: 239.935528ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:24:43.426157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.608937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-27T20:24:43.426244Z","caller":"traceutil/trace.go:171","msg":"trace[597253055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:342; }","duration":"321.734518ms","start":"2026-02-27T20:24:43.104493Z","end":"2026-02-27T20:24:43.426227Z","steps":["trace[597253055] 'agreement among raft nodes before linearized reading' (duration: 321.555537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:43.426407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:43.104479Z","time spent":"321.914729ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-27T20:24:43.425878Z","caller":"traceutil/trace.go:171","msg":"trace[923056121] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"330.892914ms","start":"2026-02-27T20:24:43.094971Z","end":"2026-02-27T20:24:43.425864Z","steps":["trace[923056121] 'process raft request' (duration: 328.267625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:43.426617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.629119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:24:43.426764Z","caller":"traceutil/trace.go:171","msg":"trace[131874049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:342; }","duration":"230.81622ms","start":"2026-02-27T20:24:43.195931Z","end":"2026-02-27T20:24:43.426747Z","steps":["trace[131874049] 'agreement among raft nodes before linearized reading' (duration: 230.638869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:43.426667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.935064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-27T20:24:43.427014Z","caller":"traceutil/trace.go:171","msg":"trace[1596337107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:342; }","duration":"309.310956ms","start":"2026-02-27T20:24:43.117686Z","end":"2026-02-27T20:24:43.426997Z","steps":["trace[1596337107] 'agreement among raft nodes before linearized reading' (duration: 308.913053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:43.426654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.285367ms","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-02-27T20:24:43.42709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:43.117626Z","time spent":"309.447457ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-27T20:24:43.42665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.586641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-27T20:24:43.427157Z","caller":"traceutil/trace.go:171","msg":"trace[1394401675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:342; }","duration":"309.156635ms","start":"2026-02-27T20:24:43.117991Z","end":"2026-02-27T20:24:43.427147Z","steps":["trace[1394401675] 'agreement among raft nodes before linearized reading' (duration: 308.549391ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:24:43.427114Z","caller":"traceutil/trace.go:171","msg":"trace[173573242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:342; }","duration":"312.811861ms","start":"2026-02-27T20:24:43.114288Z","end":"2026-02-27T20:24:43.427099Z","steps":["trace[173573242] 'agreement among raft nodes before linearized reading' (duration: 312.245767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:24:43.4272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:43.117974Z","time spent":"309.210666ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-27T20:24:43.427221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:43.094945Z","time spent":"331.556509ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-27T20:24:43.427238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:24:43.114271Z","time spent":"312.948073ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-27T20:24:44.672446Z","caller":"traceutil/trace.go:171","msg":"trace[1692128629] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"125.958526ms","start":"2026-02-27T20:24:44.546427Z","end":"2026-02-27T20:24:44.672386Z","steps":["trace[1692128629] 'process raft request' (duration: 67.245389ms)","trace[1692128629] 'compare' (duration: 58.595896ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:04.138324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.308321ms","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-02-27T20:25:04.13842Z","caller":"traceutil/trace.go:171","msg":"trace[1983600382] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:522; }","duration":"538.442631ms","start":"2026-02-27T20:25:03.599957Z","end":"2026-02-27T20:25:04.138399Z","steps":["trace[1983600382] 'range keys from in-memory index tree' (duration: 538.20701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:04.138462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:03.599944Z","time spent":"538.508732ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-27T20:25:04.138763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.06218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-27T20:25:04.138857Z","caller":"traceutil/trace.go:171","msg":"trace[1331383613] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"534.843217ms","start":"2026-02-27T20:25:03.603999Z","end":"2026-02-27T20:25:04.138843Z","steps":["trace[1331383613] 'read index received' (duration: 178.445865ms)","trace[1331383613] 'applied index is now lower than readState.Index' (duration: 356.396202ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:04.138886Z","caller":"traceutil/trace.go:171","msg":"trace[1447285877] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"535.664952ms","start":"2026-02-27T20:25:03.603194Z","end":"2026-02-27T20:25:04.138858Z","steps":["trace[1447285877] 'process raft request' (duration: 179.24981ms)","trace[1447285877] 'compare' (duration: 355.96626ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:04.138967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.960918ms","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-27T20:25:04.138995Z","caller":"traceutil/trace.go:171","msg":"trace[72022436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:523; }","duration":"535.006108ms","start":"2026-02-27T20:25:03.603979Z","end":"2026-02-27T20:25:04.138985Z","steps":["trace[72022436] 'agreement among raft nodes before linearized reading' (duration: 534.948178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:04.139028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:03.603973Z","time spent":"535.048178ms","remote":"127.0.0.1:55062","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-27T20:25:04.139016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:03.603173Z","time spent":"535.776353ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:25:04.139249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.858416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-02-27T20:25:04.139298Z","caller":"traceutil/trace.go:171","msg":"trace[464173100] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:523; }","duration":"304.909656ms","start":"2026-02-27T20:25:03.834373Z","end":"2026-02-27T20:25:04.139283Z","steps":["trace[464173100] 'agreement among raft nodes before linearized reading' (duration: 304.811645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:04.13933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:03.834322Z","time spent":"305.000017ms","remote":"127.0.0.1:54974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4398,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-27T20:25:10.596295Z","caller":"traceutil/trace.go:171","msg":"trace[2009262072] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"427.606976ms","start":"2026-02-27T20:25:10.168661Z","end":"2026-02-27T20:25:10.596268Z","steps":["trace[2009262072] 'process raft request' (duration: 427.442434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:10.596531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:10.168644Z","time spent":"427.738877ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:25:10.734172Z","caller":"traceutil/trace.go:171","msg":"trace[1020427233] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:581; }","duration":"148.943551ms","start":"2026-02-27T20:25:10.58521Z","end":"2026-02-27T20:25:10.734153Z","steps":["trace[1020427233] 'read index received' (duration: 10.967709ms)","trace[1020427233] 'applied index is now lower than readState.Index' (duration: 137.975002ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:10.734314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.094862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-944jp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-02-27T20:25:10.734342Z","caller":"traceutil/trace.go:171","msg":"trace[774937962] range","detail":"{range_begin:/registry/pods/kube-system/cilium-944jp; range_end:; response_count:1; response_revision:566; }","duration":"149.173694ms","start":"2026-02-27T20:25:10.585161Z","end":"2026-02-27T20:25:10.734335Z","steps":["trace[774937962] 'agreement among raft nodes before linearized reading' (duration: 149.060382ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:10.734391Z","caller":"traceutil/trace.go:171","msg":"trace[1653559637] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"564.074611ms","start":"2026-02-27T20:25:10.170291Z","end":"2026-02-27T20:25:10.734365Z","steps":["trace[1653559637] 'process raft request' (duration: 563.793078ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:10.734424Z","caller":"traceutil/trace.go:171","msg":"trace[1687104054] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"565.064142ms","start":"2026-02-27T20:25:10.16933Z","end":"2026-02-27T20:25:10.734394Z","steps":["trace[1687104054] 'process raft request' (duration: 540.7683ms)","trace[1687104054] 'compare' (duration: 23.844588ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:10.734513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:10.170276Z","time spent":"564.166892ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:25:10.734531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:10.169312Z","time spent":"565.163043ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:25:10.734904Z","caller":"traceutil/trace.go:171","msg":"trace[1604212767] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"149.654368ms","start":"2026-02-27T20:25:10.585236Z","end":"2026-02-27T20:25:10.734891Z","steps":["trace[1604212767] 'process raft request' (duration: 148.87292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:11.109045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.743704ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-27T20:25:11.109324Z","caller":"traceutil/trace.go:171","msg":"trace[723969596] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"363.047473ms","start":"2026-02-27T20:25:10.746262Z","end":"2026-02-27T20:25:11.109309Z","steps":["trace[723969596] 'process raft request' (duration: 362.894576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:11.109432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:10.746239Z","time spent":"363.121966ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:25:12.10413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.496859ms","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-27T20:25:12.104191Z","caller":"traceutil/trace.go:171","msg":"trace[1644836661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"501.576703ms","start":"2026-02-27T20:25:11.602601Z","end":"2026-02-27T20:25:12.104177Z","steps":["trace[1644836661] 'range keys from in-memory index tree' (duration: 501.326212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:12.104223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:11.602546Z","time spent":"501.670958ms","remote":"127.0.0.1:55062","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-27T20:25:14.019071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.279825344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-02-27T20:25:14.019109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.279577063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-27T20:25:14.01915Z","caller":"traceutil/trace.go:171","msg":"trace[282895928] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:569; }","duration":"1.27996842s","start":"2026-02-27T20:25:12.739163Z","end":"2026-02-27T20:25:14.019131Z","steps":["trace[282895928] 'range keys from in-memory index tree' (duration: 1.279721519s)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:14.019192Z","caller":"traceutil/trace.go:171","msg":"trace[1540959644] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:569; }","duration":"1.279722819s","start":"2026-02-27T20:25:12.739448Z","end":"2026-02-27T20:25:14.01917Z","steps":["trace[1540959644] 'range keys from in-memory index tree' (duration: 1.279450317s)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:14.019197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:12.739143Z","time spent":"1.280043913s","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-27T20:25:14.019237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:12.739429Z","time spent":"1.279798842s","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-27T20:25:14.618252Z","caller":"traceutil/trace.go:171","msg":"trace[577090683] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"595.834939ms","start":"2026-02-27T20:25:14.022398Z","end":"2026-02-27T20:25:14.618233Z","steps":["trace[577090683] 'process raft request' (duration: 595.700443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:14.618366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:14.022378Z","time spent":"595.931253ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:25:14.805359Z","caller":"traceutil/trace.go:171","msg":"trace[1142438069] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:589; }","duration":"617.797118ms","start":"2026-02-27T20:25:14.187534Z","end":"2026-02-27T20:25:14.805331Z","steps":["trace[1142438069] 'read index received' (duration: 430.638676ms)","trace[1142438069] 'applied index is now lower than readState.Index' (duration: 187.157372ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:25:14.805389Z","caller":"traceutil/trace.go:171","msg":"trace[1763541430] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"782.149194ms","start":"2026-02-27T20:25:14.023214Z","end":"2026-02-27T20:25:14.805363Z","steps":["trace[1763541430] 'process raft request' (duration: 708.195955ms)","trace[1763541430] 'compare' (duration: 73.787192ms)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:25:14.805556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.954686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:25:14.805635Z","caller":"traceutil/trace.go:171","msg":"trace[525949955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"611.064901ms","start":"2026-02-27T20:25:14.194553Z","end":"2026-02-27T20:25:14.805617Z","steps":["trace[525949955] 'agreement among raft nodes before linearized reading' (duration: 610.946036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:14.805653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.087031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-27T20:25:14.805689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:14.194541Z","time spent":"611.135065ms","remote":"127.0.0.1:54796","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-27T20:25:14.805709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.484712ms","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-27T20:25:14.805741Z","caller":"traceutil/trace.go:171","msg":"trace[1498486014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:571; }","duration":"618.210726ms","start":"2026-02-27T20:25:14.187508Z","end":"2026-02-27T20:25:14.805719Z","steps":["trace[1498486014] 'agreement among raft nodes before linearized reading' (duration: 617.932164ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:25:14.805768Z","caller":"traceutil/trace.go:171","msg":"trace[1648493102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:571; }","duration":"124.576566ms","start":"2026-02-27T20:25:14.681177Z","end":"2026-02-27T20:25:14.805754Z","steps":["trace[1648493102] 'agreement among raft nodes before linearized reading' (duration: 124.408769ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:25:14.805791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:14.187494Z","time spent":"618.287031ms","remote":"127.0.0.1:55062","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-27T20:25:14.805957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:25:14.023193Z","time spent":"782.318011ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:26:35.171128Z","caller":"traceutil/trace.go:171","msg":"trace[1540738111] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"130.672721ms","start":"2026-02-27T20:26:35.040436Z","end":"2026-02-27T20:26:35.171109Z","steps":["trace[1540738111] 'read index received' (duration: 130.503648ms)","trace[1540738111] 'applied index is now lower than readState.Index' (duration: 168.323µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:35.17121Z","caller":"traceutil/trace.go:171","msg":"trace[1505734538] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"271.532469ms","start":"2026-02-27T20:26:34.899649Z","end":"2026-02-27T20:26:35.171182Z","steps":["trace[1505734538] 'process raft request' (duration: 271.342985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:35.171273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.820405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:26:35.171315Z","caller":"traceutil/trace.go:171","msg":"trace[599007855] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:975; }","duration":"130.911657ms","start":"2026-02-27T20:26:35.040383Z","end":"2026-02-27T20:26:35.171294Z","steps":["trace[599007855] 'agreement among raft nodes before linearized reading' (duration: 130.849036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:35.171427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.638514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-27T20:26:35.171488Z","caller":"traceutil/trace.go:171","msg":"trace[1120213402] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:975; }","duration":"124.738345ms","start":"2026-02-27T20:26:35.046734Z","end":"2026-02-27T20:26:35.171473Z","steps":["trace[1120213402] 'agreement among raft nodes before linearized reading' (duration: 124.540431ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.34906Z","caller":"traceutil/trace.go:171","msg":"trace[1688554290] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"462.927835ms","start":"2026-02-27T20:26:42.88611Z","end":"2026-02-27T20:26:43.349038Z","steps":["trace[1688554290] 'read index received' (duration: 462.788443ms)","trace[1688554290] 'applied index is now lower than readState.Index' (duration: 138.362µs)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:43.349167Z","caller":"traceutil/trace.go:171","msg":"trace[1419005001] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"677.453091ms","start":"2026-02-27T20:26:42.671704Z","end":"2026-02-27T20:26:43.349157Z","steps":["trace[1419005001] 'process raft request' (duration: 677.200536ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.349276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:42.671681Z","time spent":"677.508592ms","remote":"127.0.0.1:54974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-27T20:26:43.349436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.288963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:26:43.349517Z","caller":"traceutil/trace.go:171","msg":"trace[306286566] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1003; }","duration":"463.443856ms","start":"2026-02-27T20:26:42.886056Z","end":"2026-02-27T20:26:43.3495Z","steps":["trace[306286566] 'agreement among raft nodes before linearized reading' (duration: 463.301143ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.349576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:42.886031Z","time spent":"463.524557ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-02-27T20:26:43.473067Z","caller":"traceutil/trace.go:171","msg":"trace[63864220] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"123.917762ms","start":"2026-02-27T20:26:43.349129Z","end":"2026-02-27T20:26:43.473047Z","steps":["trace[63864220] 'read index received' (duration: 123.731918ms)","trace[63864220] 'applied index is now lower than readState.Index' (duration: 184.624µs)"],"step_count":2} {"level":"warn","ts":"2026-02-27T20:26:43.473235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.17503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-27T20:26:43.473324Z","caller":"traceutil/trace.go:171","msg":"trace[1197113377] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1004; }","duration":"181.291801ms","start":"2026-02-27T20:26:43.292003Z","end":"2026-02-27T20:26:43.473295Z","steps":["trace[1197113377] 'agreement among raft nodes before linearized reading' (duration: 181.129318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.473418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.325722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-27T20:26:43.473448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.080661ms","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-02-27T20:26:43.473464Z","caller":"traceutil/trace.go:171","msg":"trace[1390657011] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1004; }","duration":"268.446083ms","start":"2026-02-27T20:26:43.205007Z","end":"2026-02-27T20:26:43.473453Z","steps":["trace[1390657011] 'agreement among raft nodes before linearized reading' (duration: 268.162768ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.473555Z","caller":"traceutil/trace.go:171","msg":"trace[1580235289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"165.214784ms","start":"2026-02-27T20:26:43.308284Z","end":"2026-02-27T20:26:43.473498Z","steps":["trace[1580235289] 'agreement among raft nodes before linearized reading' (duration: 164.830297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.473616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.224169ms","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-27T20:26:43.473687Z","caller":"traceutil/trace.go:171","msg":"trace[43524493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"162.31065ms","start":"2026-02-27T20:26:43.311358Z","end":"2026-02-27T20:26:43.473669Z","steps":["trace[43524493] 'agreement among raft nodes before linearized reading' (duration: 161.73825ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.47387Z","caller":"traceutil/trace.go:171","msg":"trace[686946309] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"520.045183ms","start":"2026-02-27T20:26:42.953791Z","end":"2026-02-27T20:26:43.473836Z","steps":["trace[686946309] 'process raft request' (duration: 519.122216ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.473898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.223494ms","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-27T20:26:43.473916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.691029ms","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-27T20:26:43.473955Z","caller":"traceutil/trace.go:171","msg":"trace[1290379473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1004; }","duration":"161.76644ms","start":"2026-02-27T20:26:43.312177Z","end":"2026-02-27T20:26:43.473944Z","steps":["trace[1290379473] 'agreement among raft nodes before linearized reading' (duration: 161.658428ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.473952Z","caller":"traceutil/trace.go:171","msg":"trace[1884406969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"165.314056ms","start":"2026-02-27T20:26:43.308623Z","end":"2026-02-27T20:26:43.473937Z","steps":["trace[1884406969] 'agreement among raft nodes before linearized reading' (duration: 165.130463ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.474393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-27T20:26:42.953763Z","time spent":"520.166905ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-27T20:26:43.698768Z","caller":"traceutil/trace.go:171","msg":"trace[1232362534] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"220.591849ms","start":"2026-02-27T20:26:43.478148Z","end":"2026-02-27T20:26:43.69874Z","steps":["trace[1232362534] 'process raft request' (duration: 198.802796ms)","trace[1232362534] 'compare' (duration: 21.61578ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:43.699115Z","caller":"traceutil/trace.go:171","msg":"trace[521746853] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"220.313103ms","start":"2026-02-27T20:26:43.478783Z","end":"2026-02-27T20:26:43.699096Z","steps":["trace[521746853] 'process raft request' (duration: 220.166581ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.69909Z","caller":"traceutil/trace.go:171","msg":"trace[2006095761] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"220.360835ms","start":"2026-02-27T20:26:43.478695Z","end":"2026-02-27T20:26:43.699056Z","steps":["trace[2006095761] 'process raft request' (duration: 220.003858ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.699546Z","caller":"traceutil/trace.go:171","msg":"trace[1353012817] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"220.704271ms","start":"2026-02-27T20:26:43.47883Z","end":"2026-02-27T20:26:43.699535Z","steps":["trace[1353012817] 'process raft request' (duration: 220.226432ms)"],"step_count":1} {"level":"info","ts":"2026-02-27T20:26:43.699536Z","caller":"traceutil/trace.go:171","msg":"trace[278969496] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1045; }","duration":"218.705716ms","start":"2026-02-27T20:26:43.480803Z","end":"2026-02-27T20:26:43.699508Z","steps":["trace[278969496] 'read index received' (duration: 196.179648ms)","trace[278969496] 'applied index is now lower than readState.Index' (duration: 22.327813ms)"],"step_count":2} {"level":"info","ts":"2026-02-27T20:26:43.699571Z","caller":"traceutil/trace.go:171","msg":"trace[1322351447] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"220.555759ms","start":"2026-02-27T20:26:43.479003Z","end":"2026-02-27T20:26:43.699559Z","steps":["trace[1322351447] 'process raft request' (duration: 220.187071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.699721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.891099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:26:43.699801Z","caller":"traceutil/trace.go:171","msg":"trace[214874103] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1009; }","duration":"219.000101ms","start":"2026-02-27T20:26:43.48078Z","end":"2026-02-27T20:26:43.69978Z","steps":["trace[214874103] 'agreement among raft nodes before linearized reading' (duration: 218.873049ms)"],"step_count":1} {"level":"warn","ts":"2026-02-27T20:26:43.699802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.912463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-27T20:26:43.699913Z","caller":"traceutil/trace.go:171","msg":"trace[278738314] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1009; }","duration":"202.084687ms","start":"2026-02-27T20:26:43.497812Z","end":"2026-02-27T20:26:43.699896Z","steps":["trace[278738314] 'agreement among raft nodes before linearized reading' (duration: 201.886903ms)"],"step_count":1}