{"level":"warn","ts":"2026-06-09T17:12:50.493997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T17:12:50.494071Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.59: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.19.213.59:2380","--initial-cluster=instance=https://199.19.213.59:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.59:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.59: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-06-09T17:12:50.494134Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T17:12:50.494143Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.59:2380"]} {"level":"info","ts":"2026-06-09T17:12:50.494165Z","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-06-09T17:12:50.494782Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.59:2379"]} {"level":"info","ts":"2026-06-09T17:12:50.494852Z","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.19.213.59:2380"],"listen-peer-urls":["https://199.19.213.59:2380"],"advertise-client-urls":["https://199.19.213.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.59: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-06-09T17:12:50.500113Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.871759ms"} {"level":"info","ts":"2026-06-09T17:12:50.514325Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"41c06612bf92f90","cluster-id":"7f792254ff9520b"} {"level":"info","ts":"2026-06-09T17:12:50.514425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T17:12:50.51445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became follower at term 0"} {"level":"info","ts":"2026-06-09T17:12:50.514463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 41c06612bf92f90 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T17:12:50.514487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became follower at term 1"} {"level":"info","ts":"2026-06-09T17:12:50.514528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 switched to configuration voters=(296118689918955408)"} {"level":"warn","ts":"2026-06-09T17:12:50.524555Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T17:12:50.527647Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T17:12:50.529047Z","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-06-09T17:12:50.532662Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"41c06612bf92f90","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T17:12:50.532838Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"41c06612bf92f90","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T17:12:50.532878Z","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-06-09T17:12:50.532937Z","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-06-09T17:12:50.532948Z","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-06-09T17:12:50.533817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 switched to configuration voters=(296118689918955408)"} {"level":"info","ts":"2026-06-09T17:12:50.533926Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7f792254ff9520b","local-member-id":"41c06612bf92f90","added-peer-id":"41c06612bf92f90","added-peer-peer-urls":["https://199.19.213.59:2380"]} {"level":"info","ts":"2026-06-09T17:12:50.53594Z","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-06-09T17:12:50.536115Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"41c06612bf92f90","initial-advertise-peer-urls":["https://199.19.213.59:2380"],"listen-peer-urls":["https://199.19.213.59:2380"],"advertise-client-urls":["https://199.19.213.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T17:12:50.536137Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T17:12:50.53735Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.59:2380"} {"level":"info","ts":"2026-06-09T17:12:50.537387Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.59:2380"} {"level":"info","ts":"2026-06-09T17:12:51.114971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T17:12:51.115054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T17:12:51.115077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 received MsgPreVoteResp from 41c06612bf92f90 at term 1"} {"level":"info","ts":"2026-06-09T17:12:51.115092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became candidate at term 2"} {"level":"info","ts":"2026-06-09T17:12:51.1151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 received MsgVoteResp from 41c06612bf92f90 at term 2"} {"level":"info","ts":"2026-06-09T17:12:51.115112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"41c06612bf92f90 became leader at term 2"} {"level":"info","ts":"2026-06-09T17:12:51.115122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 41c06612bf92f90 elected leader 41c06612bf92f90 at term 2"} {"level":"info","ts":"2026-06-09T17:12:51.119342Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:51.120835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:12:51.120863Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"41c06612bf92f90","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.59:2379]}","request-path":"/0/members/41c06612bf92f90/attributes","cluster-id":"7f792254ff9520b","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T17:12:51.1211Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:12:51.142397Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7f792254ff9520b","local-member-id":"41c06612bf92f90","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:51.142563Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T17:12:51.142816Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T17:12:51.142811Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:51.142908Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:12:51.143004Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.59:2379"} {"level":"info","ts":"2026-06-09T17:12:51.143966Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T17:13:08.616656Z","caller":"traceutil/trace.go:171","msg":"trace[576985711] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"193.928773ms","start":"2026-06-09T17:13:08.422703Z","end":"2026-06-09T17:13:08.616632Z","steps":["trace[576985711] 'read index received' (duration: 193.81742ms)","trace[576985711] 'applied index is now lower than readState.Index' (duration: 110.543µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:08.616851Z","caller":"traceutil/trace.go:171","msg":"trace[802163035] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"427.247467ms","start":"2026-06-09T17:13:08.189467Z","end":"2026-06-09T17:13:08.616714Z","steps":["trace[802163035] 'process raft request' (duration: 426.990511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:08.616998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.286372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T17:13:08.617066Z","caller":"traceutil/trace.go:171","msg":"trace[303305276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:371; }","duration":"194.405105ms","start":"2026-06-09T17:13:08.42265Z","end":"2026-06-09T17:13:08.617055Z","steps":["trace[303305276] 'agreement among raft nodes before linearized reading' (duration: 194.130728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:08.618089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:08.189432Z","time spent":"427.489883ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:13:08.931542Z","caller":"traceutil/trace.go:171","msg":"trace[1781765832] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"237.864915ms","start":"2026-06-09T17:13:08.693648Z","end":"2026-06-09T17:13:08.931513Z","steps":["trace[1781765832] 'read index received' (duration: 151.042186ms)","trace[1781765832] 'applied index is now lower than readState.Index' (duration: 86.821699ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:08.93163Z","caller":"traceutil/trace.go:171","msg":"trace[1426421327] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"310.61001ms","start":"2026-06-09T17:13:08.620986Z","end":"2026-06-09T17:13:08.931596Z","steps":["trace[1426421327] 'process raft request' (duration: 223.804551ms)","trace[1426421327] 'compare' (duration: 86.589193ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:08.931871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.308773ms","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-06-09T17:13:08.931949Z","caller":"traceutil/trace.go:171","msg":"trace[1527348525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:372; }","duration":"133.433926ms","start":"2026-06-09T17:13:08.798497Z","end":"2026-06-09T17:13:08.931931Z","steps":["trace[1527348525] 'agreement among raft nodes before linearized reading' (duration: 133.313553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:08.9319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.169332ms","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-06-09T17:13:08.932054Z","caller":"traceutil/trace.go:171","msg":"trace[1981272172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"238.435928ms","start":"2026-06-09T17:13:08.693602Z","end":"2026-06-09T17:13:08.932038Z","steps":["trace[1981272172] 'agreement among raft nodes before linearized reading' (duration: 238.165022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:08.932255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:08.620969Z","time spent":"310.890847ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:13:28.149604Z","caller":"traceutil/trace.go:171","msg":"trace[1322857968] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"327.949492ms","start":"2026-06-09T17:13:27.821632Z","end":"2026-06-09T17:13:28.149581Z","steps":["trace[1322857968] 'process raft request' (duration: 327.842099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.149823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.821613Z","time spent":"328.148747ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.159069Z","caller":"traceutil/trace.go:171","msg":"trace[319899282] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"337.184726ms","start":"2026-06-09T17:13:27.821869Z","end":"2026-06-09T17:13:28.159054Z","steps":["trace[319899282] 'process raft request' (duration: 337.042392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.159155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.821842Z","time spent":"337.270768ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.159173Z","caller":"traceutil/trace.go:171","msg":"trace[67699034] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"337.199096ms","start":"2026-06-09T17:13:27.821954Z","end":"2026-06-09T17:13:28.159153Z","steps":["trace[67699034] 'process raft request' (duration: 337.049342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.159275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.821946Z","time spent":"337.286258ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.15962Z","caller":"traceutil/trace.go:171","msg":"trace[1135643418] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"328.463365ms","start":"2026-06-09T17:13:27.831144Z","end":"2026-06-09T17:13:28.159608Z","steps":["trace[1135643418] 'process raft request' (duration: 327.939292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.159684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.831125Z","time spent":"328.530336ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.159796Z","caller":"traceutil/trace.go:171","msg":"trace[1288227775] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"326.280678ms","start":"2026-06-09T17:13:27.833498Z","end":"2026-06-09T17:13:28.159778Z","steps":["trace[1288227775] 'process raft request' (duration: 325.99019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.159887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.833486Z","time spent":"326.369911ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.160093Z","caller":"traceutil/trace.go:171","msg":"trace[1983192032] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"326.499073ms","start":"2026-06-09T17:13:27.833582Z","end":"2026-06-09T17:13:28.160081Z","steps":["trace[1983192032] 'process raft request' (duration: 325.991669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.160158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.833576Z","time spent":"326.556744ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.160224Z","caller":"traceutil/trace.go:171","msg":"trace[1222683249] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"326.306618ms","start":"2026-06-09T17:13:27.833889Z","end":"2026-06-09T17:13:28.160195Z","steps":["trace[1222683249] 'process raft request' (duration: 326.111432ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:28.160257Z","caller":"traceutil/trace.go:171","msg":"trace[18506738] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"325.741763ms","start":"2026-06-09T17:13:27.834496Z","end":"2026-06-09T17:13:28.160237Z","steps":["trace[18506738] 'process raft request' (duration: 325.548818ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:28.160354Z","caller":"traceutil/trace.go:171","msg":"trace[469849178] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"316.418147ms","start":"2026-06-09T17:13:27.843923Z","end":"2026-06-09T17:13:28.160341Z","steps":["trace[469849178] 'process raft request' (duration: 316.226082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.16037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.834476Z","time spent":"325.839236ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:13:28.160422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.843904Z","time spent":"316.489319ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T17:13:28.160397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.83388Z","time spent":"326.41612ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.160603Z","caller":"traceutil/trace.go:171","msg":"trace[1269531554] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"314.074015ms","start":"2026-06-09T17:13:27.846516Z","end":"2026-06-09T17:13:28.16059Z","steps":["trace[1269531554] 'process raft request' (duration: 313.679675ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:28.160712Z","caller":"traceutil/trace.go:171","msg":"trace[830628180] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"295.048403ms","start":"2026-06-09T17:13:27.86565Z","end":"2026-06-09T17:13:28.160699Z","steps":["trace[830628180] 'process raft request' (duration: 294.894409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:28.16077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:27.846505Z","time spent":"314.125876ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:28.160779Z","caller":"traceutil/trace.go:171","msg":"trace[267776126] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"188.428056ms","start":"2026-06-09T17:13:27.972336Z","end":"2026-06-09T17:13:28.160764Z","steps":["trace[267776126] 'process raft request' (duration: 188.339444ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:34.552956Z","caller":"traceutil/trace.go:171","msg":"trace[315484737] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"277.102449ms","start":"2026-06-09T17:13:34.275152Z","end":"2026-06-09T17:13:34.552255Z","steps":["trace[315484737] 'process raft request' (duration: 275.603999ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:34.566524Z","caller":"traceutil/trace.go:171","msg":"trace[1638589222] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"264.906207ms","start":"2026-06-09T17:13:34.3016Z","end":"2026-06-09T17:13:34.566506Z","steps":["trace[1638589222] 'process raft request' (duration: 264.756453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:34.98855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.669886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T17:13:34.988635Z","caller":"traceutil/trace.go:171","msg":"trace[719218129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"190.82128ms","start":"2026-06-09T17:13:34.797796Z","end":"2026-06-09T17:13:34.988617Z","steps":["trace[719218129] 'agreement among raft nodes before linearized reading' (duration: 190.643315ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:34.988328Z","caller":"traceutil/trace.go:171","msg":"trace[576619640] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"190.4216ms","start":"2026-06-09T17:13:34.797873Z","end":"2026-06-09T17:13:34.988295Z","steps":["trace[576619640] 'read index received' (duration: 113.578359ms)","trace[576619640] 'applied index is now lower than readState.Index' (duration: 76.841501ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:34.988406Z","caller":"traceutil/trace.go:171","msg":"trace[984012910] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"379.747801ms","start":"2026-06-09T17:13:34.608589Z","end":"2026-06-09T17:13:34.988336Z","steps":["trace[984012910] 'process raft request' (duration: 302.810728ms)","trace[984012910] 'compare' (duration: 76.638744ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:34.98939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:34.608574Z","time spent":"380.707795ms","remote":"127.0.0.1:34046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:35.218198Z","caller":"traceutil/trace.go:171","msg":"trace[1441974306] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"223.266197ms","start":"2026-06-09T17:13:34.994903Z","end":"2026-06-09T17:13:35.218169Z","steps":["trace[1441974306] 'read index received' (duration: 167.522055ms)","trace[1441974306] 'applied index is now lower than readState.Index' (duration: 55.743002ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:35.218476Z","caller":"traceutil/trace.go:171","msg":"trace[793191960] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"226.069622ms","start":"2026-06-09T17:13:34.992393Z","end":"2026-06-09T17:13:35.218463Z","steps":["trace[793191960] 'process raft request' (duration: 170.016981ms)","trace[793191960] 'compare' (duration: 55.497155ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:35.218566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.625746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-09T17:13:35.218652Z","caller":"traceutil/trace.go:171","msg":"trace[1067211439] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:594; }","duration":"223.75801ms","start":"2026-06-09T17:13:34.994874Z","end":"2026-06-09T17:13:35.218632Z","steps":["trace[1067211439] 'agreement among raft nodes before linearized reading' (duration: 223.560935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:35.226629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.631979ms","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-06-09T17:13:35.226677Z","caller":"traceutil/trace.go:171","msg":"trace[1127521683] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"122.718071ms","start":"2026-06-09T17:13:35.103948Z","end":"2026-06-09T17:13:35.226666Z","steps":["trace[1127521683] 'agreement among raft nodes before linearized reading' (duration: 122.631499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:35.227037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.431832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-09T17:13:35.226922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.291849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T17:13:35.227065Z","caller":"traceutil/trace.go:171","msg":"trace[1776883678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"170.496384ms","start":"2026-06-09T17:13:35.056563Z","end":"2026-06-09T17:13:35.227059Z","steps":["trace[1776883678] 'agreement among raft nodes before linearized reading' (duration: 170.446862ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:35.227199Z","caller":"traceutil/trace.go:171","msg":"trace[1195314080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"114.534205ms","start":"2026-06-09T17:13:35.112549Z","end":"2026-06-09T17:13:35.227084Z","steps":["trace[1195314080] 'agreement among raft nodes before linearized reading' (duration: 114.018502ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:35.227206Z","caller":"traceutil/trace.go:171","msg":"trace[100533090] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"221.458659ms","start":"2026-06-09T17:13:35.005738Z","end":"2026-06-09T17:13:35.227196Z","steps":["trace[100533090] 'process raft request' (duration: 220.72004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:35.732777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427413783895889723,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T17:13:36.335529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.70085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:13:36.335635Z","caller":"traceutil/trace.go:171","msg":"trace[1942558414] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.104088421s","start":"2026-06-09T17:13:35.231528Z","end":"2026-06-09T17:13:36.335617Z","steps":["trace[1942558414] 'process raft request' (duration: 744.078553ms)","trace[1942558414] 'compare' (duration: 359.584527ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:36.335698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:35.231517Z","time spent":"1.104153842s","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:13:36.376467Z","caller":"traceutil/trace.go:171","msg":"trace[964669218] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.144697303s","start":"2026-06-09T17:13:35.23174Z","end":"2026-06-09T17:13:36.376437Z","steps":["trace[964669218] 'process raft request' (duration: 1.144494198s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:36.376652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:35.23173Z","time spent":"1.144824868s","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:13:36.376828Z","caller":"traceutil/trace.go:171","msg":"trace[1838781092] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:621; }","duration":"1.145102364s","start":"2026-06-09T17:13:35.231675Z","end":"2026-06-09T17:13:36.376778Z","steps":["trace[1838781092] 'read index received' (duration: 743.96043ms)","trace[1838781092] 'applied index is now lower than readState.Index' (duration: 401.141094ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:36.376843Z","caller":"traceutil/trace.go:171","msg":"trace[612769262] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.145025502s","start":"2026-06-09T17:13:35.231791Z","end":"2026-06-09T17:13:36.376817Z","steps":["trace[612769262] 'process raft request' (duration: 1.144863218s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:36.376946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145256308s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:13:36.376987Z","caller":"traceutil/trace.go:171","msg":"trace[1349565774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.145350131s","start":"2026-06-09T17:13:35.231625Z","end":"2026-06-09T17:13:36.376975Z","steps":["trace[1349565774] 'agreement among raft nodes before linearized reading' (duration: 1.145274949s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:36.377018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:35.231603Z","time spent":"1.145408252s","remote":"127.0.0.1:33818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:13:36.377022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:35.231775Z","time spent":"1.145143636s","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:13:36.37745Z","caller":"traceutil/trace.go:171","msg":"trace[649654108] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.144899299s","start":"2026-06-09T17:13:35.23183Z","end":"2026-06-09T17:13:36.376729Z","steps":["trace[649654108] 'process raft request' (duration: 1.14453451s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:36.377898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:35.231715Z","time spent":"1.145998918s","remote":"127.0.0.1:33988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:13:38.15231Z","caller":"traceutil/trace.go:171","msg":"trace[1741337177] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"123.840631ms","start":"2026-06-09T17:13:38.028444Z","end":"2026-06-09T17:13:38.152285Z","steps":["trace[1741337177] 'process raft request' (duration: 123.617725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:51.566282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.830263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:13:51.566567Z","caller":"traceutil/trace.go:171","msg":"trace[378368693] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"346.678926ms","start":"2026-06-09T17:13:51.219862Z","end":"2026-06-09T17:13:51.566541Z","steps":["trace[378368693] 'read index received' (duration: 32.911µs)","trace[378368693] 'applied index is now lower than readState.Index' (duration: 346.643885ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:13:51.56677Z","caller":"traceutil/trace.go:171","msg":"trace[276187141] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"570.792165ms","start":"2026-06-09T17:13:50.995956Z","end":"2026-06-09T17:13:51.566749Z","steps":["trace[276187141] 'process raft request' (duration: 26.353546ms)","trace[276187141] 'compare' (duration: 543.582807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:13:51.566935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:50.995929Z","time spent":"570.947499ms","remote":"127.0.0.1:33988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:13:51.567163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.269942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:13:51.567262Z","caller":"traceutil/trace.go:171","msg":"trace[170281179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"347.421716ms","start":"2026-06-09T17:13:51.21982Z","end":"2026-06-09T17:13:51.567241Z","steps":["trace[170281179] 'agreement among raft nodes before linearized reading' (duration: 347.262822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:13:51.567252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.187876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-09T17:13:51.567309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:13:51.219799Z","time spent":"347.501887ms","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T17:13:51.567312Z","caller":"traceutil/trace.go:171","msg":"trace[1039019476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"287.284088ms","start":"2026-06-09T17:13:51.280013Z","end":"2026-06-09T17:13:51.567298Z","steps":["trace[1039019476] 'agreement among raft nodes before linearized reading' (duration: 287.085073ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:51.745928Z","caller":"traceutil/trace.go:171","msg":"trace[1633592576] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"174.376646ms","start":"2026-06-09T17:13:51.571522Z","end":"2026-06-09T17:13:51.745898Z","steps":["trace[1633592576] 'process raft request' (duration: 173.955785ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:20.055092Z","caller":"traceutil/trace.go:171","msg":"trace[1191338895] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"119.721223ms","start":"2026-06-09T17:14:19.93535Z","end":"2026-06-09T17:14:20.055071Z","steps":["trace[1191338895] 'process raft request' (duration: 108.557538ms)","trace[1191338895] 'compare' (duration: 11.053242ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:26.215509Z","caller":"traceutil/trace.go:171","msg":"trace[1788437773] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"260.618969ms","start":"2026-06-09T17:14:25.954869Z","end":"2026-06-09T17:14:26.215488Z","steps":["trace[1788437773] 'process raft request' (duration: 260.477986ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:14:26.215755Z","caller":"traceutil/trace.go:171","msg":"trace[1193763877] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1006; }","duration":"140.705452ms","start":"2026-06-09T17:14:26.075035Z","end":"2026-06-09T17:14:26.215741Z","steps":["trace[1193763877] 'read index received' (duration: 140.699131ms)","trace[1193763877] 'applied index is now lower than readState.Index' (duration: 5.12µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:26.215929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.885257ms","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-06-09T17:14:26.215968Z","caller":"traceutil/trace.go:171","msg":"trace[1744676346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"140.974238ms","start":"2026-06-09T17:14:26.074984Z","end":"2026-06-09T17:14:26.215958Z","steps":["trace[1744676346] 'agreement among raft nodes before linearized reading' (duration: 140.822074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:26.804567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.417488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:14:26.80464Z","caller":"traceutil/trace.go:171","msg":"trace[248574126] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"567.884959ms","start":"2026-06-09T17:14:26.236744Z","end":"2026-06-09T17:14:26.804629Z","steps":["trace[248574126] 'read index received' (duration: 104.356807ms)","trace[248574126] 'applied index is now lower than readState.Index' (duration: 463.527012ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:14:26.804731Z","caller":"traceutil/trace.go:171","msg":"trace[531019035] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"585.786279ms","start":"2026-06-09T17:14:26.218931Z","end":"2026-06-09T17:14:26.804717Z","steps":["trace[531019035] 'process raft request' (duration: 122.156385ms)","trace[531019035] 'compare' (duration: 463.267775ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:26.804781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:26.218909Z","time spent":"585.848511ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:14:26.804817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.048743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:26.804887Z","caller":"traceutil/trace.go:171","msg":"trace[254125156] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:968; }","duration":"568.162986ms","start":"2026-06-09T17:14:26.236708Z","end":"2026-06-09T17:14:26.804871Z","steps":["trace[254125156] 'agreement among raft nodes before linearized reading' (duration: 568.041983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:26.804922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:26.236693Z","time spent":"568.221058ms","remote":"127.0.0.1:34054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:14:26.807124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.454777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:26.807163Z","caller":"traceutil/trace.go:171","msg":"trace[448488853] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:969; }","duration":"553.500768ms","start":"2026-06-09T17:14:26.253652Z","end":"2026-06-09T17:14:26.807153Z","steps":["trace[448488853] 'agreement among raft nodes before linearized reading' (duration: 553.422076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:26.807179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:26.253609Z","time spent":"553.565909ms","remote":"127.0.0.1:34120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:14:26.807167Z","caller":"traceutil/trace.go:171","msg":"trace[417871793] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"524.051181ms","start":"2026-06-09T17:14:26.283096Z","end":"2026-06-09T17:14:26.807147Z","steps":["trace[417871793] 'process raft request' (duration: 523.902207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:26.807211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.172332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-09T17:14:26.80723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:26.283076Z","time spent":"524.127092ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:26.807258Z","caller":"traceutil/trace.go:171","msg":"trace[765131268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:969; }","duration":"212.264954ms","start":"2026-06-09T17:14:26.594981Z","end":"2026-06-09T17:14:26.807246Z","steps":["trace[765131268] 'agreement among raft nodes before linearized reading' (duration: 212.11942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:26.807246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.714289ms","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-06-09T17:14:26.807299Z","caller":"traceutil/trace.go:171","msg":"trace[2143025878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:969; }","duration":"204.789751ms","start":"2026-06-09T17:14:26.602497Z","end":"2026-06-09T17:14:26.807286Z","steps":["trace[2143025878] 'agreement among raft nodes before linearized reading' (duration: 204.584646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:26.80733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.784365ms","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-06-09T17:14:26.807369Z","caller":"traceutil/trace.go:171","msg":"trace[1694484533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:969; }","duration":"236.851547ms","start":"2026-06-09T17:14:26.570508Z","end":"2026-06-09T17:14:26.80736Z","steps":["trace[1694484533] 'agreement among raft nodes before linearized reading' (duration: 236.751034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:49.853668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.879386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:14:49.853826Z","caller":"traceutil/trace.go:171","msg":"trace[580237610] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"934.835945ms","start":"2026-06-09T17:14:48.918969Z","end":"2026-06-09T17:14:49.853805Z","steps":["trace[580237610] 'process raft request' (duration: 464.748734ms)","trace[580237610] 'compare' (duration: 469.773713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:49.853886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:48.918941Z","time spent":"934.917727ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:49.873302Z","caller":"traceutil/trace.go:171","msg":"trace[109444284] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"953.752803ms","start":"2026-06-09T17:14:48.919524Z","end":"2026-06-09T17:14:49.873276Z","steps":["trace[109444284] 'process raft request' (duration: 953.444395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:49.873464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:48.919504Z","time spent":"953.860965ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:49.873557Z","caller":"traceutil/trace.go:171","msg":"trace[2029630895] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"952.91593ms","start":"2026-06-09T17:14:48.920611Z","end":"2026-06-09T17:14:49.873527Z","steps":["trace[2029630895] 'process raft request' (duration: 952.475819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:49.873703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:48.920596Z","time spent":"953.024473ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:49.874008Z","caller":"traceutil/trace.go:171","msg":"trace[1892622423] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1084; }","duration":"655.029742ms","start":"2026-06-09T17:14:49.218966Z","end":"2026-06-09T17:14:49.873996Z","steps":["trace[1892622423] 'read index received' (duration: 164.769102ms)","trace[1892622423] 'applied index is now lower than readState.Index' (duration: 490.25986ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:14:49.87413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.169225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:49.874166Z","caller":"traceutil/trace.go:171","msg":"trace[1818398875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1045; }","duration":"655.240937ms","start":"2026-06-09T17:14:49.218915Z","end":"2026-06-09T17:14:49.874156Z","steps":["trace[1818398875] 'agreement among raft nodes before linearized reading' (duration: 655.144895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:49.874202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:49.218891Z","time spent":"655.305589ms","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T17:14:49.874248Z","caller":"traceutil/trace.go:171","msg":"trace[1850533712] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"952.763766ms","start":"2026-06-09T17:14:48.921459Z","end":"2026-06-09T17:14:49.874223Z","steps":["trace[1850533712] 'process raft request' (duration: 951.992036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:49.874366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:14:48.921449Z","time spent":"952.856179ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:14:51.115271Z","caller":"traceutil/trace.go:171","msg":"trace[1878067451] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"231.204121ms","start":"2026-06-09T17:14:50.884043Z","end":"2026-06-09T17:14:51.115247Z","steps":["trace[1878067451] 'process raft request' (duration: 231.010126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:52.385017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.280965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:52.385106Z","caller":"traceutil/trace.go:171","msg":"trace[183701488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1051; }","duration":"165.424719ms","start":"2026-06-09T17:14:52.21966Z","end":"2026-06-09T17:14:52.385085Z","steps":["trace[183701488] 'range keys from in-memory index tree' (duration: 165.188972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:14:52.385022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.137988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:14:52.385208Z","caller":"traceutil/trace.go:171","msg":"trace[1363982026] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1051; }","duration":"255.396655ms","start":"2026-06-09T17:14:52.129793Z","end":"2026-06-09T17:14:52.385189Z","steps":["trace[1363982026] 'count revisions from in-memory index tree' (duration: 255.008194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:07.72079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427413783895890940,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T17:15:07.975587Z","caller":"traceutil/trace.go:171","msg":"trace[2067020536] linearizableReadLoop","detail":"{readStateIndex:1200; appliedIndex:1199; }","duration":"755.487138ms","start":"2026-06-09T17:15:07.220081Z","end":"2026-06-09T17:15:07.975568Z","steps":["trace[2067020536] 'read index received' (duration: 755.300253ms)","trace[2067020536] 'applied index is now lower than readState.Index' (duration: 186.065µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:15:07.97565Z","caller":"traceutil/trace.go:171","msg":"trace[1087959476] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"791.152497ms","start":"2026-06-09T17:15:07.184465Z","end":"2026-06-09T17:15:07.975618Z","steps":["trace[1087959476] 'process raft request' (duration: 790.977023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:07.975741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.640453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:15:07.975805Z","caller":"traceutil/trace.go:171","msg":"trace[220886406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1151; }","duration":"755.738134ms","start":"2026-06-09T17:15:07.220052Z","end":"2026-06-09T17:15:07.97579Z","steps":["trace[220886406] 'agreement among raft nodes before linearized reading' (duration: 755.640712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:07.975803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:07.184442Z","time spent":"791.28234ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:15:07.975842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:07.220039Z","time spent":"755.795037ms","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:15:07.975832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.820428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:15:07.975922Z","caller":"traceutil/trace.go:171","msg":"trace[642067849] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1151; }","duration":"644.971032ms","start":"2026-06-09T17:15:07.33093Z","end":"2026-06-09T17:15:07.975901Z","steps":["trace[642067849] 'agreement among raft nodes before linearized reading' (duration: 644.809128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:07.975967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:07.330909Z","time spent":"645.048025ms","remote":"127.0.0.1:60790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:15:07.976182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.598729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:15:07.976227Z","caller":"traceutil/trace.go:171","msg":"trace[1307061837] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1151; }","duration":"274.679061ms","start":"2026-06-09T17:15:07.701537Z","end":"2026-06-09T17:15:07.976216Z","steps":["trace[1307061837] 'agreement among raft nodes before linearized reading' (duration: 274.61461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:24.894583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.144817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T17:15:24.894645Z","caller":"traceutil/trace.go:171","msg":"trace[624628291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1228; }","duration":"288.215589ms","start":"2026-06-09T17:15:24.606419Z","end":"2026-06-09T17:15:24.894634Z","steps":["trace[624628291] 'range keys from in-memory index tree' (duration: 287.942291ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:15:25.280197Z","caller":"traceutil/trace.go:171","msg":"trace[791456797] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"381.911459ms","start":"2026-06-09T17:15:24.898262Z","end":"2026-06-09T17:15:25.280173Z","steps":["trace[791456797] 'process raft request' (duration: 381.323294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:25.280321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:24.898247Z","time spent":"382.007511ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:15:26.254689Z","caller":"traceutil/trace.go:171","msg":"trace[1455115536] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1284; }","duration":"150.439665ms","start":"2026-06-09T17:15:26.104228Z","end":"2026-06-09T17:15:26.254668Z","steps":["trace[1455115536] 'read index received' (duration: 150.284831ms)","trace[1455115536] 'applied index is now lower than readState.Index' (duration: 153.944µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:15:26.25492Z","caller":"traceutil/trace.go:171","msg":"trace[322902124] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"181.850385ms","start":"2026-06-09T17:15:26.073058Z","end":"2026-06-09T17:15:26.254908Z","steps":["trace[322902124] 'process raft request' (duration: 181.503567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.25516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.917667ms","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-06-09T17:15:26.255197Z","caller":"traceutil/trace.go:171","msg":"trace[309111251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1232; }","duration":"150.993859ms","start":"2026-06-09T17:15:26.104194Z","end":"2026-06-09T17:15:26.255188Z","steps":["trace[309111251] 'agreement among raft nodes before linearized reading' (duration: 150.877146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.255539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.814498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T17:15:26.255624Z","caller":"traceutil/trace.go:171","msg":"trace[1796208876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1232; }","duration":"147.933382ms","start":"2026-06-09T17:15:26.107674Z","end":"2026-06-09T17:15:26.255607Z","steps":["trace[1796208876] 'agreement among raft nodes before linearized reading' (duration: 147.669665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.255777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.244482ms","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-06-09T17:15:26.255818Z","caller":"traceutil/trace.go:171","msg":"trace[1972102705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1232; }","duration":"125.293644ms","start":"2026-06-09T17:15:26.130513Z","end":"2026-06-09T17:15:26.255807Z","steps":["trace[1972102705] 'agreement among raft nodes before linearized reading' (duration: 125.202742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.255931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.28894ms","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-06-09T17:15:26.255973Z","caller":"traceutil/trace.go:171","msg":"trace[2089872208] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1232; }","duration":"128.358902ms","start":"2026-06-09T17:15:26.127603Z","end":"2026-06-09T17:15:26.255962Z","steps":["trace[2089872208] 'agreement among raft nodes before linearized reading' (duration: 128.255979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.634652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.283555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:15:26.63478Z","caller":"traceutil/trace.go:171","msg":"trace[2041348669] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"373.336718ms","start":"2026-06-09T17:15:26.261419Z","end":"2026-06-09T17:15:26.634756Z","steps":["trace[2041348669] 'process raft request' (duration: 176.867218ms)","trace[2041348669] 'compare' (duration: 195.993277ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:15:26.634871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:26.261399Z","time spent":"373.421069ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:15:26.760852Z","caller":"traceutil/trace.go:171","msg":"trace[1370703851] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"498.992151ms","start":"2026-06-09T17:15:26.261831Z","end":"2026-06-09T17:15:26.760823Z","steps":["trace[1370703851] 'process raft request' (duration: 483.518507ms)","trace[1370703851] 'compare' (duration: 15.242158ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:15:26.761021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:26.261823Z","time spent":"499.105874ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:15:26.761175Z","caller":"traceutil/trace.go:171","msg":"trace[1226271430] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"499.250848ms","start":"2026-06-09T17:15:26.261903Z","end":"2026-06-09T17:15:26.761154Z","steps":["trace[1226271430] 'process raft request' (duration: 498.872968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.761297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:26.261885Z","time spent":"499.34981ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:15:26.761174Z","caller":"traceutil/trace.go:171","msg":"trace[67398676] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"497.895883ms","start":"2026-06-09T17:15:26.263258Z","end":"2026-06-09T17:15:26.761154Z","steps":["trace[67398676] 'process raft request' (duration: 497.78923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:26.761429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:26.263238Z","time spent":"498.128028ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:15:27.39311Z","caller":"traceutil/trace.go:171","msg":"trace[88062920] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"105.651922ms","start":"2026-06-09T17:15:27.287438Z","end":"2026-06-09T17:15:27.39309Z","steps":["trace[88062920] 'process raft request' (duration: 105.481478ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:15:27.888927Z","caller":"traceutil/trace.go:171","msg":"trace[1720592708] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"409.610162ms","start":"2026-06-09T17:15:27.479292Z","end":"2026-06-09T17:15:27.888902Z","steps":["trace[1720592708] 'process raft request' (duration: 352.510047ms)","trace[1720592708] 'compare' (duration: 56.987642ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:15:27.88905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:27.479281Z","time spent":"409.696244ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:15:28.173578Z","caller":"traceutil/trace.go:171","msg":"trace[1695112256] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"279.584338ms","start":"2026-06-09T17:15:27.893973Z","end":"2026-06-09T17:15:28.173557Z","steps":["trace[1695112256] 'process raft request' (duration: 276.90668ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:15:28.173705Z","caller":"traceutil/trace.go:171","msg":"trace[933739687] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"233.975805ms","start":"2026-06-09T17:15:27.939699Z","end":"2026-06-09T17:15:28.173675Z","steps":["trace[933739687] 'process raft request' (duration: 233.925244ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:15:28.173931Z","caller":"traceutil/trace.go:171","msg":"trace[163346088] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"274.955749ms","start":"2026-06-09T17:15:27.898956Z","end":"2026-06-09T17:15:28.173911Z","steps":["trace[163346088] 'process raft request' (duration: 274.543268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.039566Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3427413783895891269,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T17:15:38.294581Z","caller":"traceutil/trace.go:171","msg":"trace[483318871] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1370; }","duration":"755.642943ms","start":"2026-06-09T17:15:37.538903Z","end":"2026-06-09T17:15:38.294546Z","steps":["trace[483318871] 'read index received' (duration: 755.629223ms)","trace[483318871] 'applied index is now lower than readState.Index' (duration: 10.98µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:15:38.294759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.840878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-09T17:15:38.294544Z","caller":"traceutil/trace.go:171","msg":"trace[850373468] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"863.205296ms","start":"2026-06-09T17:15:37.431304Z","end":"2026-06-09T17:15:38.29451Z","steps":["trace[850373468] 'process raft request' (duration: 862.99979ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:15:38.294826Z","caller":"traceutil/trace.go:171","msg":"trace[1802245192] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1315; }","duration":"755.946461ms","start":"2026-06-09T17:15:37.538862Z","end":"2026-06-09T17:15:38.294809Z","steps":["trace[1802245192] 'agreement among raft nodes before linearized reading' (duration: 755.758646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.294864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.538847Z","time spent":"756.006043ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-09T17:15:38.294933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.431285Z","time spent":"863.554764ms","remote":"127.0.0.1:34072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:15:38.296674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.966714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:15:38.296727Z","caller":"traceutil/trace.go:171","msg":"trace[860003240] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1316; }","duration":"742.042796ms","start":"2026-06-09T17:15:37.554662Z","end":"2026-06-09T17:15:38.296705Z","steps":["trace[860003240] 'agreement among raft nodes before linearized reading' (duration: 741.959584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.296762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.554647Z","time spent":"742.105248ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:15:38.296896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.339209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:15:38.296925Z","caller":"traceutil/trace.go:171","msg":"trace[1227641767] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1316; }","duration":"701.394011ms","start":"2026-06-09T17:15:37.595524Z","end":"2026-06-09T17:15:38.296918Z","steps":["trace[1227641767] 'agreement among raft nodes before linearized reading' (duration: 701.3485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.296944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.595512Z","time spent":"701.427582ms","remote":"127.0.0.1:34186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:15:38.296982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.837231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:15:38.297026Z","caller":"traceutil/trace.go:171","msg":"trace[1105928944] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1316; }","duration":"535.915143ms","start":"2026-06-09T17:15:37.761098Z","end":"2026-06-09T17:15:38.297013Z","steps":["trace[1105928944] 'agreement among raft nodes before linearized reading' (duration: 535.861981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.297053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.761076Z","time spent":"535.970724ms","remote":"127.0.0.1:34330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-09T17:15:38.297062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.933807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:15:38.296921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.197529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:15:38.297161Z","caller":"traceutil/trace.go:171","msg":"trace[1215621927] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1316; }","duration":"700.484517ms","start":"2026-06-09T17:15:37.596668Z","end":"2026-06-09T17:15:38.297153Z","steps":["trace[1215621927] 'agreement among raft nodes before linearized reading' (duration: 700.182949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.2972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.596658Z","time spent":"700.532308ms","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:15:38.297196Z","caller":"traceutil/trace.go:171","msg":"trace[2098122597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1316; }","duration":"688.05562ms","start":"2026-06-09T17:15:37.609094Z","end":"2026-06-09T17:15:38.29715Z","steps":["trace[2098122597] 'agreement among raft nodes before linearized reading' (duration: 687.919527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:15:38.297284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:15:37.609083Z","time spent":"688.187964ms","remote":"127.0.0.1:33804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T17:15:38.297413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.692736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-09T17:15:38.297515Z","caller":"traceutil/trace.go:171","msg":"trace[945893820] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1316; }","duration":"107.83374ms","start":"2026-06-09T17:15:38.189668Z","end":"2026-06-09T17:15:38.297502Z","steps":["trace[945893820] 'agreement among raft nodes before linearized reading' (duration: 106.973497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:19:26.225422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.344585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:19:26.225538Z","caller":"traceutil/trace.go:171","msg":"trace[1125314325] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2393; }","duration":"145.53677ms","start":"2026-06-09T17:19:26.079976Z","end":"2026-06-09T17:19:26.225512Z","steps":["trace[1125314325] 'count revisions from in-memory index tree' (duration: 145.210392ms)"],"step_count":1}