{"level":"warn","ts":"2026-02-25T01:35:08.635109Z","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-25T01:35:08.635199Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-25T01:35:08.635261Z","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-25T01:35:08.635273Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-02-25T01:35:08.635291Z","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-25T01:35:08.63589Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-02-25T01:35:08.636058Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-25T01:35:08.64032Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.978243ms"} {"level":"info","ts":"2026-02-25T01:35:08.653791Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-02-25T01:35:08.653858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T01:35:08.653883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-02-25T01:35:08.653896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T01:35:08.653904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-02-25T01:35:08.653934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-02-25T01:35:08.661639Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T01:35:08.667527Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T01:35:08.671277Z","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-25T01:35:08.673721Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T01:35:08.673923Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T01:35:08.674127Z","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-25T01:35:08.674169Z","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-25T01:35:08.674184Z","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-25T01:35:08.674758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-02-25T01:35:08.674903Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-02-25T01:35:08.678167Z","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-25T01:35:08.67822Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-02-25T01:35:08.678251Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-02-25T01:35:08.679562Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T01:35:08.679627Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T01:35:09.454527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T01:35:09.45461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T01:35:09.454625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-02-25T01:35:09.454637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-02-25T01:35:09.454643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-02-25T01:35:09.454652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-02-25T01:35:09.45466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-02-25T01:35:09.455653Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:35:09.456355Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T01:35:09.456398Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:35:09.456436Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:35:09.456615Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T01:35:09.456691Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T01:35:09.457019Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:35:09.457099Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:35:09.457126Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:35:09.460522Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-02-25T01:35:09.460493Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T01:35:14.833806Z","caller":"traceutil/trace.go:171","msg":"trace[1041143146] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"101.674869ms","start":"2026-02-25T01:35:14.7321Z","end":"2026-02-25T01:35:14.833775Z","steps":["trace[1041143146] 'process raft request' (duration: 99.447911ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:16.898708Z","caller":"traceutil/trace.go:171","msg":"trace[433630998] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"131.246558ms","start":"2026-02-25T01:35:16.767436Z","end":"2026-02-25T01:35:16.898683Z","steps":["trace[433630998] 'process raft request' (duration: 75.368603ms)","trace[433630998] 'compare' (duration: 55.754724ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:18.130519Z","caller":"traceutil/trace.go:171","msg":"trace[1041054645] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"105.676999ms","start":"2026-02-25T01:35:18.024794Z","end":"2026-02-25T01:35:18.130471Z","steps":["trace[1041054645] 'process raft request' (duration: 49.687071ms)","trace[1041054645] 'compare' (duration: 55.794266ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:18.335277Z","caller":"traceutil/trace.go:171","msg":"trace[556527468] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"196.772217ms","start":"2026-02-25T01:35:18.138479Z","end":"2026-02-25T01:35:18.335252Z","steps":["trace[556527468] 'process raft request' (duration: 126.186001ms)","trace[556527468] 'compare' (duration: 70.306074ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:18.33541Z","caller":"traceutil/trace.go:171","msg":"trace[865781832] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"195.378258ms","start":"2026-02-25T01:35:18.140006Z","end":"2026-02-25T01:35:18.335385Z","steps":["trace[865781832] 'process raft request' (duration: 195.187676ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:18.335391Z","caller":"traceutil/trace.go:171","msg":"trace[1130214538] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"195.058795ms","start":"2026-02-25T01:35:18.140296Z","end":"2026-02-25T01:35:18.335355Z","steps":["trace[1130214538] 'process raft request' (duration: 194.972415ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:18.335697Z","caller":"traceutil/trace.go:171","msg":"trace[1224823800] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"194.618952ms","start":"2026-02-25T01:35:18.141071Z","end":"2026-02-25T01:35:18.33569Z","steps":["trace[1224823800] 'process raft request' (duration: 194.244189ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:18.335761Z","caller":"traceutil/trace.go:171","msg":"trace[422832476] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:326; }","duration":"169.237351ms","start":"2026-02-25T01:35:18.166517Z","end":"2026-02-25T01:35:18.335754Z","steps":["trace[422832476] 'read index received' (duration: 98.110231ms)","trace[422832476] 'applied index is now lower than readState.Index' (duration: 71.12642ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:18.33587Z","caller":"traceutil/trace.go:171","msg":"trace[637902197] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"187.924241ms","start":"2026-02-25T01:35:18.147934Z","end":"2026-02-25T01:35:18.335859Z","steps":["trace[637902197] 'process raft request' (duration: 187.648699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:18.335875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.336592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-02-25T01:35:18.335984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.821201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-25T01:35:18.336013Z","caller":"traceutil/trace.go:171","msg":"trace[123739878] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:320; }","duration":"112.892411ms","start":"2026-02-25T01:35:18.223113Z","end":"2026-02-25T01:35:18.336005Z","steps":["trace[123739878] 'agreement among raft nodes before linearized reading' (duration: 112.79977ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:18.336012Z","caller":"traceutil/trace.go:171","msg":"trace[1731237690] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:320; }","duration":"169.506433ms","start":"2026-02-25T01:35:18.166485Z","end":"2026-02-25T01:35:18.335992Z","steps":["trace[1731237690] 'agreement among raft nodes before linearized reading' (duration: 169.318411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:19.276238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.495495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:35:19.276388Z","caller":"traceutil/trace.go:171","msg":"trace[817803253] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:358; }","duration":"178.023537ms","start":"2026-02-25T01:35:19.098352Z","end":"2026-02-25T01:35:19.276376Z","steps":["trace[817803253] 'read index received' (duration: 31.975827ms)","trace[817803253] 'applied index is now lower than readState.Index' (duration: 146.04677ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:19.276492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.137337ms","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-25T01:35:19.276515Z","caller":"traceutil/trace.go:171","msg":"trace[247774578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:347; }","duration":"178.195737ms","start":"2026-02-25T01:35:19.098309Z","end":"2026-02-25T01:35:19.276505Z","steps":["trace[247774578] 'agreement among raft nodes before linearized reading' (duration: 178.140827ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:19.276436Z","caller":"traceutil/trace.go:171","msg":"trace[1865036877] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"248.403407ms","start":"2026-02-25T01:35:19.027984Z","end":"2026-02-25T01:35:19.276387Z","steps":["trace[1865036877] 'process raft request' (duration: 102.326237ms)","trace[1865036877] 'compare' (duration: 145.339803ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:19.276775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.083877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-25T01:35:19.2769Z","caller":"traceutil/trace.go:171","msg":"trace[1322198753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:347; }","duration":"136.262548ms","start":"2026-02-25T01:35:19.140613Z","end":"2026-02-25T01:35:19.276875Z","steps":["trace[1322198753] 'agreement among raft nodes before linearized reading' (duration: 135.980436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:33.4681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334365933993423282,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T01:35:33.503091Z","caller":"traceutil/trace.go:171","msg":"trace[1079091198] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:436; }","duration":"535.059159ms","start":"2026-02-25T01:35:32.967997Z","end":"2026-02-25T01:35:33.503056Z","steps":["trace[1079091198] 'read index received' (duration: 534.798547ms)","trace[1079091198] 'applied index is now lower than readState.Index' (duration: 259.462µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:33.50329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.2644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:35:33.503266Z","caller":"traceutil/trace.go:171","msg":"trace[98861217] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"602.526939ms","start":"2026-02-25T01:35:32.900695Z","end":"2026-02-25T01:35:33.503222Z","steps":["trace[98861217] 'process raft request' (duration: 602.189007ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:33.503345Z","caller":"traceutil/trace.go:171","msg":"trace[1361476352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"535.395862ms","start":"2026-02-25T01:35:32.967936Z","end":"2026-02-25T01:35:33.503331Z","steps":["trace[1361476352] 'agreement among raft nodes before linearized reading' (duration: 535.281831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:33.50339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:32.967917Z","time spent":"535.460772ms","remote":"127.0.0.1:43478","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-25T01:35:33.503429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.151134ms","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-25T01:35:33.503498Z","caller":"traceutil/trace.go:171","msg":"trace[1593609415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:421; }","duration":"432.266375ms","start":"2026-02-25T01:35:33.071217Z","end":"2026-02-25T01:35:33.503483Z","steps":["trace[1593609415] 'agreement among raft nodes before linearized reading' (duration: 432.159794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:33.503525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:33.071197Z","time spent":"432.321496ms","remote":"127.0.0.1:43790","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-25T01:35:33.503648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.802628ms","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-25T01:35:33.503661Z","caller":"traceutil/trace.go:171","msg":"trace[43965278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:421; }","duration":"141.827149ms","start":"2026-02-25T01:35:33.361829Z","end":"2026-02-25T01:35:33.503657Z","steps":["trace[43965278] 'agreement among raft nodes before linearized reading' (duration: 141.802119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:33.503702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:32.900672Z","time spent":"602.698841ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:35:33.503738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.323529ms","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-25T01:35:33.503753Z","caller":"traceutil/trace.go:171","msg":"trace[1537181115] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"155.374939ms","start":"2026-02-25T01:35:33.348374Z","end":"2026-02-25T01:35:33.503749Z","steps":["trace[1537181115] 'agreement among raft nodes before linearized reading' (duration: 155.340819ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:34.972147Z","caller":"traceutil/trace.go:171","msg":"trace[508928829] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"115.289659ms","start":"2026-02-25T01:35:34.856826Z","end":"2026-02-25T01:35:34.972116Z","steps":["trace[508928829] 'process raft request' (duration: 114.996087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:38.931712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.283066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:35:38.931836Z","caller":"traceutil/trace.go:171","msg":"trace[704352883] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"527.880235ms","start":"2026-02-25T01:35:38.403936Z","end":"2026-02-25T01:35:38.931816Z","steps":["trace[704352883] 'process raft request' (duration: 416.420218ms)","trace[704352883] 'compare' (duration: 111.128045ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:38.931892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:38.403922Z","time spent":"527.949276ms","remote":"127.0.0.1:44048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10217,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T01:35:38.932961Z","caller":"traceutil/trace.go:171","msg":"trace[260147535] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"447.219857ms","start":"2026-02-25T01:35:38.485728Z","end":"2026-02-25T01:35:38.932948Z","steps":["trace[260147535] 'process raft request' (duration: 446.873964ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:38.932941Z","caller":"traceutil/trace.go:171","msg":"trace[448123088] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"514.981843ms","start":"2026-02-25T01:35:38.417927Z","end":"2026-02-25T01:35:38.932909Z","steps":["trace[448123088] 'process raft request' (duration: 514.514179ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:38.933045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:38.485708Z","time spent":"447.297677ms","remote":"127.0.0.1:43592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317251,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:35:38.933107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:38.41791Z","time spent":"515.123774ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4155,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T01:35:39.140171Z","caller":"traceutil/trace.go:171","msg":"trace[1950548629] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"200.884707ms","start":"2026-02-25T01:35:38.939256Z","end":"2026-02-25T01:35:39.140141Z","steps":["trace[1950548629] 'process raft request' (duration: 116.905511ms)","trace[1950548629] 'compare' (duration: 83.694833ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:39.140197Z","caller":"traceutil/trace.go:171","msg":"trace[2026910251] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:465; }","duration":"178.875135ms","start":"2026-02-25T01:35:38.961298Z","end":"2026-02-25T01:35:39.140174Z","steps":["trace[2026910251] 'read index received' (duration: 57.277908ms)","trace[2026910251] 'applied index is now lower than readState.Index' (duration: 121.596257ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:39.14029Z","caller":"traceutil/trace.go:171","msg":"trace[1425395547] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"193.642921ms","start":"2026-02-25T01:35:38.946628Z","end":"2026-02-25T01:35:39.140271Z","steps":["trace[1425395547] 'process raft request' (duration: 193.43944ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.140293Z","caller":"traceutil/trace.go:171","msg":"trace[1307090572] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"193.137997ms","start":"2026-02-25T01:35:38.947119Z","end":"2026-02-25T01:35:39.140257Z","steps":["trace[1307090572] 'process raft request' (duration: 192.993026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:39.140353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.047806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:35:39.140381Z","caller":"traceutil/trace.go:171","msg":"trace[1345711820] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:452; }","duration":"179.108707ms","start":"2026-02-25T01:35:38.961265Z","end":"2026-02-25T01:35:39.140373Z","steps":["trace[1345711820] 'agreement among raft nodes before linearized reading' (duration: 179.053986ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:39.140876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.857106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329924"} {"level":"info","ts":"2026-02-25T01:35:39.140933Z","caller":"traceutil/trace.go:171","msg":"trace[253290668] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:452; }","duration":"105.962128ms","start":"2026-02-25T01:35:39.034955Z","end":"2026-02-25T01:35:39.140917Z","steps":["trace[253290668] 'agreement among raft nodes before linearized reading' (duration: 105.390434ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.303066Z","caller":"traceutil/trace.go:171","msg":"trace[943366482] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"154.74752ms","start":"2026-02-25T01:35:39.148297Z","end":"2026-02-25T01:35:39.303044Z","steps":["trace[943366482] 'process raft request' (duration: 146.9834ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.303427Z","caller":"traceutil/trace.go:171","msg":"trace[729355634] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"149.906979ms","start":"2026-02-25T01:35:39.15349Z","end":"2026-02-25T01:35:39.303397Z","steps":["trace[729355634] 'process raft request' (duration: 149.501367ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.303494Z","caller":"traceutil/trace.go:171","msg":"trace[623448198] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"149.808369ms","start":"2026-02-25T01:35:39.153677Z","end":"2026-02-25T01:35:39.303486Z","steps":["trace[623448198] 'process raft request' (duration: 149.566357ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.303464Z","caller":"traceutil/trace.go:171","msg":"trace[31955579] linearizableReadLoop","detail":"{readStateIndex:474; appliedIndex:469; }","duration":"142.446151ms","start":"2026-02-25T01:35:39.160992Z","end":"2026-02-25T01:35:39.303438Z","steps":["trace[31955579] 'read index received' (duration: 13.931679ms)","trace[31955579] 'applied index is now lower than readState.Index' (duration: 128.513372ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:39.303637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.626722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4313"} {"level":"info","ts":"2026-02-25T01:35:39.303694Z","caller":"traceutil/trace.go:171","msg":"trace[1103308997] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:458; }","duration":"142.710913ms","start":"2026-02-25T01:35:39.160969Z","end":"2026-02-25T01:35:39.30368Z","steps":["trace[1103308997] 'agreement among raft nodes before linearized reading' (duration: 142.546902ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.30375Z","caller":"traceutil/trace.go:171","msg":"trace[1786928338] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"142.646452ms","start":"2026-02-25T01:35:39.161079Z","end":"2026-02-25T01:35:39.303726Z","steps":["trace[1786928338] 'process raft request' (duration: 142.30899ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.303455Z","caller":"traceutil/trace.go:171","msg":"trace[933120921] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"142.471501ms","start":"2026-02-25T01:35:39.160971Z","end":"2026-02-25T01:35:39.303443Z","steps":["trace[933120921] 'process raft request' (duration: 142.374821ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.472461Z","caller":"traceutil/trace.go:171","msg":"trace[1363906153] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"160.791078ms","start":"2026-02-25T01:35:39.311651Z","end":"2026-02-25T01:35:39.472442Z","steps":["trace[1363906153] 'process raft request' (duration: 127.188343ms)","trace[1363906153] 'compare' (duration: 33.461234ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:39.472629Z","caller":"traceutil/trace.go:171","msg":"trace[677216803] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"160.694257ms","start":"2026-02-25T01:35:39.311929Z","end":"2026-02-25T01:35:39.472623Z","steps":["trace[677216803] 'read index received' (duration: 47.00604ms)","trace[677216803] 'applied index is now lower than readState.Index' (duration: 113.687687ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:39.472679Z","caller":"traceutil/trace.go:171","msg":"trace[2113042290] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"160.073203ms","start":"2026-02-25T01:35:39.312573Z","end":"2026-02-25T01:35:39.472647Z","steps":["trace[2113042290] 'process raft request' (duration: 159.828882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:39.472773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.831828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-62pwk\" ","response":"range_response_count:1 size:3615"} {"level":"info","ts":"2026-02-25T01:35:39.47279Z","caller":"traceutil/trace.go:171","msg":"trace[666573623] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-62pwk; range_end:; response_count:1; response_revision:461; }","duration":"160.881818ms","start":"2026-02-25T01:35:39.311904Z","end":"2026-02-25T01:35:39.472785Z","steps":["trace[666573623] 'agreement among raft nodes before linearized reading' (duration: 160.773967ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:39.472925Z","caller":"traceutil/trace.go:171","msg":"trace[415965817] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"110.174955ms","start":"2026-02-25T01:35:39.362726Z","end":"2026-02-25T01:35:39.472901Z","steps":["trace[415965817] 'process raft request' (duration: 109.876813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:39.473056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.710779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14247"} {"level":"info","ts":"2026-02-25T01:35:39.473108Z","caller":"traceutil/trace.go:171","msg":"trace[1511037595] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:462; }","duration":"157.792099ms","start":"2026-02-25T01:35:39.315301Z","end":"2026-02-25T01:35:39.473093Z","steps":["trace[1511037595] 'agreement among raft nodes before linearized reading' (duration: 157.551088ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:45.33949Z","caller":"traceutil/trace.go:171","msg":"trace[874741522] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"209.83475ms","start":"2026-02-25T01:35:45.129621Z","end":"2026-02-25T01:35:45.339456Z","steps":["trace[874741522] 'process raft request' (duration: 209.70419ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:48.025738Z","caller":"traceutil/trace.go:171","msg":"trace[1542856349] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"309.482002ms","start":"2026-02-25T01:35:47.716222Z","end":"2026-02-25T01:35:48.025704Z","steps":["trace[1542856349] 'read index received' (duration: 309.21811ms)","trace[1542856349] 'applied index is now lower than readState.Index' (duration: 262.232µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:35:48.025808Z","caller":"traceutil/trace.go:171","msg":"trace[890858054] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"368.612816ms","start":"2026-02-25T01:35:47.657155Z","end":"2026-02-25T01:35:48.025768Z","steps":["trace[890858054] 'process raft request' (duration: 368.319553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:48.025971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.739594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-25T01:35:48.025993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:47.657134Z","time spent":"368.764087ms","remote":"127.0.0.1:43700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:35:48.026057Z","caller":"traceutil/trace.go:171","msg":"trace[1668101168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"309.856285ms","start":"2026-02-25T01:35:47.716172Z","end":"2026-02-25T01:35:48.026028Z","steps":["trace[1668101168] 'agreement among raft nodes before linearized reading' (duration: 309.700904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:48.026102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:47.716152Z","time spent":"309.942295ms","remote":"127.0.0.1:43790","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-25T01:35:48.203499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.406058ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-25T01:35:48.203806Z","caller":"traceutil/trace.go:171","msg":"trace[1377402178] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"173.27913ms","start":"2026-02-25T01:35:48.030505Z","end":"2026-02-25T01:35:48.203784Z","steps":["trace[1377402178] 'process raft request' (duration: 173.120359ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:48.203798Z","caller":"traceutil/trace.go:171","msg":"trace[667476645] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"177.935228ms","start":"2026-02-25T01:35:48.025832Z","end":"2026-02-25T01:35:48.203768Z","steps":["trace[667476645] 'read index received' (duration: 24.258128ms)","trace[667476645] 'applied index is now lower than readState.Index' (duration: 153.67364ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:48.204537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.618672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:35:48.204414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.58684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T01:35:48.204673Z","caller":"traceutil/trace.go:171","msg":"trace[1937911534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"240.785864ms","start":"2026-02-25T01:35:47.963837Z","end":"2026-02-25T01:35:48.204623Z","steps":["trace[1937911534] 'agreement among raft nodes before linearized reading' (duration: 240.15369ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:48.204684Z","caller":"traceutil/trace.go:171","msg":"trace[1887638078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"464.893742ms","start":"2026-02-25T01:35:47.739752Z","end":"2026-02-25T01:35:48.204645Z","steps":["trace[1887638078] 'agreement among raft nodes before linearized reading' (duration: 464.123307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:48.204734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:47.739743Z","time spent":"464.979722ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T01:35:48.204761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.666693ms","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-25T01:35:48.204829Z","caller":"traceutil/trace.go:171","msg":"trace[599657028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"484.772844ms","start":"2026-02-25T01:35:47.720027Z","end":"2026-02-25T01:35:48.2048Z","steps":["trace[599657028] 'agreement among raft nodes before linearized reading' (duration: 483.899539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:48.204867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:47.720015Z","time spent":"484.843524ms","remote":"127.0.0.1:43790","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-25T01:35:48.205729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.344441ms","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-25T01:35:48.205815Z","caller":"traceutil/trace.go:171","msg":"trace[1890137530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"466.432071ms","start":"2026-02-25T01:35:47.739348Z","end":"2026-02-25T01:35:48.20578Z","steps":["trace[1890137530] 'agreement among raft nodes before linearized reading' (duration: 464.922902ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:48.206845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:47.739338Z","time spent":"467.433167ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T01:35:48.63865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.212017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:35:48.639054Z","caller":"traceutil/trace.go:171","msg":"trace[1821965432] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"427.706845ms","start":"2026-02-25T01:35:48.211297Z","end":"2026-02-25T01:35:48.639003Z","steps":["trace[1821965432] 'process raft request' (duration: 427.504784ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:48.639076Z","caller":"traceutil/trace.go:171","msg":"trace[663366542] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"427.907086ms","start":"2026-02-25T01:35:48.21105Z","end":"2026-02-25T01:35:48.638957Z","steps":["trace[663366542] 'process raft request' (duration: 197.224356ms)","trace[663366542] 'compare' (duration: 230.031546ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:48.639171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:48.211284Z","time spent":"427.817906ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:35:48.639245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:48.211028Z","time spent":"428.125217ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:35:49.419485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.457195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:35:49.419617Z","caller":"traceutil/trace.go:171","msg":"trace[1177331732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"455.630486ms","start":"2026-02-25T01:35:48.963963Z","end":"2026-02-25T01:35:49.419594Z","steps":["trace[1177331732] 'range keys from in-memory index tree' (duration: 455.381464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:49.419696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:48.963928Z","time spent":"455.753847ms","remote":"127.0.0.1:43478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:35:52.13071Z","caller":"traceutil/trace.go:171","msg":"trace[688536283] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"392.328477ms","start":"2026-02-25T01:35:51.738329Z","end":"2026-02-25T01:35:52.130658Z","steps":["trace[688536283] 'process raft request' (duration: 364.368928ms)","trace[688536283] 'compare' (duration: 27.656717ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:52.13089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:35:51.7383Z","time spent":"392.493348ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:35:52.131013Z","caller":"traceutil/trace.go:171","msg":"trace[1313073774] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"165.870759ms","start":"2026-02-25T01:35:51.964662Z","end":"2026-02-25T01:35:52.130533Z","steps":["trace[1313073774] 'read index received' (duration: 137.983291ms)","trace[1313073774] 'applied index is now lower than readState.Index' (duration: 27.886548ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:52.131087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.407882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:35:52.131148Z","caller":"traceutil/trace.go:171","msg":"trace[1207675507] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"166.527513ms","start":"2026-02-25T01:35:51.964604Z","end":"2026-02-25T01:35:52.131131Z","steps":["trace[1207675507] 'agreement among raft nodes before linearized reading' (duration: 166.409622ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:54.919739Z","caller":"traceutil/trace.go:171","msg":"trace[990120906] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"136.058329ms","start":"2026-02-25T01:35:54.783662Z","end":"2026-02-25T01:35:54.919721Z","steps":["trace[990120906] 'process raft request' (duration: 135.273572ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:36:08.960864Z","caller":"traceutil/trace.go:171","msg":"trace[2076483066] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"136.264363ms","start":"2026-02-25T01:36:08.824565Z","end":"2026-02-25T01:36:08.960829Z","steps":["trace[2076483066] 'process raft request' (duration: 134.035598ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:37:23.254802Z","caller":"traceutil/trace.go:171","msg":"trace[1392747400] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"555.448041ms","start":"2026-02-25T01:37:22.699324Z","end":"2026-02-25T01:37:23.254772Z","steps":["trace[1392747400] 'process raft request' (duration: 555.219887ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:37:23.254996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:37:22.699312Z","time spent":"555.588253ms","remote":"127.0.0.1:43790","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-25T01:37:23.265548Z","caller":"traceutil/trace.go:171","msg":"trace[1091971482] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1005; }","duration":"508.277366ms","start":"2026-02-25T01:37:22.757221Z","end":"2026-02-25T01:37:23.265499Z","steps":["trace[1091971482] 'read index received' (duration: 497.327294ms)","trace[1091971482] 'applied index is now lower than readState.Index' (duration: 10.948592ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:37:23.26584Z","caller":"traceutil/trace.go:171","msg":"trace[1950517080] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"565.995966ms","start":"2026-02-25T01:37:22.699828Z","end":"2026-02-25T01:37:23.265824Z","steps":["trace[1950517080] 'process raft request' (duration: 565.540638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:37:23.265966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:37:22.699812Z","time spent":"566.067068ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:37:23.26617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.52912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:37:23.266268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.049859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T01:37:23.266327Z","caller":"traceutil/trace.go:171","msg":"trace[1205952311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"302.688433ms","start":"2026-02-25T01:37:22.963559Z","end":"2026-02-25T01:37:23.266248Z","steps":["trace[1205952311] 'agreement among raft nodes before linearized reading' (duration: 302.52487ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:37:23.266332Z","caller":"traceutil/trace.go:171","msg":"trace[1773423196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"509.143571ms","start":"2026-02-25T01:37:22.757169Z","end":"2026-02-25T01:37:23.266313Z","steps":["trace[1773423196] 'agreement among raft nodes before linearized reading' (duration: 508.967298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:37:23.266382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:37:22.75715Z","time spent":"509.223022ms","remote":"127.0.0.1:43790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T01:37:23.266387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:37:22.963539Z","time spent":"302.832506ms","remote":"127.0.0.1:43484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:37:43.597648Z","caller":"traceutil/trace.go:171","msg":"trace[815259702] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1071; }","duration":"104.987936ms","start":"2026-02-25T01:37:43.492626Z","end":"2026-02-25T01:37:43.597613Z","steps":["trace[815259702] 'read index received' (duration: 28.618909ms)","trace[815259702] 'applied index is now lower than readState.Index' (duration: 76.368087ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:37:43.597798Z","caller":"traceutil/trace.go:171","msg":"trace[1091223575] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"106.6907ms","start":"2026-02-25T01:37:43.491094Z","end":"2026-02-25T01:37:43.597785Z","steps":["trace[1091223575] 'process raft request' (duration: 106.473387ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:37:43.597816Z","caller":"traceutil/trace.go:171","msg":"trace[641512265] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"107.017265ms","start":"2026-02-25T01:37:43.490761Z","end":"2026-02-25T01:37:43.597779Z","steps":["trace[641512265] 'process raft request' (duration: 102.397877ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:37:43.598046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.404511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4597"} {"level":"info","ts":"2026-02-25T01:37:43.598095Z","caller":"traceutil/trace.go:171","msg":"trace[594581405] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:1028; }","duration":"105.486602ms","start":"2026-02-25T01:37:43.492598Z","end":"2026-02-25T01:37:43.598085Z","steps":["trace[594581405] 'agreement among raft nodes before linearized reading' (duration: 105.35339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:37:43.598153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.157467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4068"} {"level":"info","ts":"2026-02-25T01:37:43.59826Z","caller":"traceutil/trace.go:171","msg":"trace[1009631036] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:1028; }","duration":"105.341479ms","start":"2026-02-25T01:37:43.492899Z","end":"2026-02-25T01:37:43.59824Z","steps":["trace[1009631036] 'agreement among raft nodes before linearized reading' (duration: 105.114816ms)"],"step_count":1}