{"level":"warn","ts":"2026-02-26T16:45:52.347326Z","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-26T16:45:52.347437Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.209:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.209:2380","--initial-cluster=instance=https://162.253.55.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.209: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-26T16:45:52.347525Z","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-26T16:45:52.347543Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-02-26T16:45:52.347572Z","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-26T16:45:52.348664Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"]} {"level":"info","ts":"2026-02-26T16:45:52.348783Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.209: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-26T16:45:52.354698Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.642706ms"} {"level":"info","ts":"2026-02-26T16:45:52.364762Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"53de2bdd9aa7b793","cluster-id":"385802231390d48c"} {"level":"info","ts":"2026-02-26T16:45:52.36486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T16:45:52.364897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 0"} {"level":"info","ts":"2026-02-26T16:45:52.364921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 53de2bdd9aa7b793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T16:45:52.364934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 1"} {"level":"info","ts":"2026-02-26T16:45:52.364986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"warn","ts":"2026-02-26T16:45:52.379381Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T16:45:52.381506Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T16:45:52.382706Z","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-26T16:45:52.386482Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"53de2bdd9aa7b793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T16:45:52.389078Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"53de2bdd9aa7b793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T16:45:52.389259Z","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-26T16:45:52.389322Z","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-26T16:45:52.389334Z","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-26T16:45:52.392493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"info","ts":"2026-02-26T16:45:52.392672Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","added-peer-id":"53de2bdd9aa7b793","added-peer-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-02-26T16:45:52.393623Z","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-26T16:45:52.393819Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"53de2bdd9aa7b793","initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T16:45:52.393848Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T16:45:52.393865Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-02-26T16:45:52.393899Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-02-26T16:45:52.566186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T16:45:52.566268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T16:45:52.566296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgPreVoteResp from 53de2bdd9aa7b793 at term 1"} {"level":"info","ts":"2026-02-26T16:45:52.566317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became candidate at term 2"} {"level":"info","ts":"2026-02-26T16:45:52.566333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgVoteResp from 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-02-26T16:45:52.566349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became leader at term 2"} {"level":"info","ts":"2026-02-26T16:45:52.566414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 53de2bdd9aa7b793 elected leader 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-02-26T16:45:52.568488Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"53de2bdd9aa7b793","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.209:2379]}","request-path":"/0/members/53de2bdd9aa7b793/attributes","cluster-id":"385802231390d48c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T16:45:52.572437Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T16:45:52.572478Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T16:45:52.572518Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T16:45:52.572695Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:45:52.573796Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:45:52.573891Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:45:52.57393Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:45:52.574048Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.209:2379"} {"level":"info","ts":"2026-02-26T16:45:52.572416Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T16:45:52.577089Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-26T16:45:55.335714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.489735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T16:45:55.335858Z","caller":"traceutil/trace.go:171","msg":"trace[124030055] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"176.916578ms","start":"2026-02-26T16:45:55.158924Z","end":"2026-02-26T16:45:55.335841Z","steps":["trace[124030055] 'process raft request' (duration: 49.95898ms)","trace[124030055] 'compare' (duration: 126.375028ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:45:56.296999Z","caller":"traceutil/trace.go:171","msg":"trace[1371215982] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"113.80618ms","start":"2026-02-26T16:45:56.183168Z","end":"2026-02-26T16:45:56.296975Z","steps":["trace[1371215982] 'process raft request' (duration: 113.636228ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:45:56.465781Z","caller":"traceutil/trace.go:171","msg":"trace[530726914] transaction","detail":"{read_only:false; response_revision:128; number_of_response:1; }","duration":"142.216762ms","start":"2026-02-26T16:45:56.323534Z","end":"2026-02-26T16:45:56.46575Z","steps":["trace[530726914] 'process raft request' (duration: 99.234544ms)","trace[530726914] 'compare' (duration: 42.852819ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:45:56.762815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.765208ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:45:56.762923Z","caller":"traceutil/trace.go:171","msg":"trace[1594153699] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"266.556421ms","start":"2026-02-26T16:45:56.496348Z","end":"2026-02-26T16:45:56.762904Z","steps":["trace[1594153699] 'process raft request' (duration: 150.63116ms)","trace[1594153699] 'compare' (duration: 115.613168ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:45:56.764633Z","caller":"traceutil/trace.go:171","msg":"trace[171787283] transaction","detail":"{read_only:false; response_revision:131; number_of_response:1; }","duration":"130.601463ms","start":"2026-02-26T16:45:56.634019Z","end":"2026-02-26T16:45:56.76462Z","steps":["trace[171787283] 'process raft request' (duration: 130.537958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:45:57.119024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.401767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:45:57.119118Z","caller":"traceutil/trace.go:171","msg":"trace[1182071178] linearizableReadLoop","detail":"{readStateIndex:138; appliedIndex:137; }","duration":"299.397697ms","start":"2026-02-26T16:45:56.819704Z","end":"2026-02-26T16:45:57.119102Z","steps":["trace[1182071178] 'read index received' (duration: 91.791135ms)","trace[1182071178] 'applied index is now lower than readState.Index' (duration: 207.605662ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:45:57.119235Z","caller":"traceutil/trace.go:171","msg":"trace[659443796] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"331.433913ms","start":"2026-02-26T16:45:56.787758Z","end":"2026-02-26T16:45:57.119191Z","steps":["trace[659443796] 'process raft request' (duration: 123.79825ms)","trace[659443796] 'compare' (duration: 207.265807ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:45:57.119264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.555018ms","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-26T16:45:57.119388Z","caller":"traceutil/trace.go:171","msg":"trace[1887756371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:134; }","duration":"299.711659ms","start":"2026-02-26T16:45:56.819653Z","end":"2026-02-26T16:45:57.119365Z","steps":["trace[1887756371] 'agreement among raft nodes before linearized reading' (duration: 299.491654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:45:57.119413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:45:56.787736Z","time spent":"331.576773ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T16:45:57.321914Z","caller":"traceutil/trace.go:171","msg":"trace[1668444843] linearizableReadLoop","detail":"{readStateIndex:140; appliedIndex:138; }","duration":"180.707415ms","start":"2026-02-26T16:45:57.141162Z","end":"2026-02-26T16:45:57.321869Z","steps":["trace[1668444843] 'read index received' (duration: 43.785748ms)","trace[1668444843] 'applied index is now lower than readState.Index' (duration: 136.920527ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:45:57.321973Z","caller":"traceutil/trace.go:171","msg":"trace[78620714] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"197.33308ms","start":"2026-02-26T16:45:57.124617Z","end":"2026-02-26T16:45:57.32195Z","steps":["trace[78620714] 'process raft request' (duration: 128.69327ms)","trace[78620714] 'compare' (duration: 68.437726ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:45:57.322099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.898538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:45:57.322198Z","caller":"traceutil/trace.go:171","msg":"trace[512467948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:136; }","duration":"181.056819ms","start":"2026-02-26T16:45:57.141126Z","end":"2026-02-26T16:45:57.322183Z","steps":["trace[512467948] 'agreement among raft nodes before linearized reading' (duration: 180.854295ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:45:57.590161Z","caller":"traceutil/trace.go:171","msg":"trace[509008444] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"174.297406ms","start":"2026-02-26T16:45:57.415831Z","end":"2026-02-26T16:45:57.590129Z","steps":["trace[509008444] 'process raft request' (duration: 83.878839ms)","trace[509008444] 'compare' (duration: 90.284917ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:45:57.920828Z","caller":"traceutil/trace.go:171","msg":"trace[1077294231] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"325.281648ms","start":"2026-02-26T16:45:57.595524Z","end":"2026-02-26T16:45:57.920806Z","steps":["trace[1077294231] 'process raft request' (duration: 291.848765ms)","trace[1077294231] 'compare' (duration: 33.313165ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:45:57.921008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:45:57.595506Z","time spent":"325.389895ms","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":664,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T16:45:58.112333Z","caller":"traceutil/trace.go:171","msg":"trace[496128625] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"121.619736ms","start":"2026-02-26T16:45:57.990661Z","end":"2026-02-26T16:45:58.11228Z","steps":["trace[496128625] 'process raft request' (duration: 40.97492ms)","trace[496128625] 'compare' (duration: 80.40584ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:45:58.500518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.389224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:45:58.500667Z","caller":"traceutil/trace.go:171","msg":"trace[1678055541] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"383.585089ms","start":"2026-02-26T16:45:58.117057Z","end":"2026-02-26T16:45:58.500642Z","steps":["trace[1678055541] 'process raft request' (duration: 130.940797ms)","trace[1678055541] 'compare' (duration: 252.118766ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:45:58.50075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:45:58.117023Z","time spent":"383.686016ms","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T16:45:58.516655Z","caller":"traceutil/trace.go:171","msg":"trace[1659879477] linearizableReadLoop","detail":"{readStateIndex:149; appliedIndex:147; }","duration":"275.427137ms","start":"2026-02-26T16:45:58.241199Z","end":"2026-02-26T16:45:58.516626Z","steps":["trace[1659879477] 'read index received' (duration: 6.81128ms)","trace[1659879477] 'applied index is now lower than readState.Index' (duration: 268.614897ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:45:58.516668Z","caller":"traceutil/trace.go:171","msg":"trace[172650842] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"334.443311ms","start":"2026-02-26T16:45:58.182204Z","end":"2026-02-26T16:45:58.516647Z","steps":["trace[172650842] 'process raft request' (duration: 334.339833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:45:58.516759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:45:58.182181Z","time spent":"334.536207ms","remote":"127.0.0.1:57348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:45:58.516909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.708806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:45:58.516959Z","caller":"traceutil/trace.go:171","msg":"trace[1120913850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:144; }","duration":"275.807623ms","start":"2026-02-26T16:45:58.241137Z","end":"2026-02-26T16:45:58.516945Z","steps":["trace[1120913850] 'agreement among raft nodes before linearized reading' (duration: 275.583687ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:45:59.645857Z","caller":"traceutil/trace.go:171","msg":"trace[1912072194] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"105.558281ms","start":"2026-02-26T16:45:59.540269Z","end":"2026-02-26T16:45:59.645827Z","steps":["trace[1912072194] 'process raft request' (duration: 54.815003ms)","trace[1912072194] 'compare' (duration: 50.626879ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:00.390728Z","caller":"traceutil/trace.go:171","msg":"trace[1385905619] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"151.840675ms","start":"2026-02-26T16:46:00.238827Z","end":"2026-02-26T16:46:00.390668Z","steps":["trace[1385905619] 'process raft request' (duration: 123.012219ms)","trace[1385905619] 'compare' (duration: 28.693296ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:01.223023Z","caller":"traceutil/trace.go:171","msg":"trace[529205673] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"131.81687ms","start":"2026-02-26T16:46:01.091177Z","end":"2026-02-26T16:46:01.222994Z","steps":["trace[529205673] 'process raft request' (duration: 123.401591ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:03.143648Z","caller":"traceutil/trace.go:171","msg":"trace[2097961441] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:327; }","duration":"239.341846ms","start":"2026-02-26T16:46:02.904273Z","end":"2026-02-26T16:46:03.143615Z","steps":["trace[2097961441] 'read index received' (duration: 227.893845ms)","trace[2097961441] 'applied index is now lower than readState.Index' (duration: 11.445851ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:03.143706Z","caller":"traceutil/trace.go:171","msg":"trace[445033510] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"258.618375ms","start":"2026-02-26T16:46:02.885058Z","end":"2026-02-26T16:46:03.143676Z","steps":["trace[445033510] 'process raft request' (duration: 247.173633ms)","trace[445033510] 'compare' (duration: 11.156541ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:03.143876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.595874ms","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-26T16:46:03.143942Z","caller":"traceutil/trace.go:171","msg":"trace[1153311813] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:314; }","duration":"239.712463ms","start":"2026-02-26T16:46:02.904207Z","end":"2026-02-26T16:46:03.143919Z","steps":["trace[1153311813] 'agreement among raft nodes before linearized reading' (duration: 239.560322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:03.552677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.360065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:46:03.552879Z","caller":"traceutil/trace.go:171","msg":"trace[560226995] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"360.529589ms","start":"2026-02-26T16:46:03.192315Z","end":"2026-02-26T16:46:03.552845Z","steps":["trace[560226995] 'process raft request' (duration: 51.755594ms)","trace[560226995] 'compare' (duration: 308.049703ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:03.552789Z","caller":"traceutil/trace.go:171","msg":"trace[206918736] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:331; }","duration":"346.407004ms","start":"2026-02-26T16:46:03.206364Z","end":"2026-02-26T16:46:03.552771Z","steps":["trace[206918736] 'read index received' (duration: 37.624989ms)","trace[206918736] 'applied index is now lower than readState.Index' (duration: 308.780365ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:03.553096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:03.192303Z","time spent":"360.670029ms","remote":"127.0.0.1:57452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:46:03.553155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.766861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:46:03.553258Z","caller":"traceutil/trace.go:171","msg":"trace[954175954] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:318; }","duration":"346.923373ms","start":"2026-02-26T16:46:03.206311Z","end":"2026-02-26T16:46:03.553234Z","steps":["trace[954175954] 'agreement among raft nodes before linearized reading' (duration: 346.761021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:03.553244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.409962ms","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-26T16:46:03.55332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:03.20629Z","time spent":"347.017069ms","remote":"127.0.0.1:57482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" "} {"level":"info","ts":"2026-02-26T16:46:03.553341Z","caller":"traceutil/trace.go:171","msg":"trace[395054218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:318; }","duration":"259.557153ms","start":"2026-02-26T16:46:03.293751Z","end":"2026-02-26T16:46:03.553308Z","steps":["trace[395054218] 'agreement among raft nodes before linearized reading' (duration: 259.405762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:03.553371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.152593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-26T16:46:03.553607Z","caller":"traceutil/trace.go:171","msg":"trace[707124349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:318; }","duration":"310.459355ms","start":"2026-02-26T16:46:03.243132Z","end":"2026-02-26T16:46:03.553592Z","steps":["trace[707124349] 'agreement among raft nodes before linearized reading' (duration: 309.96291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:03.553705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:03.243093Z","time spent":"310.599014ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T16:46:03.698574Z","caller":"traceutil/trace.go:171","msg":"trace[279436045] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"136.848889ms","start":"2026-02-26T16:46:03.561697Z","end":"2026-02-26T16:46:03.698546Z","steps":["trace[279436045] 'process raft request' (duration: 121.023644ms)","trace[279436045] 'compare' (duration: 15.567676ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:03.69877Z","caller":"traceutil/trace.go:171","msg":"trace[1130585423] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"135.228332ms","start":"2026-02-26T16:46:03.563512Z","end":"2026-02-26T16:46:03.69874Z","steps":["trace[1130585423] 'process raft request' (duration: 135.004016ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:03.698772Z","caller":"traceutil/trace.go:171","msg":"trace[710787070] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"135.533824ms","start":"2026-02-26T16:46:03.563218Z","end":"2026-02-26T16:46:03.698752Z","steps":["trace[710787070] 'process raft request' (duration: 135.157777ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:03.984464Z","caller":"traceutil/trace.go:171","msg":"trace[674494075] linearizableReadLoop","detail":"{readStateIndex:342; appliedIndex:341; }","duration":"182.143018ms","start":"2026-02-26T16:46:03.80229Z","end":"2026-02-26T16:46:03.984433Z","steps":["trace[674494075] 'read index received' (duration: 83.137405ms)","trace[674494075] 'applied index is now lower than readState.Index' (duration: 99.004483ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:03.984658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.346053ms","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-26T16:46:03.984713Z","caller":"traceutil/trace.go:171","msg":"trace[1349840247] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:328; }","duration":"182.432209ms","start":"2026-02-26T16:46:03.802265Z","end":"2026-02-26T16:46:03.984697Z","steps":["trace[1349840247] 'agreement among raft nodes before linearized reading' (duration: 182.279048ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:03.984966Z","caller":"traceutil/trace.go:171","msg":"trace[311526893] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"188.56827ms","start":"2026-02-26T16:46:03.796372Z","end":"2026-02-26T16:46:03.98494Z","steps":["trace[311526893] 'process raft request' (duration: 89.108574ms)","trace[311526893] 'compare' (duration: 98.752825ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:05.430013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.636314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:46:05.430146Z","caller":"traceutil/trace.go:171","msg":"trace[1453340976] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:340; }","duration":"276.85726ms","start":"2026-02-26T16:46:05.153273Z","end":"2026-02-26T16:46:05.43013Z","steps":["trace[1453340976] 'range keys from in-memory index tree' (duration: 276.554047ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:05.660791Z","caller":"traceutil/trace.go:171","msg":"trace[1379217922] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"154.197639ms","start":"2026-02-26T16:46:05.506554Z","end":"2026-02-26T16:46:05.660751Z","steps":["trace[1379217922] 'process raft request' (duration: 70.222183ms)","trace[1379217922] 'compare' (duration: 83.687656ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:06.066356Z","caller":"traceutil/trace.go:171","msg":"trace[1599247478] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"112.375582ms","start":"2026-02-26T16:46:05.953935Z","end":"2026-02-26T16:46:06.066311Z","steps":["trace[1599247478] 'read index received' (duration: 74.26633ms)","trace[1599247478] 'applied index is now lower than readState.Index' (duration: 38.093161ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:06.066361Z","caller":"traceutil/trace.go:171","msg":"trace[737084743] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"130.2151ms","start":"2026-02-26T16:46:05.936099Z","end":"2026-02-26T16:46:06.066315Z","steps":["trace[737084743] 'process raft request' (duration: 92.150952ms)","trace[737084743] 'compare' (duration: 37.720493ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:06.066646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.691544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-26T16:46:06.066734Z","caller":"traceutil/trace.go:171","msg":"trace[1552909236] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:353; }","duration":"112.775841ms","start":"2026-02-26T16:46:05.953918Z","end":"2026-02-26T16:46:06.066694Z","steps":["trace[1552909236] 'agreement among raft nodes before linearized reading' (duration: 112.519232ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:12.849445Z","caller":"traceutil/trace.go:171","msg":"trace[1654722949] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"129.716784ms","start":"2026-02-26T16:46:12.71969Z","end":"2026-02-26T16:46:12.849407Z","steps":["trace[1654722949] 'process raft request' (duration: 129.382729ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:13.060909Z","caller":"traceutil/trace.go:171","msg":"trace[1693610374] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"195.737081ms","start":"2026-02-26T16:46:12.865142Z","end":"2026-02-26T16:46:13.060879Z","steps":["trace[1693610374] 'process raft request' (duration: 194.114332ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:18.485182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088719374774514,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T16:46:18.612257Z","caller":"traceutil/trace.go:171","msg":"trace[1821814204] linearizableReadLoop","detail":"{readStateIndex:475; appliedIndex:474; }","duration":"627.813199ms","start":"2026-02-26T16:46:17.984403Z","end":"2026-02-26T16:46:18.612216Z","steps":["trace[1821814204] 'read index received' (duration: 627.30595ms)","trace[1821814204] 'applied index is now lower than readState.Index' (duration: 505.359µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:18.612305Z","caller":"traceutil/trace.go:171","msg":"trace[257658113] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"763.558866ms","start":"2026-02-26T16:46:17.848706Z","end":"2026-02-26T16:46:18.612265Z","steps":["trace[257658113] 'process raft request' (duration: 763.101071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:18.612506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.070258ms","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-26T16:46:18.612555Z","caller":"traceutil/trace.go:171","msg":"trace[222948535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:457; }","duration":"628.174016ms","start":"2026-02-26T16:46:17.984366Z","end":"2026-02-26T16:46:18.61254Z","steps":["trace[222948535] 'agreement among raft nodes before linearized reading' (duration: 628.011764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:18.612594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:17.984348Z","time spent":"628.2378ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T16:46:18.612629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.959372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T16:46:18.612657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:17.848686Z","time spent":"763.803654ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:46:18.612721Z","caller":"traceutil/trace.go:171","msg":"trace[2027040471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:457; }","duration":"264.110474ms","start":"2026-02-26T16:46:18.348573Z","end":"2026-02-26T16:46:18.612683Z","steps":["trace[2027040471] 'agreement among raft nodes before linearized reading' (duration: 263.956702ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:19.101444Z","caller":"traceutil/trace.go:171","msg":"trace[1611385727] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"483.93387ms","start":"2026-02-26T16:46:18.617473Z","end":"2026-02-26T16:46:19.101407Z","steps":["trace[1611385727] 'process raft request' (duration: 446.496576ms)","trace[1611385727] 'compare' (duration: 37.081908ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:19.101612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:18.617455Z","time spent":"484.081012ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:46:19.418677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.217477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:46:19.418806Z","caller":"traceutil/trace.go:171","msg":"trace[430125600] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:475; }","duration":"752.441343ms","start":"2026-02-26T16:46:18.666347Z","end":"2026-02-26T16:46:19.418788Z","steps":["trace[430125600] 'read index received' (duration: 397.644015ms)","trace[430125600] 'applied index is now lower than readState.Index' (duration: 354.796057ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:19.418852Z","caller":"traceutil/trace.go:171","msg":"trace[1327255174] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"801.139603ms","start":"2026-02-26T16:46:18.61769Z","end":"2026-02-26T16:46:19.41883Z","steps":["trace[1327255174] 'process raft request' (duration: 643.659995ms)","trace[1327255174] 'compare' (duration: 157.095458ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:19.418908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.559161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:46:19.418938Z","caller":"traceutil/trace.go:171","msg":"trace[1690302067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:459; }","duration":"752.614116ms","start":"2026-02-26T16:46:18.666313Z","end":"2026-02-26T16:46:19.418927Z","steps":["trace[1690302067] 'agreement among raft nodes before linearized reading' (duration: 752.564952ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:19.418977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:18.666301Z","time spent":"752.670109ms","remote":"127.0.0.1:57290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T16:46:19.418976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:18.617682Z","time spent":"801.235299ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:46:19.419174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.90418ms","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-26T16:46:19.41921Z","caller":"traceutil/trace.go:171","msg":"trace[1677567942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:459; }","duration":"538.941082ms","start":"2026-02-26T16:46:18.880261Z","end":"2026-02-26T16:46:19.419202Z","steps":["trace[1677567942] 'agreement among raft nodes before linearized reading' (duration: 538.878158ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:19.41925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:18.880172Z","time spent":"539.066812ms","remote":"127.0.0.1:57552","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-26T16:46:19.419338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.87394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-26T16:46:19.419368Z","caller":"traceutil/trace.go:171","msg":"trace[1134444853] range","detail":"{range_begin:/registry/masterleases/162.253.55.209; range_end:; response_count:1; response_revision:459; }","duration":"276.903632ms","start":"2026-02-26T16:46:19.142458Z","end":"2026-02-26T16:46:19.419361Z","steps":["trace[1134444853] 'agreement among raft nodes before linearized reading' (duration: 276.855769ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:19.59698Z","caller":"traceutil/trace.go:171","msg":"trace[2025381273] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"172.098871ms","start":"2026-02-26T16:46:19.424856Z","end":"2026-02-26T16:46:19.596955Z","steps":["trace[2025381273] 'process raft request' (duration: 97.733441ms)","trace[2025381273] 'compare' (duration: 74.164375ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:19.597105Z","caller":"traceutil/trace.go:171","msg":"trace[867683176] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"110.439243ms","start":"2026-02-26T16:46:19.486634Z","end":"2026-02-26T16:46:19.597074Z","steps":["trace[867683176] 'process raft request' (duration: 110.275901ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:23.861186Z","caller":"traceutil/trace.go:171","msg":"trace[1159177047] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"194.23396ms","start":"2026-02-26T16:46:23.666927Z","end":"2026-02-26T16:46:23.861161Z","steps":["trace[1159177047] 'read index received' (duration: 194.042135ms)","trace[1159177047] 'applied index is now lower than readState.Index' (duration: 190.754µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:23.861317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.36839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:46:23.86135Z","caller":"traceutil/trace.go:171","msg":"trace[53660775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"194.477938ms","start":"2026-02-26T16:46:23.666863Z","end":"2026-02-26T16:46:23.86134Z","steps":["trace[53660775] 'agreement among raft nodes before linearized reading' (duration: 194.396772ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:23.861545Z","caller":"traceutil/trace.go:171","msg":"trace[347159702] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"218.316278ms","start":"2026-02-26T16:46:23.643154Z","end":"2026-02-26T16:46:23.86147Z","steps":["trace[347159702] 'process raft request' (duration: 217.869394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:25.278152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.402281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-02-26T16:46:25.278245Z","caller":"traceutil/trace.go:171","msg":"trace[111089449] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:472; }","duration":"372.542272ms","start":"2026-02-26T16:46:24.90568Z","end":"2026-02-26T16:46:25.278222Z","steps":["trace[111089449] 'range keys from in-memory index tree' (duration: 372.259111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:25.278227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.97465ms","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-26T16:46:25.278288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:24.905656Z","time spent":"372.621828ms","remote":"127.0.0.1:57376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12691,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-02-26T16:46:25.278569Z","caller":"traceutil/trace.go:171","msg":"trace[442311689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"131.097699ms","start":"2026-02-26T16:46:25.147183Z","end":"2026-02-26T16:46:25.278281Z","steps":["trace[442311689] 'range keys from in-memory index tree' (duration: 130.869242ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:28.918607Z","caller":"traceutil/trace.go:171","msg":"trace[239551621] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"156.060234ms","start":"2026-02-26T16:46:28.762526Z","end":"2026-02-26T16:46:28.918586Z","steps":["trace[239551621] 'process raft request' (duration: 155.914083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:35.053923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.341601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-st7xq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-02-26T16:46:35.054039Z","caller":"traceutil/trace.go:171","msg":"trace[1091854352] range","detail":"{range_begin:/registry/pods/kube-system/cilium-st7xq; range_end:; response_count:1; response_revision:553; }","duration":"216.513485ms","start":"2026-02-26T16:46:34.837502Z","end":"2026-02-26T16:46:35.054015Z","steps":["trace[1091854352] 'range keys from in-memory index tree' (duration: 216.136556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:35.366999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.491927ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-26T16:46:35.367289Z","caller":"traceutil/trace.go:171","msg":"trace[222360546] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"343.424177ms","start":"2026-02-26T16:46:35.023846Z","end":"2026-02-26T16:46:35.36727Z","steps":["trace[222360546] 'process raft request' (duration: 343.279206ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:35.367304Z","caller":"traceutil/trace.go:171","msg":"trace[2137788705] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:574; }","duration":"425.456754ms","start":"2026-02-26T16:46:34.941765Z","end":"2026-02-26T16:46:35.367222Z","steps":["trace[2137788705] 'read index received' (duration: 67.807554ms)","trace[2137788705] 'applied index is now lower than readState.Index' (duration: 357.640269ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:35.367407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:35.023821Z","time spent":"343.512944ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:46:35.367857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.059581ms","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-26T16:46:35.367988Z","caller":"traceutil/trace.go:171","msg":"trace[889142975] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"426.258116ms","start":"2026-02-26T16:46:34.941699Z","end":"2026-02-26T16:46:35.367957Z","steps":["trace[889142975] 'agreement among raft nodes before linearized reading' (duration: 425.630677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:35.3681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:34.941668Z","time spent":"426.369264ms","remote":"127.0.0.1:57552","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-26T16:46:35.467146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.542252ms","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-26T16:46:35.467226Z","caller":"traceutil/trace.go:171","msg":"trace[1222020672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"141.678913ms","start":"2026-02-26T16:46:35.325528Z","end":"2026-02-26T16:46:35.467207Z","steps":["trace[1222020672] 'agreement among raft nodes before linearized reading' (duration: 141.454216ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:35.467194Z","caller":"traceutil/trace.go:171","msg":"trace[1424046160] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"397.414415ms","start":"2026-02-26T16:46:35.069731Z","end":"2026-02-26T16:46:35.467145Z","steps":["trace[1424046160] 'process raft request' (duration: 397.095901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:35.467492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:35.069712Z","time spent":"397.587669ms","remote":"127.0.0.1:57452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:46:35.487869Z","caller":"traceutil/trace.go:171","msg":"trace[723218744] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"116.210956ms","start":"2026-02-26T16:46:35.371609Z","end":"2026-02-26T16:46:35.48782Z","steps":["trace[723218744] 'process raft request' (duration: 104.967662ms)","trace[723218744] 'compare' (duration: 11.108033ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:46:36.106762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.974899ms","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-26T16:46:36.106835Z","caller":"traceutil/trace.go:171","msg":"trace[1651091227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"159.10942ms","start":"2026-02-26T16:46:35.947709Z","end":"2026-02-26T16:46:36.106818Z","steps":["trace[1651091227] 'range keys from in-memory index tree' (duration: 158.72878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:36.106836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.596328ms","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-26T16:46:36.106897Z","caller":"traceutil/trace.go:171","msg":"trace[2011452136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"488.706766ms","start":"2026-02-26T16:46:35.618173Z","end":"2026-02-26T16:46:36.106879Z","steps":["trace[2011452136] 'range keys from in-memory index tree' (duration: 488.455486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:36.106929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:35.618154Z","time spent":"488.768401ms","remote":"127.0.0.1:57552","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-26T16:46:37.026998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.67518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:46:37.027404Z","caller":"traceutil/trace.go:171","msg":"trace[163864786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"360.109024ms","start":"2026-02-26T16:46:36.667272Z","end":"2026-02-26T16:46:37.027381Z","steps":["trace[163864786] 'range keys from in-memory index tree' (duration: 359.509298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:37.027472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:36.667179Z","time spent":"360.278977ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T16:46:37.940146Z","caller":"traceutil/trace.go:171","msg":"trace[1408120328] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:581; }","duration":"438.361647ms","start":"2026-02-26T16:46:37.501759Z","end":"2026-02-26T16:46:37.940121Z","steps":["trace[1408120328] 'read index received' (duration: 438.091436ms)","trace[1408120328] 'applied index is now lower than readState.Index' (duration: 268.941µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:37.940277Z","caller":"traceutil/trace.go:171","msg":"trace[145995077] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"444.392032ms","start":"2026-02-26T16:46:37.495873Z","end":"2026-02-26T16:46:37.940265Z","steps":["trace[145995077] 'process raft request' (duration: 444.095089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:37.940383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.928981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:46:37.940467Z","caller":"traceutil/trace.go:171","msg":"trace[633213180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"273.076202ms","start":"2026-02-26T16:46:37.667377Z","end":"2026-02-26T16:46:37.940453Z","steps":["trace[633213180] 'agreement among raft nodes before linearized reading' (duration: 272.903059ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:37.940461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:37.495841Z","time spent":"444.488109ms","remote":"127.0.0.1:57552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:46:37.94063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.847985ms","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-26T16:46:37.940712Z","caller":"traceutil/trace.go:171","msg":"trace[734068997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:560; }","duration":"438.978715ms","start":"2026-02-26T16:46:37.50171Z","end":"2026-02-26T16:46:37.940689Z","steps":["trace[734068997] 'agreement among raft nodes before linearized reading' (duration: 438.713604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:37.940758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:46:37.501693Z","time spent":"439.056871ms","remote":"127.0.0.1:57552","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-26T16:46:38.130461Z","caller":"traceutil/trace.go:171","msg":"trace[1522888998] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"184.752775ms","start":"2026-02-26T16:46:37.945682Z","end":"2026-02-26T16:46:38.130434Z","steps":["trace[1522888998] 'process raft request' (duration: 111.956204ms)","trace[1522888998] 'compare' (duration: 72.667981ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:43.23152Z","caller":"traceutil/trace.go:171","msg":"trace[1520616991] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"154.439701ms","start":"2026-02-26T16:46:43.077043Z","end":"2026-02-26T16:46:43.231482Z","steps":["trace[1520616991] 'read index received' (duration: 151.507922ms)","trace[1520616991] 'applied index is now lower than readState.Index' (duration: 2.930559ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:46:43.231568Z","caller":"traceutil/trace.go:171","msg":"trace[1294100138] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"214.930016ms","start":"2026-02-26T16:46:43.016599Z","end":"2026-02-26T16:46:43.231529Z","steps":["trace[1294100138] 'process raft request' (duration: 212.072693ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:46:43.231752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.690296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-26T16:46:43.231801Z","caller":"traceutil/trace.go:171","msg":"trace[1547400833] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:634; }","duration":"154.80319ms","start":"2026-02-26T16:46:43.076982Z","end":"2026-02-26T16:46:43.231786Z","steps":["trace[1547400833] 'agreement among raft nodes before linearized reading' (duration: 154.616431ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:46:58.271842Z","caller":"traceutil/trace.go:171","msg":"trace[1281757760] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"245.72775ms","start":"2026-02-26T16:46:58.026087Z","end":"2026-02-26T16:46:58.271815Z","steps":["trace[1281757760] 'process raft request' (duration: 245.577025ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:47:02.536096Z","caller":"traceutil/trace.go:171","msg":"trace[1608757557] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"239.288541ms","start":"2026-02-26T16:47:02.296781Z","end":"2026-02-26T16:47:02.53607Z","steps":["trace[1608757557] 'read index received' (duration: 239.080956ms)","trace[1608757557] 'applied index is now lower than readState.Index' (duration: 206.225µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:47:02.536198Z","caller":"traceutil/trace.go:171","msg":"trace[655608807] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"244.928447ms","start":"2026-02-26T16:47:02.291231Z","end":"2026-02-26T16:47:02.53616Z","steps":["trace[655608807] 'process raft request' (duration: 244.690214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:47:02.53634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.542453ms","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-26T16:47:02.536386Z","caller":"traceutil/trace.go:171","msg":"trace[751195239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:785; }","duration":"239.64183ms","start":"2026-02-26T16:47:02.29673Z","end":"2026-02-26T16:47:02.536372Z","steps":["trace[751195239] 'agreement among raft nodes before linearized reading' (duration: 239.482375ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:47:02.536464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.414828ms","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-26T16:47:02.53647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.734757ms","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-26T16:47:02.536518Z","caller":"traceutil/trace.go:171","msg":"trace[1189601702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:785; }","duration":"233.492117ms","start":"2026-02-26T16:47:02.303013Z","end":"2026-02-26T16:47:02.536505Z","steps":["trace[1189601702] 'agreement among raft nodes before linearized reading' (duration: 233.328231ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:47:02.536548Z","caller":"traceutil/trace.go:171","msg":"trace[514107511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:785; }","duration":"235.831994ms","start":"2026-02-26T16:47:02.300696Z","end":"2026-02-26T16:47:02.536528Z","steps":["trace[514107511] 'agreement among raft nodes before linearized reading' (duration: 235.561901ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:47:02.659503Z","caller":"traceutil/trace.go:171","msg":"trace[617691620] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"119.129639ms","start":"2026-02-26T16:47:02.540353Z","end":"2026-02-26T16:47:02.659483Z","steps":["trace[617691620] 'process raft request' (duration: 59.497172ms)","trace[617691620] 'compare' (duration: 59.493401ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:47:02.661353Z","caller":"traceutil/trace.go:171","msg":"trace[1913673432] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"120.59039ms","start":"2026-02-26T16:47:02.54073Z","end":"2026-02-26T16:47:02.66132Z","steps":["trace[1913673432] 'process raft request' (duration: 120.365726ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:47:02.661471Z","caller":"traceutil/trace.go:171","msg":"trace[1508935288] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"120.178191ms","start":"2026-02-26T16:47:02.541262Z","end":"2026-02-26T16:47:02.66144Z","steps":["trace[1508935288] 'process raft request' (duration: 119.991606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:48:11.501634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.287129ms","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-26T16:48:11.501805Z","caller":"traceutil/trace.go:171","msg":"trace[272936552] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1018; }","duration":"120.539648ms","start":"2026-02-26T16:48:11.381236Z","end":"2026-02-26T16:48:11.501776Z","steps":["trace[272936552] 'range keys from in-memory index tree' (duration: 120.182857ms)"],"step_count":1}