{"level":"warn","ts":"2026-02-01T18:51:01.684189Z","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-01T18:51:01.684277Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-01T18:51:01.684344Z","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-01T18:51:01.684353Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-02-01T18:51:01.68437Z","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-01T18:51:01.684897Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-02-01T18:51:01.684961Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-01T18:51:01.691601Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.436695ms"} {"level":"info","ts":"2026-02-01T18:51:01.742647Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-02-01T18:51:01.742858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-02-01T18:51:01.742931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-02-01T18:51:01.742991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-01T18:51:01.743037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-02-01T18:51:01.743112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-02-01T18:51:01.752323Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-01T18:51:01.755183Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-01T18:51:01.756902Z","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-01T18:51:01.759556Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-01T18:51:01.762028Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-01T18:51:01.76229Z","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-01T18:51:01.762601Z","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-01T18:51:01.762716Z","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-01T18:51:01.779131Z","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-01T18:51:01.779496Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-01T18:51:01.779514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-02-01T18:51:01.780232Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-02-01T18:51:01.779589Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-02-01T18:51:01.780867Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-02-01T18:51:01.780125Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-01T18:51:02.444054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-02-01T18:51:02.444093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-01T18:51:02.444115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-02-01T18:51:02.444128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-02-01T18:51:02.444134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-02-01T18:51:02.444143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-02-01T18:51:02.444154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-02-01T18:51:02.445049Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-01T18:51:02.44604Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-02-01T18:51:02.446196Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-01T18:51:02.446557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-01T18:51:02.446626Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-01T18:51:02.446692Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-01T18:51:02.44671Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-01T18:51:02.446743Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-01T18:51:02.44675Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-01T18:51:02.448326Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-01T18:51:02.448351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-02-01T18:51:30.699063Z","caller":"traceutil/trace.go:171","msg":"trace[1141782833] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"100.760299ms","start":"2026-02-01T18:51:30.598279Z","end":"2026-02-01T18:51:30.699039Z","steps":["trace[1141782833] 'process raft request' (duration: 100.274558ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:32.834668Z","caller":"traceutil/trace.go:171","msg":"trace[1259697273] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"102.748562ms","start":"2026-02-01T18:51:32.731898Z","end":"2026-02-01T18:51:32.834647Z","steps":["trace[1259697273] 'process raft request' (duration: 102.600549ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:32.837952Z","caller":"traceutil/trace.go:171","msg":"trace[809683330] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"105.677007ms","start":"2026-02-01T18:51:32.732247Z","end":"2026-02-01T18:51:32.837924Z","steps":["trace[809683330] 'process raft request' (duration: 105.278517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:32.841671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.837527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-01T18:51:32.841768Z","caller":"traceutil/trace.go:171","msg":"trace[722500691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"108.97793ms","start":"2026-02-01T18:51:32.732773Z","end":"2026-02-01T18:51:32.841751Z","steps":["trace[722500691] 'agreement among raft nodes before linearized reading' (duration: 108.789336ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:32.842203Z","caller":"traceutil/trace.go:171","msg":"trace[1611578012] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"104.911281ms","start":"2026-02-01T18:51:32.732794Z","end":"2026-02-01T18:51:32.837705Z","steps":["trace[1611578012] 'read index received' (duration: 101.847153ms)","trace[1611578012] 'applied index is now lower than readState.Index' (duration: 3.062808ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:51:32.842441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.062911ms","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-01T18:51:32.84248Z","caller":"traceutil/trace.go:171","msg":"trace[874530894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"109.127004ms","start":"2026-02-01T18:51:32.733343Z","end":"2026-02-01T18:51:32.84247Z","steps":["trace[874530894] 'agreement among raft nodes before linearized reading' (duration: 109.034552ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:41.050211Z","caller":"traceutil/trace.go:171","msg":"trace[1107098575] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"173.693144ms","start":"2026-02-01T18:51:40.876496Z","end":"2026-02-01T18:51:41.050189Z","steps":["trace[1107098575] 'process raft request' (duration: 173.417308ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:41.241164Z","caller":"traceutil/trace.go:171","msg":"trace[1570655375] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:545; }","duration":"345.753903ms","start":"2026-02-01T18:51:40.895384Z","end":"2026-02-01T18:51:41.241138Z","steps":["trace[1570655375] 'read index received' (duration: 154.607624ms)","trace[1570655375] 'applied index is now lower than readState.Index' (duration: 191.145029ms)"],"step_count":2} {"level":"info","ts":"2026-02-01T18:51:41.241502Z","caller":"traceutil/trace.go:171","msg":"trace[1033873585] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"362.812749ms","start":"2026-02-01T18:51:40.878675Z","end":"2026-02-01T18:51:41.241488Z","steps":["trace[1033873585] 'process raft request' (duration: 274.680588ms)","trace[1033873585] 'compare' (duration: 87.655691ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:51:41.242987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:40.878643Z","time spent":"362.888891ms","remote":"127.0.0.1:34380","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-01T18:51:41.243279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.888ms","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-01T18:51:41.243321Z","caller":"traceutil/trace.go:171","msg":"trace[1513532129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"347.946422ms","start":"2026-02-01T18:51:40.895366Z","end":"2026-02-01T18:51:41.243312Z","steps":["trace[1513532129] 'agreement among raft nodes before linearized reading' (duration: 347.81931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:41.243346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:40.895358Z","time spent":"347.982883ms","remote":"127.0.0.1:34380","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":"warn","ts":"2026-02-01T18:51:41.243439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.1946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-01T18:51:41.243456Z","caller":"traceutil/trace.go:171","msg":"trace[806668972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"344.245541ms","start":"2026-02-01T18:51:40.899205Z","end":"2026-02-01T18:51:41.243451Z","steps":["trace[806668972] 'agreement among raft nodes before linearized reading' (duration: 344.17945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:41.243472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:40.899199Z","time spent":"344.269472ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-01T18:51:42.860071Z","caller":"traceutil/trace.go:171","msg":"trace[1674378858] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"224.999985ms","start":"2026-02-01T18:51:42.635055Z","end":"2026-02-01T18:51:42.860055Z","steps":["trace[1674378858] 'process raft request' (duration: 224.898972ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:45.760875Z","caller":"traceutil/trace.go:171","msg":"trace[1592599362] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"116.112048ms","start":"2026-02-01T18:51:45.644728Z","end":"2026-02-01T18:51:45.76084Z","steps":["trace[1592599362] 'process raft request' (duration: 27.238791ms)","trace[1592599362] 'compare' (duration: 88.437808ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:51:59.917422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.126204ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-01T18:51:59.917517Z","caller":"traceutil/trace.go:171","msg":"trace[576853565] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:713; }","duration":"540.231286ms","start":"2026-02-01T18:51:59.377272Z","end":"2026-02-01T18:51:59.917504Z","steps":["trace[576853565] 'range keys from in-memory index tree' (duration: 540.114874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:59.917687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.344792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-01T18:51:59.917756Z","caller":"traceutil/trace.go:171","msg":"trace[1381360062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"566.431633ms","start":"2026-02-01T18:51:59.351307Z","end":"2026-02-01T18:51:59.917739Z","steps":["trace[1381360062] 'range keys from in-memory index tree' (duration: 566.293841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:59.917777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.207558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-01T18:51:59.917795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:59.351292Z","time spent":"566.495305ms","remote":"127.0.0.1:34104","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-01T18:51:59.917801Z","caller":"traceutil/trace.go:171","msg":"trace[1342998133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:713; }","duration":"492.250119ms","start":"2026-02-01T18:51:59.425544Z","end":"2026-02-01T18:51:59.917794Z","steps":["trace[1342998133] 'range keys from in-memory index tree' (duration: 492.093626ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:59.917847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:59.425533Z","time spent":"492.30763ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-01T18:51:59.918025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.546381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-01T18:51:59.918046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.688186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-psf75\" ","response":"range_response_count:1 size:18242"} {"level":"info","ts":"2026-02-01T18:51:59.918085Z","caller":"traceutil/trace.go:171","msg":"trace[737181078] range","detail":"{range_begin:/registry/pods/kube-system/cilium-psf75; range_end:; response_count:1; response_revision:713; }","duration":"139.764288ms","start":"2026-02-01T18:51:59.778314Z","end":"2026-02-01T18:51:59.918078Z","steps":["trace[737181078] 'range keys from in-memory index tree' (duration: 139.566173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:59.918128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.002508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-01T18:51:59.917425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.881463ms","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-01T18:51:59.918178Z","caller":"traceutil/trace.go:171","msg":"trace[1493589350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:713; }","duration":"554.0609ms","start":"2026-02-01T18:51:59.364109Z","end":"2026-02-01T18:51:59.91817Z","steps":["trace[1493589350] 'range keys from in-memory index tree' (duration: 553.929728ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:51:59.918198Z","caller":"traceutil/trace.go:171","msg":"trace[497411605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:713; }","duration":"552.694241ms","start":"2026-02-01T18:51:59.365496Z","end":"2026-02-01T18:51:59.91819Z","steps":["trace[497411605] 'range keys from in-memory index tree' (duration: 551.7157ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:59.918208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:59.364096Z","time spent":"554.105601ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-01T18:51:59.918218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:59.365489Z","time spent":"552.722041ms","remote":"127.0.0.1:34380","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-01T18:51:59.918059Z","caller":"traceutil/trace.go:171","msg":"trace[1534227091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:713; }","duration":"564.589913ms","start":"2026-02-01T18:51:59.353456Z","end":"2026-02-01T18:51:59.918046Z","steps":["trace[1534227091] 'range keys from in-memory index tree' (duration: 564.47419ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:51:59.918346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:59.35345Z","time spent":"564.888809ms","remote":"127.0.0.1:34380","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":"info","ts":"2026-02-01T18:52:02.05111Z","caller":"traceutil/trace.go:171","msg":"trace[869034039] linearizableReadLoop","detail":"{readStateIndex:747; appliedIndex:746; }","duration":"113.578471ms","start":"2026-02-01T18:52:01.937507Z","end":"2026-02-01T18:52:02.051086Z","steps":["trace[869034039] 'read index received' (duration: 113.391767ms)","trace[869034039] 'applied index is now lower than readState.Index' (duration: 185.784µs)"],"step_count":2} {"level":"info","ts":"2026-02-01T18:52:02.051386Z","caller":"traceutil/trace.go:171","msg":"trace[337213808] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"117.906817ms","start":"2026-02-01T18:52:01.933466Z","end":"2026-02-01T18:52:02.051373Z","steps":["trace[337213808] 'process raft request' (duration: 117.457937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:02.051647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.117033ms","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-01T18:52:02.051681Z","caller":"traceutil/trace.go:171","msg":"trace[718310780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:723; }","duration":"114.182724ms","start":"2026-02-01T18:52:01.937487Z","end":"2026-02-01T18:52:02.051669Z","steps":["trace[718310780] 'agreement among raft nodes before linearized reading' (duration: 114.057301ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:02.051851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.174309ms","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-01T18:52:02.051879Z","caller":"traceutil/trace.go:171","msg":"trace[2107600296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:723; }","duration":"111.215819ms","start":"2026-02-01T18:52:01.940655Z","end":"2026-02-01T18:52:02.05187Z","steps":["trace[2107600296] 'agreement among raft nodes before linearized reading' (duration: 111.139318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:02.052112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.083746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-01T18:52:02.052143Z","caller":"traceutil/trace.go:171","msg":"trace[802766612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:723; }","duration":"106.126867ms","start":"2026-02-01T18:52:01.946008Z","end":"2026-02-01T18:52:02.052135Z","steps":["trace[802766612] 'agreement among raft nodes before linearized reading' (duration: 106.048885ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:02.202948Z","caller":"traceutil/trace.go:171","msg":"trace[2002388377] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"140.419882ms","start":"2026-02-01T18:52:02.062512Z","end":"2026-02-01T18:52:02.202932Z","steps":["trace[2002388377] 'process raft request' (duration: 140.390291ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:02.203109Z","caller":"traceutil/trace.go:171","msg":"trace[89258937] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"143.600011ms","start":"2026-02-01T18:52:02.059493Z","end":"2026-02-01T18:52:02.203093Z","steps":["trace[89258937] 'process raft request' (duration: 118.696023ms)","trace[89258937] 'compare' (duration: 24.639593ms)"],"step_count":2} {"level":"info","ts":"2026-02-01T18:52:03.293971Z","caller":"traceutil/trace.go:171","msg":"trace[1220875626] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"117.556918ms","start":"2026-02-01T18:52:03.176396Z","end":"2026-02-01T18:52:03.293953Z","steps":["trace[1220875626] 'process raft request' (duration: 117.466006ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:18.456177Z","caller":"traceutil/trace.go:171","msg":"trace[1215750450] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"105.270875ms","start":"2026-02-01T18:52:18.350884Z","end":"2026-02-01T18:52:18.456155Z","steps":["trace[1215750450] 'read index received' (duration: 59.716064ms)","trace[1215750450] 'applied index is now lower than readState.Index' (duration: 45.554061ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:52:18.456285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.379927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-01T18:52:18.456309Z","caller":"traceutil/trace.go:171","msg":"trace[150752854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:778; }","duration":"105.442078ms","start":"2026-02-01T18:52:18.35086Z","end":"2026-02-01T18:52:18.456302Z","steps":["trace[150752854] 'agreement among raft nodes before linearized reading' (duration: 105.372807ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:18.456439Z","caller":"traceutil/trace.go:171","msg":"trace[644063210] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"115.626972ms","start":"2026-02-01T18:52:18.340793Z","end":"2026-02-01T18:52:18.45642Z","steps":["trace[644063210] 'process raft request' (duration: 69.854956ms)","trace[644063210] 'compare' (duration: 45.389848ms)"],"step_count":2} {"level":"info","ts":"2026-02-01T18:52:19.725359Z","caller":"traceutil/trace.go:171","msg":"trace[282598281] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"331.795435ms","start":"2026-02-01T18:52:19.393545Z","end":"2026-02-01T18:52:19.725341Z","steps":["trace[282598281] 'process raft request' (duration: 331.681402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:19.725485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:19.393534Z","time spent":"331.880467ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:21.84666Z","caller":"traceutil/trace.go:171","msg":"trace[1298255683] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"113.2672ms","start":"2026-02-01T18:52:21.733373Z","end":"2026-02-01T18:52:21.84664Z","steps":["trace[1298255683] 'process raft request' (duration: 113.141998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:22.479542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.244575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-01T18:52:22.481052Z","caller":"traceutil/trace.go:171","msg":"trace[1727100434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"358.779099ms","start":"2026-02-01T18:52:22.122231Z","end":"2026-02-01T18:52:22.48101Z","steps":["trace[1727100434] 'range keys from in-memory index tree' (duration: 357.069921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:22.481383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.231074ms","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-01T18:52:22.481873Z","caller":"traceutil/trace.go:171","msg":"trace[1464983017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"170.754666ms","start":"2026-02-01T18:52:22.311106Z","end":"2026-02-01T18:52:22.481861Z","steps":["trace[1464983017] 'range keys from in-memory index tree' (duration: 167.683628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:22.481467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:22.122208Z","time spent":"359.067905ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-01T18:52:22.481598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.618062ms","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-01T18:52:22.482641Z","caller":"traceutil/trace.go:171","msg":"trace[1529823598] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:784; }","duration":"287.687795ms","start":"2026-02-01T18:52:22.19494Z","end":"2026-02-01T18:52:22.482628Z","steps":["trace[1529823598] 'range keys from in-memory index tree' (duration: 286.52197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:22.481779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.549871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-01T18:52:22.482902Z","caller":"traceutil/trace.go:171","msg":"trace[1784670946] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:784; }","duration":"171.670985ms","start":"2026-02-01T18:52:22.311206Z","end":"2026-02-01T18:52:22.482877Z","steps":["trace[1784670946] 'range keys from in-memory index tree' (duration: 170.371757ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:22.695419Z","caller":"traceutil/trace.go:171","msg":"trace[237370193] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"207.290537ms","start":"2026-02-01T18:52:22.488104Z","end":"2026-02-01T18:52:22.695395Z","steps":["trace[237370193] 'process raft request' (duration: 207.134384ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:22.961785Z","caller":"traceutil/trace.go:171","msg":"trace[2137146939] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"471.16532ms","start":"2026-02-01T18:52:22.490597Z","end":"2026-02-01T18:52:22.961762Z","steps":["trace[2137146939] 'process raft request' (duration: 471.122009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:22.961948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:22.49059Z","time spent":"471.262092ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:22.962325Z","caller":"traceutil/trace.go:171","msg":"trace[575036973] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"474.117244ms","start":"2026-02-01T18:52:22.488194Z","end":"2026-02-01T18:52:22.962311Z","steps":["trace[575036973] 'process raft request' (duration: 385.322702ms)","trace[575036973] 'compare' (duration: 88.045496ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:52:22.962385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:22.488189Z","time spent":"474.163775ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:22.962671Z","caller":"traceutil/trace.go:171","msg":"trace[1557302816] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"472.860177ms","start":"2026-02-01T18:52:22.489803Z","end":"2026-02-01T18:52:22.962663Z","steps":["trace[1557302816] 'process raft request' (duration: 471.874385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:22.962711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:22.489796Z","time spent":"472.893608ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:35.131167Z","caller":"traceutil/trace.go:171","msg":"trace[876928154] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"373.940501ms","start":"2026-02-01T18:52:34.757143Z","end":"2026-02-01T18:52:35.131084Z","steps":["trace[876928154] 'process raft request' (duration: 373.511442ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:35.131374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:34.757134Z","time spent":"374.129585ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:35.517456Z","caller":"traceutil/trace.go:171","msg":"trace[977003170] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"383.046143ms","start":"2026-02-01T18:52:35.134393Z","end":"2026-02-01T18:52:35.517439Z","steps":["trace[977003170] 'process raft request' (duration: 285.811735ms)","trace[977003170] 'compare' (duration: 96.843259ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:52:35.517541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:35.134375Z","time spent":"383.121204ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:35.52266Z","caller":"traceutil/trace.go:171","msg":"trace[775185414] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"382.362206ms","start":"2026-02-01T18:52:35.140288Z","end":"2026-02-01T18:52:35.52265Z","steps":["trace[775185414] 'process raft request' (duration: 382.341516ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:35.522722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:35.140265Z","time spent":"382.425698ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:35.522888Z","caller":"traceutil/trace.go:171","msg":"trace[1546045380] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"387.52236ms","start":"2026-02-01T18:52:35.13536Z","end":"2026-02-01T18:52:35.522883Z","steps":["trace[1546045380] 'process raft request' (duration: 387.223614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:35.522916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:35.135347Z","time spent":"387.553221ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:41.671332Z","caller":"traceutil/trace.go:171","msg":"trace[1509425611] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"126.093193ms","start":"2026-02-01T18:52:41.545218Z","end":"2026-02-01T18:52:41.671311Z","steps":["trace[1509425611] 'read index received' (duration: 125.840237ms)","trace[1509425611] 'applied index is now lower than readState.Index' (duration: 252.296µs)"],"step_count":2} {"level":"info","ts":"2026-02-01T18:52:41.671429Z","caller":"traceutil/trace.go:171","msg":"trace[251190223] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"131.063452ms","start":"2026-02-01T18:52:41.540359Z","end":"2026-02-01T18:52:41.671422Z","steps":["trace[251190223] 'process raft request' (duration: 130.831337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:41.671861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.615584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-01T18:52:41.671833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.603712ms","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-01T18:52:41.671905Z","caller":"traceutil/trace.go:171","msg":"trace[2056369116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:889; }","duration":"126.695946ms","start":"2026-02-01T18:52:41.545201Z","end":"2026-02-01T18:52:41.671897Z","steps":["trace[2056369116] 'agreement among raft nodes before linearized reading' (duration: 126.505721ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:41.671953Z","caller":"traceutil/trace.go:171","msg":"trace[358246608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:889; }","duration":"125.806126ms","start":"2026-02-01T18:52:41.546118Z","end":"2026-02-01T18:52:41.671924Z","steps":["trace[358246608] 'agreement among raft nodes before linearized reading' (duration: 125.447888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:41.899699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.609503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-01T18:52:41.899823Z","caller":"traceutil/trace.go:171","msg":"trace[277561025] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"222.751728ms","start":"2026-02-01T18:52:41.677039Z","end":"2026-02-01T18:52:41.89979Z","steps":["trace[277561025] 'process raft request' (duration: 75.775446ms)","trace[277561025] 'compare' (duration: 146.47151ms)"],"step_count":2} {"level":"info","ts":"2026-02-01T18:52:41.936384Z","caller":"traceutil/trace.go:171","msg":"trace[593803254] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"259.247221ms","start":"2026-02-01T18:52:41.677115Z","end":"2026-02-01T18:52:41.936363Z","steps":["trace[593803254] 'process raft request' (duration: 258.878982ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:42.372468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.540803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-01T18:52:42.372752Z","caller":"traceutil/trace.go:171","msg":"trace[400816948] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"433.208885ms","start":"2026-02-01T18:52:41.939527Z","end":"2026-02-01T18:52:42.372736Z","steps":["trace[400816948] 'process raft request' (duration: 175.324904ms)","trace[400816948] 'compare' (duration: 257.457041ms)"],"step_count":2} {"level":"warn","ts":"2026-02-01T18:52:42.372786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:52:41.939512Z","time spent":"433.257055ms","remote":"127.0.0.1:34380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-01T18:52:47.85548Z","caller":"traceutil/trace.go:171","msg":"trace[1539309529] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"110.516209ms","start":"2026-02-01T18:52:47.744931Z","end":"2026-02-01T18:52:47.855447Z","steps":["trace[1539309529] 'process raft request' (duration: 110.303345ms)"],"step_count":1} {"level":"info","ts":"2026-02-01T18:52:49.97744Z","caller":"traceutil/trace.go:171","msg":"trace[350727786] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"113.169728ms","start":"2026-02-01T18:52:49.864255Z","end":"2026-02-01T18:52:49.977425Z","steps":["trace[350727786] 'process raft request' (duration: 112.993514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-01T18:52:50.197338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.32999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-01T18:52:50.197449Z","caller":"traceutil/trace.go:171","msg":"trace[1616146803] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"208.069076ms","start":"2026-02-01T18:52:49.98936Z","end":"2026-02-01T18:52:50.197429Z","steps":["trace[1616146803] 'process raft request' (duration: 74.55141ms)","trace[1616146803] 'compare' (duration: 133.093885ms)"],"step_count":2}