{"level":"warn","ts":"2026-07-25T14:19:50.282872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T14:19:50.282969Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-07-25T14:19:50.283363Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T14:19:50.28338Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-25T14:19:50.283399Z","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-07-25T14:19:50.284029Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-07-25T14:19:50.284098Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-07-25T14:19:50.286777Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.474697ms"} {"level":"info","ts":"2026-07-25T14:19:50.297302Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-07-25T14:19:50.297402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T14:19:50.297426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-07-25T14:19:50.297438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T14:19:50.297449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-07-25T14:19:50.297494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-07-25T14:19:50.30504Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T14:19:50.306746Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T14:19:50.308389Z","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-07-25T14:19:50.311133Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T14:19:50.313551Z","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-07-25T14:19:50.31374Z","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-07-25T14:19:50.313896Z","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-07-25T14:19:50.312936Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T14:19:50.314128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-07-25T14:19:50.315272Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-25T14:19:50.31579Z","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-07-25T14:19:50.316002Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T14:19:50.316026Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T14:19:50.316113Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-25T14:19:50.31613Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-25T14:19:51.19794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T14:19:51.19801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T14:19:51.198049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-07-25T14:19:51.19807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-07-25T14:19:51.198082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-25T14:19:51.198099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-07-25T14:19:51.19813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-25T14:19:51.19918Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T14:19:51.19925Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T14:19:51.1994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T14:19:51.199541Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T14:19:51.199583Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T14:19:51.199509Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T14:19:51.200989Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T14:19:51.201129Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T14:19:51.201204Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T14:19:51.202906Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T14:19:51.203698Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-07-25T14:20:41.923637Z","caller":"traceutil/trace.go:171","msg":"trace[1774880676] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"484.851073ms","start":"2026-07-25T14:20:41.438761Z","end":"2026-07-25T14:20:41.923612Z","steps":["trace[1774880676] 'read index received' (duration: 484.654237ms)","trace[1774880676] 'applied index is now lower than readState.Index' (duration: 195.856µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:20:41.923778Z","caller":"traceutil/trace.go:171","msg":"trace[1376669419] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"652.350139ms","start":"2026-07-25T14:20:41.271418Z","end":"2026-07-25T14:20:41.923768Z","steps":["trace[1376669419] 'process raft request' (duration: 652.02583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:20:41.924117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.167632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T14:20:41.924266Z","caller":"traceutil/trace.go:171","msg":"trace[1210360802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"404.342948ms","start":"2026-07-25T14:20:41.519894Z","end":"2026-07-25T14:20:41.924237Z","steps":["trace[1210360802] 'agreement among raft nodes before linearized reading' (duration: 404.145922ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:20:41.924283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.519371ms","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-07-25T14:20:41.924334Z","caller":"traceutil/trace.go:171","msg":"trace[36102852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:665; }","duration":"485.614844ms","start":"2026-07-25T14:20:41.438707Z","end":"2026-07-25T14:20:41.924322Z","steps":["trace[36102852] 'agreement among raft nodes before linearized reading' (duration: 485.48237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:20:41.924325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:20:41.519885Z","time spent":"404.42552ms","remote":"127.0.0.1:41866","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-07-25T14:20:41.924374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:20:41.438685Z","time spent":"485.681505ms","remote":"127.0.0.1:42138","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-07-25T14:20:41.924562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:20:41.271387Z","time spent":"652.415561ms","remote":"127.0.0.1:42030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T14:20:41.924616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.027653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-25T14:20:41.924692Z","caller":"traceutil/trace.go:171","msg":"trace[2091177782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:665; }","duration":"390.159596ms","start":"2026-07-25T14:20:41.534514Z","end":"2026-07-25T14:20:41.924673Z","steps":["trace[2091177782] 'agreement among raft nodes before linearized reading' (duration: 389.92202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:20:41.924736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:20:41.5345Z","time spent":"390.226988ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-25T14:20:56.844759Z","caller":"traceutil/trace.go:171","msg":"trace[146172343] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"325.193754ms","start":"2026-07-25T14:20:56.51954Z","end":"2026-07-25T14:20:56.844733Z","steps":["trace[146172343] 'read index received' (duration: 324.913786ms)","trace[146172343] 'applied index is now lower than readState.Index' (duration: 279.158µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:20:56.844912Z","caller":"traceutil/trace.go:171","msg":"trace[637790107] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"489.089715ms","start":"2026-07-25T14:20:56.355764Z","end":"2026-07-25T14:20:56.844854Z","steps":["trace[637790107] 'process raft request' (duration: 488.820038ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:20:56.844962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.400999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T14:20:56.845042Z","caller":"traceutil/trace.go:171","msg":"trace[886007320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"325.542463ms","start":"2026-07-25T14:20:56.519481Z","end":"2026-07-25T14:20:56.845023Z","steps":["trace[886007320] 'agreement among raft nodes before linearized reading' (duration: 325.384639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:20:56.845149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:20:56.519459Z","time spent":"325.625145ms","remote":"127.0.0.1:41866","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-07-25T14:20:56.845386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:20:56.355747Z","time spent":"489.250579ms","remote":"127.0.0.1:42030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T14:21:58.536248Z","caller":"traceutil/trace.go:171","msg":"trace[439404375] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1123; }","duration":"187.982013ms","start":"2026-07-25T14:21:58.348241Z","end":"2026-07-25T14:21:58.536224Z","steps":["trace[439404375] 'read index received' (duration: 187.800468ms)","trace[439404375] 'applied index is now lower than readState.Index' (duration: 180.845µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:21:58.536317Z","caller":"traceutil/trace.go:171","msg":"trace[1060471061] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"190.395349ms","start":"2026-07-25T14:21:58.345886Z","end":"2026-07-25T14:21:58.536282Z","steps":["trace[1060471061] 'process raft request' (duration: 190.220954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:21:58.53648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.21671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-25T14:21:58.536516Z","caller":"traceutil/trace.go:171","msg":"trace[698334165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1076; }","duration":"188.323973ms","start":"2026-07-25T14:21:58.348184Z","end":"2026-07-25T14:21:58.536508Z","steps":["trace[698334165] 'agreement among raft nodes before linearized reading' (duration: 188.176039ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:15.806665Z","caller":"traceutil/trace.go:171","msg":"trace[1730351944] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"151.475458ms","start":"2026-07-25T14:22:15.655162Z","end":"2026-07-25T14:22:15.806637Z","steps":["trace[1730351944] 'process raft request' (duration: 151.319934ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:15.841027Z","caller":"traceutil/trace.go:171","msg":"trace[1678642414] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"185.23705ms","start":"2026-07-25T14:22:15.655762Z","end":"2026-07-25T14:22:15.840999Z","steps":["trace[1678642414] 'process raft request' (duration: 185.053595ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:15.841399Z","caller":"traceutil/trace.go:171","msg":"trace[1538718117] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"183.951835ms","start":"2026-07-25T14:22:15.657418Z","end":"2026-07-25T14:22:15.841369Z","steps":["trace[1538718117] 'process raft request' (duration: 183.543824ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:15.8416Z","caller":"traceutil/trace.go:171","msg":"trace[720087906] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"134.603463ms","start":"2026-07-25T14:22:15.706987Z","end":"2026-07-25T14:22:15.841591Z","steps":["trace[720087906] 'process raft request' (duration: 134.284604ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:32.078791Z","caller":"traceutil/trace.go:171","msg":"trace[2037939074] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"200.935653ms","start":"2026-07-25T14:22:31.877809Z","end":"2026-07-25T14:22:32.078745Z","steps":["trace[2037939074] 'process raft request' (duration: 200.780329ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:32.090756Z","caller":"traceutil/trace.go:171","msg":"trace[213650332] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1311; }","duration":"171.54695ms","start":"2026-07-25T14:22:31.919187Z","end":"2026-07-25T14:22:32.090734Z","steps":["trace[213650332] 'read index received' (duration: 159.482654ms)","trace[213650332] 'applied index is now lower than readState.Index' (duration: 12.063636ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:22:32.090883Z","caller":"traceutil/trace.go:171","msg":"trace[1356406449] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"182.727242ms","start":"2026-07-25T14:22:31.908133Z","end":"2026-07-25T14:22:32.09086Z","steps":["trace[1356406449] 'process raft request' (duration: 182.497376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:32.090982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.780567ms","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-07-25T14:22:32.091008Z","caller":"traceutil/trace.go:171","msg":"trace[94949454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"171.872219ms","start":"2026-07-25T14:22:31.919128Z","end":"2026-07-25T14:22:32.091Z","steps":["trace[94949454] 'agreement among raft nodes before linearized reading' (duration: 171.729905ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:32.852213Z","caller":"traceutil/trace.go:171","msg":"trace[1391070389] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"120.627435ms","start":"2026-07-25T14:22:32.731548Z","end":"2026-07-25T14:22:32.852176Z","steps":["trace[1391070389] 'read index received' (duration: 120.210794ms)","trace[1391070389] 'applied index is now lower than readState.Index' (duration: 414.981µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:22:32.852286Z","caller":"traceutil/trace.go:171","msg":"trace[1756082316] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"211.570741ms","start":"2026-07-25T14:22:32.64069Z","end":"2026-07-25T14:22:32.852261Z","steps":["trace[1756082316] 'process raft request' (duration: 211.254682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:32.852468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.131282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T14:22:32.852518Z","caller":"traceutil/trace.go:171","msg":"trace[2099220053] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1260; }","duration":"120.214104ms","start":"2026-07-25T14:22:32.732288Z","end":"2026-07-25T14:22:32.852503Z","steps":["trace[2099220053] 'agreement among raft nodes before linearized reading' (duration: 120.06682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:32.852585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.001186ms","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-07-25T14:22:32.852657Z","caller":"traceutil/trace.go:171","msg":"trace[301371587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"121.13391ms","start":"2026-07-25T14:22:32.731505Z","end":"2026-07-25T14:22:32.852639Z","steps":["trace[301371587] 'agreement among raft nodes before linearized reading' (duration: 120.839822ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:32.852864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.525505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-25T14:22:32.852921Z","caller":"traceutil/trace.go:171","msg":"trace[557131262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1260; }","duration":"116.592217ms","start":"2026-07-25T14:22:32.736312Z","end":"2026-07-25T14:22:32.852904Z","steps":["trace[557131262] 'agreement among raft nodes before linearized reading' (duration: 116.402632ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:33.135995Z","caller":"traceutil/trace.go:171","msg":"trace[808828016] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"278.253771ms","start":"2026-07-25T14:22:32.857709Z","end":"2026-07-25T14:22:33.135962Z","steps":["trace[808828016] 'process raft request' (duration: 278.20445ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:33.136297Z","caller":"traceutil/trace.go:171","msg":"trace[1389685661] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"278.328652ms","start":"2026-07-25T14:22:32.857641Z","end":"2026-07-25T14:22:33.13597Z","steps":["trace[1389685661] 'process raft request' (duration: 278.231319ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:33.136063Z","caller":"traceutil/trace.go:171","msg":"trace[1963053552] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"279.008161ms","start":"2026-07-25T14:22:32.856979Z","end":"2026-07-25T14:22:33.135987Z","steps":["trace[1963053552] 'process raft request' (duration: 252.363431ms)","trace[1963053552] 'compare' (duration: 26.367672ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:22:33.276013Z","caller":"traceutil/trace.go:171","msg":"trace[402837] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"130.265086ms","start":"2026-07-25T14:22:33.145717Z","end":"2026-07-25T14:22:33.275982Z","steps":["trace[402837] 'process raft request' (duration: 110.41796ms)","trace[402837] 'compare' (duration: 19.717102ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:22:33.298599Z","caller":"traceutil/trace.go:171","msg":"trace[478170500] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"120.622725ms","start":"2026-07-25T14:22:33.177944Z","end":"2026-07-25T14:22:33.298567Z","steps":["trace[478170500] 'process raft request' (duration: 120.41807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:34.39899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.628379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T14:22:34.399098Z","caller":"traceutil/trace.go:171","msg":"trace[441766576] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1324; }","duration":"293.647806ms","start":"2026-07-25T14:22:34.105432Z","end":"2026-07-25T14:22:34.39908Z","steps":["trace[441766576] 'read index received' (duration: 68.5389ms)","trace[441766576] 'applied index is now lower than readState.Index' (duration: 225.107876ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:22:34.399157Z","caller":"traceutil/trace.go:171","msg":"trace[591593910] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"303.400449ms","start":"2026-07-25T14:22:34.095701Z","end":"2026-07-25T14:22:34.399101Z","steps":["trace[591593910] 'process raft request' (duration: 160.347878ms)","trace[591593910] 'compare' (duration: 142.494226ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T14:22:34.399279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.53214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T14:22:34.399281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.440291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-25T14:22:34.399313Z","caller":"traceutil/trace.go:171","msg":"trace[1591916779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1269; }","duration":"284.585611ms","start":"2026-07-25T14:22:34.114716Z","end":"2026-07-25T14:22:34.399302Z","steps":["trace[1591916779] 'agreement among raft nodes before linearized reading' (duration: 284.461747ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:34.399313Z","caller":"traceutil/trace.go:171","msg":"trace[541519550] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:1269; }","duration":"286.502383ms","start":"2026-07-25T14:22:34.112802Z","end":"2026-07-25T14:22:34.399305Z","steps":["trace[541519550] 'agreement among raft nodes before linearized reading' (duration: 286.369999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:34.399341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:34.09568Z","time spent":"303.560103ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T14:22:34.399538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.121528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-25T14:22:34.399565Z","caller":"traceutil/trace.go:171","msg":"trace[1356231225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1269; }","duration":"294.20174ms","start":"2026-07-25T14:22:34.105357Z","end":"2026-07-25T14:22:34.399558Z","steps":["trace[1356231225] 'agreement among raft nodes before linearized reading' (duration: 293.79989ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:35.026763Z","caller":"traceutil/trace.go:171","msg":"trace[1826248988] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"622.256765ms","start":"2026-07-25T14:22:34.404471Z","end":"2026-07-25T14:22:35.026728Z","steps":["trace[1826248988] 'process raft request' (duration: 622.021229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:35.026961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:34.40445Z","time spent":"622.404449ms","remote":"127.0.0.1:42138","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-07-25T14:22:35.026984Z","caller":"traceutil/trace.go:171","msg":"trace[1279477954] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"621.544396ms","start":"2026-07-25T14:22:34.405383Z","end":"2026-07-25T14:22:35.026927Z","steps":["trace[1279477954] 'process raft request' (duration: 621.301889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:35.027456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:34.405373Z","time spent":"621.742221ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T14:22:35.044807Z","caller":"traceutil/trace.go:171","msg":"trace[146722690] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"591.580087ms","start":"2026-07-25T14:22:34.453208Z","end":"2026-07-25T14:22:35.044789Z","steps":["trace[146722690] 'process raft request' (duration: 591.479234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:35.044897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:34.45316Z","time spent":"591.69348ms","remote":"127.0.0.1:41906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T14:22:39.282897Z","caller":"traceutil/trace.go:171","msg":"trace[495523181] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"233.078661ms","start":"2026-07-25T14:22:39.049792Z","end":"2026-07-25T14:22:39.282871Z","steps":["trace[495523181] 'process raft request' (duration: 232.885375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:40.075454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.916566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T14:22:40.075668Z","caller":"traceutil/trace.go:171","msg":"trace[1814584709] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"1.022066585s","start":"2026-07-25T14:22:39.053579Z","end":"2026-07-25T14:22:40.075646Z","steps":["trace[1814584709] 'process raft request' (duration: 565.855492ms)","trace[1814584709] 'compare' (duration: 455.786541ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T14:22:40.075729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.053564Z","time spent":"1.022141657s","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T14:22:40.075924Z","caller":"traceutil/trace.go:171","msg":"trace[1968200130] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"668.434351ms","start":"2026-07-25T14:22:39.407484Z","end":"2026-07-25T14:22:40.075919Z","steps":["trace[1968200130] 'process raft request' (duration: 668.141763ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:40.075921Z","caller":"traceutil/trace.go:171","msg":"trace[1385167617] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1370; }","duration":"917.540944ms","start":"2026-07-25T14:22:39.158364Z","end":"2026-07-25T14:22:40.075905Z","steps":["trace[1385167617] 'read index received' (duration: 124.392837ms)","trace[1385167617] 'applied index is now lower than readState.Index' (duration: 793.147147ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T14:22:40.075958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.407462Z","time spent":"668.479083ms","remote":"127.0.0.1:42138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T14:22:40.443608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.285216538s","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-07-25T14:22:40.443736Z","caller":"traceutil/trace.go:171","msg":"trace[1370265459] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1315; }","duration":"1.285428113s","start":"2026-07-25T14:22:39.158281Z","end":"2026-07-25T14:22:40.44371Z","steps":["trace[1370265459] 'agreement among raft nodes before linearized reading' (duration: 917.728749ms)","trace[1370265459] 'range keys from in-memory index tree' (duration: 367.409187ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T14:22:40.44379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.158248Z","time spent":"1.285522916s","remote":"127.0.0.1:42138","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-07-25T14:22:40.443945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.240099ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-25T14:22:40.444112Z","caller":"traceutil/trace.go:171","msg":"trace[951902727] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1373; }","duration":"368.136646ms","start":"2026-07-25T14:22:40.075952Z","end":"2026-07-25T14:22:40.444089Z","steps":["trace[951902727] 'read index received' (duration: 75.712µs)","trace[951902727] 'applied index is now lower than readState.Index' (duration: 368.058934ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T14:22:40.444137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.820174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T14:22:40.444172Z","caller":"traceutil/trace.go:171","msg":"trace[938892586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1315; }","duration":"923.893086ms","start":"2026-07-25T14:22:39.520268Z","end":"2026-07-25T14:22:40.444161Z","steps":["trace[938892586] 'agreement among raft nodes before linearized reading' (duration: 923.836835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:40.44421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.520256Z","time spent":"923.948667ms","remote":"127.0.0.1:41866","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-07-25T14:22:40.444298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153259276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T14:22:40.44434Z","caller":"traceutil/trace.go:171","msg":"trace[1696356807] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1315; }","duration":"1.153358749s","start":"2026-07-25T14:22:39.290967Z","end":"2026-07-25T14:22:40.444326Z","steps":["trace[1696356807] 'agreement among raft nodes before linearized reading' (duration: 1.153227125s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:40.444384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.290949Z","time spent":"1.153422521s","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-07-25T14:22:40.444474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.225368672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-t9ff6\" ","response":"range_response_count:1 size:12642"} {"level":"info","ts":"2026-07-25T14:22:40.444541Z","caller":"traceutil/trace.go:171","msg":"trace[1426358907] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-t9ff6; range_end:; response_count:1; response_revision:1315; }","duration":"1.225429354s","start":"2026-07-25T14:22:39.21909Z","end":"2026-07-25T14:22:40.444519Z","steps":["trace[1426358907] 'agreement among raft nodes before linearized reading' (duration: 1.225255239s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:40.444581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.219043Z","time spent":"1.225530046s","remote":"127.0.0.1:42030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12665,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-t9ff6\" "} {"level":"warn","ts":"2026-07-25T14:22:40.444596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.28568868s","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-07-25T14:22:40.444627Z","caller":"traceutil/trace.go:171","msg":"trace[524348034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1315; }","duration":"1.285782033s","start":"2026-07-25T14:22:39.158836Z","end":"2026-07-25T14:22:40.444618Z","steps":["trace[524348034] 'agreement among raft nodes before linearized reading' (duration: 1.28569363s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:40.444663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.158812Z","time spent":"1.285845385s","remote":"127.0.0.1:42138","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-07-25T14:22:40.444395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.660088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T14:22:40.444834Z","caller":"traceutil/trace.go:171","msg":"trace[888975446] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1315; }","duration":"692.149582ms","start":"2026-07-25T14:22:39.75267Z","end":"2026-07-25T14:22:40.444819Z","steps":["trace[888975446] 'agreement among raft nodes before linearized reading' (duration: 691.69312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T14:22:40.444874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T14:22:39.75264Z","time spent":"692.220183ms","remote":"127.0.0.1:48952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-07-25T14:22:40.447083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.175691ms","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-07-25T14:22:40.447242Z","caller":"traceutil/trace.go:171","msg":"trace[1637089670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1316; }","duration":"247.398358ms","start":"2026-07-25T14:22:40.199823Z","end":"2026-07-25T14:22:40.447222Z","steps":["trace[1637089670] 'agreement among raft nodes before linearized reading' (duration: 247.09361ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:50.641331Z","caller":"traceutil/trace.go:171","msg":"trace[1020120664] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"131.937191ms","start":"2026-07-25T14:22:50.509218Z","end":"2026-07-25T14:22:50.641155Z","steps":["trace[1020120664] 'process raft request' (duration: 131.836268ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T14:22:50.641504Z","caller":"traceutil/trace.go:171","msg":"trace[538428599] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"133.049491ms","start":"2026-07-25T14:22:50.508405Z","end":"2026-07-25T14:22:50.641455Z","steps":["trace[538428599] 'process raft request' (duration: 101.025507ms)","trace[538428599] 'compare' (duration: 31.421488ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T14:23:16.385642Z","caller":"traceutil/trace.go:171","msg":"trace[275303809] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"114.590258ms","start":"2026-07-25T14:23:16.27101Z","end":"2026-07-25T14:23:16.3856Z","steps":["trace[275303809] 'process raft request' (duration: 70.439154ms)","trace[275303809] 'compare' (duration: 44.01342ms)"],"step_count":2}