{"level":"warn","ts":"2026-06-24T17:17:27.235944Z","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-24T17:17:27.236028Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-24T17:17:27.236118Z","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-24T17:17:27.236135Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-24T17:17:27.23615Z","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-24T17:17:27.236758Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-06-24T17:17:27.236832Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-24T17:17:27.241407Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.384078ms"} {"level":"info","ts":"2026-06-24T17:17:27.247273Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-06-24T17:17:27.247326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T17:17:27.247343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-06-24T17:17:27.247363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T17:17:27.247369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-06-24T17:17:27.247397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-06-24T17:17:27.259909Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T17:17:27.262719Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T17:17:27.266317Z","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-24T17:17:27.269161Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T17:17:27.269467Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T17:17:27.269513Z","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-24T17:17:27.269623Z","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-24T17:17:27.26964Z","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-24T17:17:27.278152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-06-24T17:17:27.278266Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-24T17:17:27.279331Z","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-24T17:17:27.27949Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-24T17:17:27.27952Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-24T17:17:27.279751Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T17:17:27.279802Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T17:17:28.247985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T17:17:28.248041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T17:17:28.248063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-06-24T17:17:28.248081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-06-24T17:17:28.248092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-24T17:17:28.248108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-06-24T17:17:28.248122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-24T17:17:28.248834Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:17:28.249578Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T17:17:28.249642Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T17:17:28.249687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T17:17:28.249956Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T17:17:28.25002Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T17:17:28.251005Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:17:28.251099Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:17:28.251138Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:17:28.252146Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T17:17:28.253049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-06-24T17:17:30.911985Z","caller":"traceutil/trace.go:171","msg":"trace[1291443068] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"118.746748ms","start":"2026-06-24T17:17:30.793199Z","end":"2026-06-24T17:17:30.911946Z","steps":["trace[1291443068] 'process raft request' (duration: 87.140257ms)","trace[1291443068] 'compare' (duration: 31.448477ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:17:33.379677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.919409062s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:17:33.379948Z","caller":"traceutil/trace.go:171","msg":"trace[364904035] linearizableReadLoop","detail":"{readStateIndex:160; appliedIndex:159; }","duration":"2.169384657s","start":"2026-06-24T17:17:31.210546Z","end":"2026-06-24T17:17:33.37993Z","steps":["trace[364904035] 'read index received' (duration: 248.94161ms)","trace[364904035] 'applied index is now lower than readState.Index' (duration: 1.920441657s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:17:33.380107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.169528161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T17:17:33.380107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.776519827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:17:33.380042Z","caller":"traceutil/trace.go:171","msg":"trace[1635348197] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"2.462354816s","start":"2026-06-24T17:17:30.917604Z","end":"2026-06-24T17:17:33.379959Z","steps":["trace[1635348197] 'process raft request' (duration: 541.940779ms)","trace[1635348197] 'compare' (duration: 1.919223808s)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:17:33.380143Z","caller":"traceutil/trace.go:171","msg":"trace[1676764212] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:155; }","duration":"2.169637344s","start":"2026-06-24T17:17:31.210492Z","end":"2026-06-24T17:17:33.380129Z","steps":["trace[1676764212] 'agreement among raft nodes before linearized reading' (duration: 2.16952378s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:33.380154Z","caller":"traceutil/trace.go:171","msg":"trace[565884362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:155; }","duration":"1.776618539s","start":"2026-06-24T17:17:31.603522Z","end":"2026-06-24T17:17:33.38014Z","steps":["trace[565884362] 'agreement among raft nodes before linearized reading' (duration: 1.776526976s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:33.380181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:31.210467Z","time spent":"2.169703776s","remote":"127.0.0.1:60780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-06-24T17:17:33.380186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:31.603501Z","time spent":"1.776678361s","remote":"127.0.0.1:60632","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-06-24T17:17:33.380322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:30.917586Z","time spent":"2.462600432s","remote":"127.0.0.1:60982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:17:33.380546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.395333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:17:33.380583Z","caller":"traceutil/trace.go:171","msg":"trace[1397873497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:155; }","duration":"534.478044ms","start":"2026-06-24T17:17:32.846094Z","end":"2026-06-24T17:17:33.380572Z","steps":["trace[1397873497] 'agreement among raft nodes before linearized reading' (duration: 534.415923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:33.380567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.107813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:17:33.380703Z","caller":"traceutil/trace.go:171","msg":"trace[1290037966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:155; }","duration":"799.274267ms","start":"2026-06-24T17:17:32.581396Z","end":"2026-06-24T17:17:33.380671Z","steps":["trace[1290037966] 'agreement among raft nodes before linearized reading' (duration: 798.99986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:33.380763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:32.581317Z","time spent":"799.436471ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T17:17:33.380625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:32.84606Z","time spent":"534.552096ms","remote":"127.0.0.1:60632","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-06-24T17:17:34.245578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.157908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:17:34.245762Z","caller":"traceutil/trace.go:171","msg":"trace[841065882] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"860.778288ms","start":"2026-06-24T17:17:33.384924Z","end":"2026-06-24T17:17:34.245702Z","steps":["trace[841065882] 'process raft request' (duration: 530.389284ms)","trace[841065882] 'compare' (duration: 329.741568ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:17:34.245836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:33.384909Z","time spent":"860.901222ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:17:34.259818Z","caller":"traceutil/trace.go:171","msg":"trace[1534909862] linearizableReadLoop","detail":"{readStateIndex:164; appliedIndex:160; }","duration":"691.861459ms","start":"2026-06-24T17:17:33.567921Z","end":"2026-06-24T17:17:34.259782Z","steps":["trace[1534909862] 'read index received' (duration: 347.484918ms)","trace[1534909862] 'applied index is now lower than readState.Index' (duration: 344.375181ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:17:34.25997Z","caller":"traceutil/trace.go:171","msg":"trace[1555636974] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"874.762495ms","start":"2026-06-24T17:17:33.385193Z","end":"2026-06-24T17:17:34.259956Z","steps":["trace[1555636974] 'process raft request' (duration: 874.349974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:34.260198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:33.385175Z","time spent":"874.901018ms","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:17:34.260187Z","caller":"traceutil/trace.go:171","msg":"trace[489953268] transaction","detail":"{read_only:false; response_revision:159; number_of_response:1; }","duration":"873.430471ms","start":"2026-06-24T17:17:33.386725Z","end":"2026-06-24T17:17:34.260155Z","steps":["trace[489953268] 'process raft request' (duration: 873.005521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:34.260326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.389311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:17:34.260458Z","caller":"traceutil/trace.go:171","msg":"trace[640607543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:159; }","duration":"692.582417ms","start":"2026-06-24T17:17:33.567852Z","end":"2026-06-24T17:17:34.260434Z","steps":["trace[640607543] 'agreement among raft nodes before linearized reading' (duration: 692.351671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:34.260514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:33.567785Z","time spent":"692.7183ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T17:17:34.260641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:33.386711Z","time spent":"873.658157ms","remote":"127.0.0.1:60982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:17:34.261313Z","caller":"traceutil/trace.go:171","msg":"trace[1865256940] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"875.549594ms","start":"2026-06-24T17:17:33.385193Z","end":"2026-06-24T17:17:34.260743Z","steps":["trace[1865256940] 'process raft request' (duration: 874.496898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:34.261494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:33.38516Z","time spent":"876.269322ms","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:17:34.265034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.564127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:17:34.265097Z","caller":"traceutil/trace.go:171","msg":"trace[2117992131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:160; }","duration":"418.664898ms","start":"2026-06-24T17:17:33.846417Z","end":"2026-06-24T17:17:34.265082Z","steps":["trace[2117992131] 'agreement among raft nodes before linearized reading' (duration: 418.552605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:34.265133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:17:33.846383Z","time spent":"418.7431ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:17:34.26531Z","caller":"traceutil/trace.go:171","msg":"trace[1980105358] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"134.414495ms","start":"2026-06-24T17:17:34.130871Z","end":"2026-06-24T17:17:34.265285Z","steps":["trace[1980105358] 'process raft request' (duration: 133.978364ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:42.216432Z","caller":"traceutil/trace.go:171","msg":"trace[633083920] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"124.371308ms","start":"2026-06-24T17:17:42.092025Z","end":"2026-06-24T17:17:42.216396Z","steps":["trace[633083920] 'process raft request' (duration: 97.153884ms)","trace[633083920] 'compare' (duration: 27.104471ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:17:43.371702Z","caller":"traceutil/trace.go:171","msg":"trace[387948112] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"223.233124ms","start":"2026-06-24T17:17:43.148445Z","end":"2026-06-24T17:17:43.371678Z","steps":["trace[387948112] 'process raft request' (duration: 223.08285ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:59.981523Z","caller":"traceutil/trace.go:171","msg":"trace[1154097055] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"267.930229ms","start":"2026-06-24T17:17:59.713568Z","end":"2026-06-24T17:17:59.981499Z","steps":["trace[1154097055] 'read index received' (duration: 267.713113ms)","trace[1154097055] 'applied index is now lower than readState.Index' (duration: 216.246µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:17:59.981613Z","caller":"traceutil/trace.go:171","msg":"trace[1560991455] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"278.49095ms","start":"2026-06-24T17:17:59.703102Z","end":"2026-06-24T17:17:59.981593Z","steps":["trace[1560991455] 'process raft request' (duration: 278.262704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:59.981767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.143904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:17:59.982024Z","caller":"traceutil/trace.go:171","msg":"trace[998950373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:481; }","duration":"268.449923ms","start":"2026-06-24T17:17:59.713537Z","end":"2026-06-24T17:17:59.981987Z","steps":["trace[998950373] 'agreement among raft nodes before linearized reading' (duration: 268.087593ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:05.151481Z","caller":"traceutil/trace.go:171","msg":"trace[1015474037] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"244.510997ms","start":"2026-06-24T17:18:04.906944Z","end":"2026-06-24T17:18:05.151455Z","steps":["trace[1015474037] 'read index received' (duration: 244.352223ms)","trace[1015474037] 'applied index is now lower than readState.Index' (duration: 157.844µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:05.151635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.66788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T17:18:05.151675Z","caller":"traceutil/trace.go:171","msg":"trace[1860071505] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:493; }","duration":"244.757692ms","start":"2026-06-24T17:18:04.906906Z","end":"2026-06-24T17:18:05.151664Z","steps":["trace[1860071505] 'agreement among raft nodes before linearized reading' (duration: 244.66526ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:05.151671Z","caller":"traceutil/trace.go:171","msg":"trace[560686987] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"284.436904ms","start":"2026-06-24T17:18:04.867162Z","end":"2026-06-24T17:18:05.151599Z","steps":["trace[560686987] 'process raft request' (duration: 284.160177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:05.478691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:05.152476Z","time spent":"326.208467ms","remote":"127.0.0.1:60680","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-24T17:18:08.917013Z","caller":"traceutil/trace.go:171","msg":"trace[641188535] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"874.662218ms","start":"2026-06-24T17:18:08.042321Z","end":"2026-06-24T17:18:08.916983Z","steps":["trace[641188535] 'process raft request' (duration: 874.436223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:08.917516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.042299Z","time spent":"874.804622ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:09.718086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:09.131973Z","time spent":"586.103763ms","remote":"127.0.0.1:48900","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-24T17:18:10.117489Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.199995824s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T17:18:10.117999Z","caller":"traceutil/trace.go:171","msg":"trace[766640134] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.98556604s","start":"2026-06-24T17:18:08.132405Z","end":"2026-06-24T17:18:10.117971Z","steps":["trace[766640134] 'process raft request' (duration: 1.985343125s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.11812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.132386Z","time spent":"1.985679893s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118305Z","caller":"traceutil/trace.go:171","msg":"trace[333774452] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.972318082s","start":"2026-06-24T17:18:08.145957Z","end":"2026-06-24T17:18:10.118275Z","steps":["trace[333774452] 'process raft request' (duration: 1.971979293s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.118429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.145947Z","time spent":"1.972408005s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.11855Z","caller":"traceutil/trace.go:171","msg":"trace[130686899] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.985635222s","start":"2026-06-24T17:18:08.132905Z","end":"2026-06-24T17:18:10.11854Z","steps":["trace[130686899] 'process raft request' (duration: 1.984960536s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:10.118548Z","caller":"traceutil/trace.go:171","msg":"trace[166263139] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.96614051s","start":"2026-06-24T17:18:08.15238Z","end":"2026-06-24T17:18:10.11852Z","steps":["trace[166263139] 'process raft request' (duration: 1.96575141s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.118592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.132897Z","time spent":"1.985674483s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118571Z","caller":"traceutil/trace.go:171","msg":"trace[121769632] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:551; }","duration":"1.536406273s","start":"2026-06-24T17:18:08.582143Z","end":"2026-06-24T17:18:10.118549Z","steps":["trace[121769632] 'read index received' (duration: 334.663536ms)","trace[121769632] 'applied index is now lower than readState.Index' (duration: 1.201741947s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:10.118661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.152371Z","time spent":"1.966233372s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118669Z","caller":"traceutil/trace.go:171","msg":"trace[43562600] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.98072828s","start":"2026-06-24T17:18:08.137932Z","end":"2026-06-24T17:18:10.118661Z","steps":["trace[43562600] 'process raft request' (duration: 1.979967812s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:10.118686Z","caller":"traceutil/trace.go:171","msg":"trace[593502506] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.963153955s","start":"2026-06-24T17:18:08.155522Z","end":"2026-06-24T17:18:10.118676Z","steps":["trace[593502506] 'process raft request' (duration: 1.962698534s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.118711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.137923Z","time spent":"1.980767631s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118747Z","caller":"traceutil/trace.go:171","msg":"trace[1756554765] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.795786907s","start":"2026-06-24T17:18:08.322953Z","end":"2026-06-24T17:18:10.11874Z","steps":["trace[1756554765] 'process raft request' (duration: 1.795539261s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.11878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.322924Z","time spent":"1.795840939s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:18:10.118775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.155515Z","time spent":"1.963201837s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118825Z","caller":"traceutil/trace.go:171","msg":"trace[1786949740] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.953077016s","start":"2026-06-24T17:18:08.165741Z","end":"2026-06-24T17:18:10.118818Z","steps":["trace[1786949740] 'process raft request' (duration: 1.952527143s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.118844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.165711Z","time spent":"1.953122737s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118886Z","caller":"traceutil/trace.go:171","msg":"trace[1077034179] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.971299117s","start":"2026-06-24T17:18:08.147574Z","end":"2026-06-24T17:18:10.118873Z","steps":["trace[1077034179] 'process raft request' (duration: 1.970476587s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:10.118911Z","caller":"traceutil/trace.go:171","msg":"trace[2016814155] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.940798893s","start":"2026-06-24T17:18:08.178108Z","end":"2026-06-24T17:18:10.118907Z","steps":["trace[2016814155] 'process raft request' (duration: 1.940201569s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.118926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.147568Z","time spent":"1.971340198s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:18:10.118934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.178093Z","time spent":"1.940829673s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.118985Z","caller":"traceutil/trace.go:171","msg":"trace[1596196396] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.968443797s","start":"2026-06-24T17:18:08.150537Z","end":"2026-06-24T17:18:10.11898Z","steps":["trace[1596196396] 'process raft request' (duration: 1.967553925s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.119004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.150518Z","time spent":"1.968477277s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:10.119019Z","caller":"traceutil/trace.go:171","msg":"trace[2059992901] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.913828496s","start":"2026-06-24T17:18:08.205182Z","end":"2026-06-24T17:18:10.119011Z","steps":["trace[2059992901] 'process raft request' (duration: 1.91319443s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.119046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.205162Z","time spent":"1.913869827s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:18:10.288614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.706461459s","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-24T17:18:10.288674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044445897s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:10.288729Z","caller":"traceutil/trace.go:171","msg":"trace[1155304722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"1.706609763s","start":"2026-06-24T17:18:08.582093Z","end":"2026-06-24T17:18:10.288703Z","steps":["trace[1155304722] 'agreement among raft nodes before linearized reading' (duration: 1.536780493s)","trace[1155304722] 'range keys from in-memory index tree' (duration: 169.674537ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:10.28879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.574671549s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T17:18:10.288814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696857251s","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-24T17:18:10.288894Z","caller":"traceutil/trace.go:171","msg":"trace[1454793341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"1.574869624s","start":"2026-06-24T17:18:08.714001Z","end":"2026-06-24T17:18:10.28887Z","steps":["trace[1454793341] 'agreement among raft nodes before linearized reading' (duration: 1.404920081s)","trace[1454793341] 'range keys from in-memory index tree' (duration: 169.782338ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:10.288946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.71398Z","time spent":"1.574953446s","remote":"127.0.0.1:60644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:18:10.288954Z","caller":"traceutil/trace.go:171","msg":"trace[160207759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:546; }","duration":"1.696984194s","start":"2026-06-24T17:18:08.591924Z","end":"2026-06-24T17:18:10.288908Z","steps":["trace[160207759] 'agreement among raft nodes before linearized reading' (duration: 1.52697141s)","trace[160207759] 'range keys from in-memory index tree' (duration: 169.727917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:10.2888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.582078Z","time spent":"1.706708735s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T17:18:10.288808Z","caller":"traceutil/trace.go:171","msg":"trace[1650709055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"1.044631292s","start":"2026-06-24T17:18:09.244143Z","end":"2026-06-24T17:18:10.288774Z","steps":["trace[1650709055] 'agreement among raft nodes before linearized reading' (duration: 874.764991ms)","trace[1650709055] 'range keys from in-memory index tree' (duration: 169.691007ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:10.289077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:08.591912Z","time spent":"1.697087756s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T17:18:10.289091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:09.244119Z","time spent":"1.044955s","remote":"127.0.0.1:60632","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-06-24T17:18:10.288699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126128367s","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-24T17:18:10.28918Z","caller":"traceutil/trace.go:171","msg":"trace[731941134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"1.12666484s","start":"2026-06-24T17:18:09.162493Z","end":"2026-06-24T17:18:10.289158Z","steps":["trace[731941134] 'agreement among raft nodes before linearized reading' (duration: 956.42143ms)","trace[731941134] 'range keys from in-memory index tree' (duration: 169.704607ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:10.289248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:09.162473Z","time spent":"1.126758853s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T17:18:10.720045Z","caller":"traceutil/trace.go:171","msg":"trace[1766863841] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"590.675467ms","start":"2026-06-24T17:18:10.129347Z","end":"2026-06-24T17:18:10.720022Z","steps":["trace[1766863841] 'process raft request' (duration: 590.496583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:10.7202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.129319Z","time spent":"590.797529ms","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:12.067104Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.345151784s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T17:18:12.103757Z","caller":"traceutil/trace.go:171","msg":"trace[483852805] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.972864256s","start":"2026-06-24T17:18:10.130863Z","end":"2026-06-24T17:18:12.103727Z","steps":["trace[483852805] 'process raft request' (duration: 1.936488607s)","trace[483852805] 'compare' (duration: 35.695172ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:12.103807Z","caller":"traceutil/trace.go:171","msg":"trace[289317922] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.972857626s","start":"2026-06-24T17:18:10.130909Z","end":"2026-06-24T17:18:12.103767Z","steps":["trace[289317922] 'process raft request' (duration: 1.972744244s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:12.103895Z","caller":"traceutil/trace.go:171","msg":"trace[1351943468] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.971938273s","start":"2026-06-24T17:18:10.131928Z","end":"2026-06-24T17:18:12.103866Z","steps":["trace[1351943468] 'process raft request' (duration: 1.971790949s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.104005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.130905Z","time spent":"1.97301808s","remote":"127.0.0.1:32932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:18:12.104028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.13191Z","time spent":"1.972052405s","remote":"127.0.0.1:32932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:18:12.105138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.130848Z","time spent":"1.97302567s","remote":"127.0.0.1:32932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:12.105799Z","caller":"traceutil/trace.go:171","msg":"trace[961815065] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"1.967618736s","start":"2026-06-24T17:18:10.136645Z","end":"2026-06-24T17:18:12.104264Z","steps":["trace[961815065] 'process raft request' (duration: 1.967281178s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.105923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.136636Z","time spent":"1.969232126s","remote":"127.0.0.1:32932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:12.106459Z","caller":"traceutil/trace.go:171","msg":"trace[1215404344] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.969621986s","start":"2026-06-24T17:18:10.136811Z","end":"2026-06-24T17:18:12.106433Z","steps":["trace[1215404344] 'process raft request' (duration: 1.967161425s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:12.106515Z","caller":"traceutil/trace.go:171","msg":"trace[1766379668] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.972701392s","start":"2026-06-24T17:18:10.13367Z","end":"2026-06-24T17:18:12.106372Z","steps":["trace[1766379668] 'process raft request' (duration: 1.970136668s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.106545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.136804Z","time spent":"1.969691358s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:12.106595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.133655Z","time spent":"1.972901107s","remote":"127.0.0.1:32932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:12.105936Z","caller":"traceutil/trace.go:171","msg":"trace[136861986] transaction","detail":"{read_only:false; number_of_response:1; response_revision:550; }","duration":"1.973827269s","start":"2026-06-24T17:18:10.132091Z","end":"2026-06-24T17:18:12.105919Z","steps":["trace[136861986] 'process raft request' (duration: 1.971669366s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:12.107673Z","caller":"traceutil/trace.go:171","msg":"trace[984290816] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"1.968107878s","start":"2026-06-24T17:18:10.139549Z","end":"2026-06-24T17:18:12.107657Z","steps":["trace[984290816] 'process raft request' (duration: 1.964477579s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.107763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.139531Z","time spent":"1.96819325s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:12.107691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.132087Z","time spent":"1.975547362s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:18:12.108116Z","caller":"traceutil/trace.go:171","msg":"trace[104137498] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.973973523s","start":"2026-06-24T17:18:10.134121Z","end":"2026-06-24T17:18:12.108094Z","steps":["trace[104137498] 'process raft request' (duration: 1.969769569s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.108235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.134114Z","time spent":"1.974059296s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:18:12.109388Z","caller":"traceutil/trace.go:171","msg":"trace[1500955838] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.965694808s","start":"2026-06-24T17:18:10.143679Z","end":"2026-06-24T17:18:12.109374Z","steps":["trace[1500955838] 'process raft request' (duration: 1.960414077s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.109476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.143669Z","time spent":"1.965760641s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:18:12.109566Z","caller":"traceutil/trace.go:171","msg":"trace[384297860] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.934883297s","start":"2026-06-24T17:18:10.174643Z","end":"2026-06-24T17:18:12.109527Z","steps":["trace[384297860] 'process raft request' (duration: 1.934200959s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.109672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.174605Z","time spent":"1.93499061s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:12.109697Z","caller":"traceutil/trace.go:171","msg":"trace[257714598] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.811630129s","start":"2026-06-24T17:18:10.298052Z","end":"2026-06-24T17:18:12.109682Z","steps":["trace[257714598] 'process raft request' (duration: 1.811363492s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.109932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.298033Z","time spent":"1.811858434s","remote":"127.0.0.1:60900","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-06-24T17:18:12.110042Z","caller":"traceutil/trace.go:171","msg":"trace[1426708968] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"1.811904915s","start":"2026-06-24T17:18:10.298109Z","end":"2026-06-24T17:18:12.110014Z","steps":["trace[1426708968] 'process raft request' (duration: 1.811365132s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.110108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.298105Z","time spent":"1.811966077s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:18:12.110604Z","caller":"traceutil/trace.go:171","msg":"trace[1227033407] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"1.812053739s","start":"2026-06-24T17:18:10.298131Z","end":"2026-06-24T17:18:12.110184Z","steps":["trace[1227033407] 'process raft request' (duration: 1.811376662s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.111252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.298128Z","time spent":"1.812614922s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:18:12.165945Z","caller":"traceutil/trace.go:171","msg":"trace[12950814] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"1.646237128s","start":"2026-06-24T17:18:10.519683Z","end":"2026-06-24T17:18:12.165921Z","steps":["trace[12950814] 'process raft request' (duration: 1.645951031s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.166084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.519661Z","time spent":"1.646353421s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:18:12.166094Z","caller":"traceutil/trace.go:171","msg":"trace[1438735407] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.436996094s","start":"2026-06-24T17:18:10.729072Z","end":"2026-06-24T17:18:12.166068Z","steps":["trace[1438735407] 'process raft request' (duration: 1.436950313s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.166179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.867939591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:12.166238Z","caller":"traceutil/trace.go:171","msg":"trace[1646203974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"1.868027243s","start":"2026-06-24T17:18:10.2982Z","end":"2026-06-24T17:18:12.166227Z","steps":["trace[1646203974] 'agreement among raft nodes before linearized reading' (duration: 1.8679171s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:12.16607Z","caller":"traceutil/trace.go:171","msg":"trace[669752442] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:565; }","duration":"1.867800108s","start":"2026-06-24T17:18:10.298219Z","end":"2026-06-24T17:18:12.16602Z","steps":["trace[669752442] 'read index received' (duration: 421.783561ms)","trace[669752442] 'applied index is now lower than readState.Index' (duration: 1.446014947s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:12.166236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.729054Z","time spent":"1.437108407s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:12.166275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.298195Z","time spent":"1.868072474s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:18:12.16637Z","caller":"traceutil/trace.go:171","msg":"trace[64229948] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"1.437492376s","start":"2026-06-24T17:18:10.728699Z","end":"2026-06-24T17:18:12.166192Z","steps":["trace[64229948] 'process raft request' (duration: 1.437232729s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.166582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.728675Z","time spent":"1.437756123s","remote":"127.0.0.1:60696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:12.237348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.3159645s","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-24T17:18:12.237424Z","caller":"traceutil/trace.go:171","msg":"trace[656460213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:567; }","duration":"1.316084184s","start":"2026-06-24T17:18:10.921323Z","end":"2026-06-24T17:18:12.237408Z","steps":["trace[656460213] 'agreement among raft nodes before linearized reading' (duration: 1.315940061s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:12.237463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:10.921306Z","time spent":"1.316148247s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T17:18:12.414799Z","caller":"traceutil/trace.go:171","msg":"trace[198205919] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"151.695262ms","start":"2026-06-24T17:18:12.263077Z","end":"2026-06-24T17:18:12.414772Z","steps":["trace[198205919] 'process raft request' (duration: 77.747693ms)","trace[198205919] 'compare' (duration: 73.818616ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:12.419197Z","caller":"traceutil/trace.go:171","msg":"trace[1114559614] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"122.505829ms","start":"2026-06-24T17:18:12.296665Z","end":"2026-06-24T17:18:12.419171Z","steps":["trace[1114559614] 'process raft request' (duration: 122.384816ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:15.671921Z","caller":"traceutil/trace.go:171","msg":"trace[1612262353] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"113.069626ms","start":"2026-06-24T17:18:15.558829Z","end":"2026-06-24T17:18:15.671898Z","steps":["trace[1612262353] 'process raft request' (duration: 112.597965ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:15.86593Z","caller":"traceutil/trace.go:171","msg":"trace[1876413382] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"126.785447ms","start":"2026-06-24T17:18:15.739121Z","end":"2026-06-24T17:18:15.865906Z","steps":["trace[1876413382] 'process raft request' (duration: 30.69576ms)","trace[1876413382] 'compare' (duration: 95.87138ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:18.716462Z","caller":"traceutil/trace.go:171","msg":"trace[1919186243] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"143.605661ms","start":"2026-06-24T17:18:18.572823Z","end":"2026-06-24T17:18:18.716429Z","steps":["trace[1919186243] 'process raft request' (duration: 143.391156ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:19.074738Z","caller":"traceutil/trace.go:171","msg":"trace[240270736] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"340.483048ms","start":"2026-06-24T17:18:18.734227Z","end":"2026-06-24T17:18:19.07471Z","steps":["trace[240270736] 'process raft request' (duration: 339.932355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:19.074988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:18.734206Z","time spent":"340.615532ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:20.195512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.678697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:18:20.196056Z","caller":"traceutil/trace.go:171","msg":"trace[1722736920] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"950.114715ms","start":"2026-06-24T17:18:19.245925Z","end":"2026-06-24T17:18:20.196039Z","steps":["trace[1722736920] 'read index received' (duration: 318.348732ms)","trace[1722736920] 'applied index is now lower than readState.Index' (duration: 631.764273ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:20.196073Z","caller":"traceutil/trace.go:171","msg":"trace[1354850662] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.063227971s","start":"2026-06-24T17:18:19.132785Z","end":"2026-06-24T17:18:20.196013Z","steps":["trace[1354850662] 'process raft request' (duration: 431.509869ms)","trace[1354850662] 'compare' (duration: 630.510013ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:20.196276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.32975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:20.196389Z","caller":"traceutil/trace.go:171","msg":"trace[1999565708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"950.481533ms","start":"2026-06-24T17:18:19.245879Z","end":"2026-06-24T17:18:20.19636Z","steps":["trace[1999565708] 'agreement among raft nodes before linearized reading' (duration: 950.264958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:20.196443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:19.245861Z","time spent":"950.570376ms","remote":"127.0.0.1:60632","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-06-24T17:18:20.196284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:19.132765Z","time spent":"1.063484918s","remote":"127.0.0.1:60880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:18:20.196643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.356308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:20.196772Z","caller":"traceutil/trace.go:171","msg":"trace[160728679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"482.542084ms","start":"2026-06-24T17:18:19.714194Z","end":"2026-06-24T17:18:20.196736Z","steps":["trace[160728679] 'agreement among raft nodes before linearized reading' (duration: 482.366058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:20.197506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:19.714173Z","time spent":"483.315342ms","remote":"127.0.0.1:60644","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-06-24T17:18:20.812896Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151967568188516,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T17:18:21.313678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151967568188516,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T17:18:21.814699Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151967568188516,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T17:18:22.297808Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.01417686s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T17:18:22.381128Z","caller":"traceutil/trace.go:171","msg":"trace[163321711] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"2.106101363s","start":"2026-06-24T17:18:20.274997Z","end":"2026-06-24T17:18:22.381098Z","steps":["trace[163321711] 'process raft request' (duration: 2.022957228s)","trace[163321711] 'compare' (duration: 82.962771ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:22.381276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:20.27497Z","time spent":"2.106242907s","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:18:22.384392Z","caller":"traceutil/trace.go:171","msg":"trace[1419379127] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:675; }","duration":"2.072280077s","start":"2026-06-24T17:18:20.312081Z","end":"2026-06-24T17:18:22.384361Z","steps":["trace[1419379127] 'read index received' (duration: 1.985876681s)","trace[1419379127] 'applied index is now lower than readState.Index' (duration: 86.401426ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:22.384614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.670056602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:22.38465Z","caller":"traceutil/trace.go:171","msg":"trace[1435952597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"1.670186676s","start":"2026-06-24T17:18:20.714454Z","end":"2026-06-24T17:18:22.384641Z","steps":["trace[1435952597] 'agreement among raft nodes before linearized reading' (duration: 1.670083402s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:22.384683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:20.714433Z","time spent":"1.670243468s","remote":"127.0.0.1:60632","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-06-24T17:18:22.38492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.072650057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T17:18:22.385079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.197531ms","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-24T17:18:22.385112Z","caller":"traceutil/trace.go:171","msg":"trace[1464567796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"109.264743ms","start":"2026-06-24T17:18:22.27584Z","end":"2026-06-24T17:18:22.385104Z","steps":["trace[1464567796] 'agreement among raft nodes before linearized reading' (duration: 109.195251ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:22.385105Z","caller":"traceutil/trace.go:171","msg":"trace[944845347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:654; }","duration":"2.073046176s","start":"2026-06-24T17:18:20.312038Z","end":"2026-06-24T17:18:22.385084Z","steps":["trace[944845347] 'agreement among raft nodes before linearized reading' (duration: 2.07242035s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:22.385165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:20.312021Z","time spent":"2.073128628s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T17:18:22.385276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.591222ms","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-24T17:18:22.385329Z","caller":"traceutil/trace.go:171","msg":"trace[1512892949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"143.684764ms","start":"2026-06-24T17:18:22.241637Z","end":"2026-06-24T17:18:22.385322Z","steps":["trace[1512892949] 'agreement among raft nodes before linearized reading' (duration: 143.610052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:22.385014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.094294ms","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-24T17:18:22.38542Z","caller":"traceutil/trace.go:171","msg":"trace[20585072] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"108.515444ms","start":"2026-06-24T17:18:22.27689Z","end":"2026-06-24T17:18:22.385406Z","steps":["trace[20585072] 'agreement among raft nodes before linearized reading' (duration: 108.002502ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:24.36982Z","caller":"traceutil/trace.go:171","msg":"trace[185622306] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"126.57595ms","start":"2026-06-24T17:18:24.243201Z","end":"2026-06-24T17:18:24.369777Z","steps":["trace[185622306] 'read index received' (duration: 126.13192ms)","trace[185622306] 'applied index is now lower than readState.Index' (duration: 442.44µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:24.369851Z","caller":"traceutil/trace.go:171","msg":"trace[1928608388] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"134.100756ms","start":"2026-06-24T17:18:24.23571Z","end":"2026-06-24T17:18:24.369811Z","steps":["trace[1928608388] 'process raft request' (duration: 133.787389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:24.370035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.808156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-24T17:18:24.370296Z","caller":"traceutil/trace.go:171","msg":"trace[506988184] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:674; }","duration":"126.96715ms","start":"2026-06-24T17:18:24.24315Z","end":"2026-06-24T17:18:24.370117Z","steps":["trace[506988184] 'agreement among raft nodes before linearized reading' (duration: 126.706793ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:25.062768Z","caller":"traceutil/trace.go:171","msg":"trace[1543411701] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"170.21847ms","start":"2026-06-24T17:18:24.892525Z","end":"2026-06-24T17:18:25.062744Z","steps":["trace[1543411701] 'process raft request' (duration: 170.085326ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:25.066992Z","caller":"traceutil/trace.go:171","msg":"trace[1650990771] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"173.074181ms","start":"2026-06-24T17:18:24.893877Z","end":"2026-06-24T17:18:25.066952Z","steps":["trace[1650990771] 'process raft request' (duration: 172.741292ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:25.067033Z","caller":"traceutil/trace.go:171","msg":"trace[864835043] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"158.664424ms","start":"2026-06-24T17:18:24.908258Z","end":"2026-06-24T17:18:25.066923Z","steps":["trace[864835043] 'read index received' (duration: 154.491081ms)","trace[864835043] 'applied index is now lower than readState.Index' (duration: 4.171673ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:25.067317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.028863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T17:18:25.067364Z","caller":"traceutil/trace.go:171","msg":"trace[2146982356] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:692; }","duration":"159.141146ms","start":"2026-06-24T17:18:24.908211Z","end":"2026-06-24T17:18:25.067352Z","steps":["trace[2146982356] 'agreement among raft nodes before linearized reading' (duration: 158.929641ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:26.893791Z","caller":"traceutil/trace.go:171","msg":"trace[824981191] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"119.972157ms","start":"2026-06-24T17:18:26.773795Z","end":"2026-06-24T17:18:26.893767Z","steps":["trace[824981191] 'process raft request' (duration: 119.708591ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.662636Z","caller":"traceutil/trace.go:171","msg":"trace[48367789] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"147.789785ms","start":"2026-06-24T17:18:28.514833Z","end":"2026-06-24T17:18:28.662622Z","steps":["trace[48367789] 'process raft request' (duration: 147.521608ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.662517Z","caller":"traceutil/trace.go:171","msg":"trace[449295608] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:769; }","duration":"124.488259ms","start":"2026-06-24T17:18:28.538003Z","end":"2026-06-24T17:18:28.662491Z","steps":["trace[449295608] 'read index received' (duration: 41.049175ms)","trace[449295608] 'applied index is now lower than readState.Index' (duration: 83.438214ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:28.662931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.9189ms","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-24T17:18:28.663062Z","caller":"traceutil/trace.go:171","msg":"trace[1425899580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:747; }","duration":"125.088785ms","start":"2026-06-24T17:18:28.537952Z","end":"2026-06-24T17:18:28.663041Z","steps":["trace[1425899580] 'agreement among raft nodes before linearized reading' (duration: 124.813888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:28.685451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.95404ms","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-06-24T17:18:28.685563Z","caller":"traceutil/trace.go:171","msg":"trace[2125788231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:748; }","duration":"146.086593ms","start":"2026-06-24T17:18:28.539452Z","end":"2026-06-24T17:18:28.685539Z","steps":["trace[2125788231] 'agreement among raft nodes before linearized reading' (duration: 145.826537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:28.685625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.908426ms","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":"warn","ts":"2026-06-24T17:18:28.685492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.532485ms","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-24T17:18:28.685678Z","caller":"traceutil/trace.go:171","msg":"trace[1445079668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:748; }","duration":"140.953777ms","start":"2026-06-24T17:18:28.544693Z","end":"2026-06-24T17:18:28.685647Z","steps":["trace[1445079668] 'agreement among raft nodes before linearized reading' (duration: 140.850154ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.685687Z","caller":"traceutil/trace.go:171","msg":"trace[991602051] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:748; }","duration":"144.7536ms","start":"2026-06-24T17:18:28.540923Z","end":"2026-06-24T17:18:28.685676Z","steps":["trace[991602051] 'agreement among raft nodes before linearized reading' (duration: 144.460053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:28.685856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.558131ms","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-24T17:18:28.685885Z","caller":"traceutil/trace.go:171","msg":"trace[1091051992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:748; }","duration":"141.607423ms","start":"2026-06-24T17:18:28.544268Z","end":"2026-06-24T17:18:28.685876Z","steps":["trace[1091051992] 'agreement among raft nodes before linearized reading' (duration: 141.534421ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.79142Z","caller":"traceutil/trace.go:171","msg":"trace[1249903904] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"124.040139ms","start":"2026-06-24T17:18:28.667355Z","end":"2026-06-24T17:18:28.791395Z","steps":["trace[1249903904] 'process raft request' (duration: 101.114771ms)","trace[1249903904] 'compare' (duration: 22.823264ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:28.844627Z","caller":"traceutil/trace.go:171","msg":"trace[62187643] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"155.240911ms","start":"2026-06-24T17:18:28.689368Z","end":"2026-06-24T17:18:28.844609Z","steps":["trace[62187643] 'process raft request' (duration: 155.077346ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.844665Z","caller":"traceutil/trace.go:171","msg":"trace[1045805747] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"154.207685ms","start":"2026-06-24T17:18:28.690434Z","end":"2026-06-24T17:18:28.844642Z","steps":["trace[1045805747] 'process raft request' (duration: 154.109952ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.84488Z","caller":"traceutil/trace.go:171","msg":"trace[753524611] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"154.346918ms","start":"2026-06-24T17:18:28.690523Z","end":"2026-06-24T17:18:28.84487Z","steps":["trace[753524611] 'process raft request' (duration: 154.085152ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.845025Z","caller":"traceutil/trace.go:171","msg":"trace[983148423] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"154.001099ms","start":"2026-06-24T17:18:28.691007Z","end":"2026-06-24T17:18:28.845008Z","steps":["trace[983148423] 'process raft request' (duration: 153.818865ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.845096Z","caller":"traceutil/trace.go:171","msg":"trace[875658709] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"152.745098ms","start":"2026-06-24T17:18:28.692336Z","end":"2026-06-24T17:18:28.845081Z","steps":["trace[875658709] 'process raft request' (duration: 152.617125ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:28.845259Z","caller":"traceutil/trace.go:171","msg":"trace[1139602590] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"152.914662ms","start":"2026-06-24T17:18:28.692337Z","end":"2026-06-24T17:18:28.845252Z","steps":["trace[1139602590] 'process raft request' (duration: 152.713897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.16304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.500746062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vjtkd\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-24T17:18:39.163128Z","caller":"traceutil/trace.go:171","msg":"trace[521462330] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vjtkd; range_end:; response_count:1; response_revision:815; }","duration":"1.500888416s","start":"2026-06-24T17:18:37.66222Z","end":"2026-06-24T17:18:39.163108Z","steps":["trace[521462330] 'range keys from in-memory index tree' (duration: 1.500587479s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.163428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448995142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:39.16349Z","caller":"traceutil/trace.go:171","msg":"trace[994761154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"1.449103504s","start":"2026-06-24T17:18:37.714369Z","end":"2026-06-24T17:18:39.163473Z","steps":["trace[994761154] 'range keys from in-memory index tree' (duration: 1.44890877s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.163533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:37.714348Z","time spent":"1.449173367s","remote":"127.0.0.1:60632","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-06-24T17:18:39.1634Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.012676773s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T17:18:39.163825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:37.662203Z","time spent":"1.500955968s","remote":"127.0.0.1:60822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vjtkd\" "} {"level":"info","ts":"2026-06-24T17:18:39.164081Z","caller":"traceutil/trace.go:171","msg":"trace[1030403360] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"1.013461293s","start":"2026-06-24T17:18:38.150594Z","end":"2026-06-24T17:18:39.164056Z","steps":["trace[1030403360] 'process raft request' (duration: 1.01334611s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.164206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:38.150568Z","time spent":"1.013567826s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:39.164355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394832723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T17:18:39.16442Z","caller":"traceutil/trace.go:171","msg":"trace[1278222586] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:815; }","duration":"1.395636653s","start":"2026-06-24T17:18:37.768765Z","end":"2026-06-24T17:18:39.164402Z","steps":["trace[1278222586] 'count revisions from in-memory index tree' (duration: 1.394658489s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.16447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:37.768752Z","time spent":"1.395700224s","remote":"127.0.0.1:32834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-24T17:18:39.169236Z","caller":"traceutil/trace.go:171","msg":"trace[429184305] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"328.442032ms","start":"2026-06-24T17:18:38.840774Z","end":"2026-06-24T17:18:39.169216Z","steps":["trace[429184305] 'read index received' (duration: 323.271314ms)","trace[429184305] 'applied index is now lower than readState.Index' (duration: 5.169678ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:39.169291Z","caller":"traceutil/trace.go:171","msg":"trace[196556960] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"993.505009ms","start":"2026-06-24T17:18:38.175767Z","end":"2026-06-24T17:18:39.169272Z","steps":["trace[196556960] 'process raft request' (duration: 993.336645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.169393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:38.175747Z","time spent":"993.585231ms","remote":"127.0.0.1:60816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:18:39.169456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.671228ms","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-24T17:18:39.169503Z","caller":"traceutil/trace.go:171","msg":"trace[1812748657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:817; }","duration":"328.75957ms","start":"2026-06-24T17:18:38.84073Z","end":"2026-06-24T17:18:39.169489Z","steps":["trace[1812748657] 'agreement among raft nodes before linearized reading' (duration: 328.602096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.169498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.677609ms","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-06-24T17:18:39.169543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:18:38.84071Z","time spent":"328.822231ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T17:18:39.16956Z","caller":"traceutil/trace.go:171","msg":"trace[1790209303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:817; }","duration":"271.834362ms","start":"2026-06-24T17:18:38.897711Z","end":"2026-06-24T17:18:39.169545Z","steps":["trace[1790209303] 'agreement among raft nodes before linearized reading' (duration: 271.651718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.169585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.740375ms","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-06-24T17:18:39.169623Z","caller":"traceutil/trace.go:171","msg":"trace[1039810110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"270.820567ms","start":"2026-06-24T17:18:38.898787Z","end":"2026-06-24T17:18:39.169608Z","steps":["trace[1039810110] 'agreement among raft nodes before linearized reading' (duration: 270.703104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.169748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.523585ms","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-24T17:18:39.169889Z","caller":"traceutil/trace.go:171","msg":"trace[665751300] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:817; }","duration":"271.710429ms","start":"2026-06-24T17:18:38.898164Z","end":"2026-06-24T17:18:39.169875Z","steps":["trace[665751300] 'agreement among raft nodes before linearized reading' (duration: 271.475304ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:39.169782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.879264ms","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-06-24T17:18:39.169958Z","caller":"traceutil/trace.go:171","msg":"trace[695364510] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:817; }","duration":"272.094969ms","start":"2026-06-24T17:18:38.897856Z","end":"2026-06-24T17:18:39.169951Z","steps":["trace[695364510] 'agreement among raft nodes before linearized reading' (duration: 271.875874ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:43.270372Z","caller":"traceutil/trace.go:171","msg":"trace[1329822558] linearizableReadLoop","detail":"{readStateIndex:885; appliedIndex:883; }","duration":"104.031802ms","start":"2026-06-24T17:18:43.166314Z","end":"2026-06-24T17:18:43.270346Z","steps":["trace[1329822558] 'read index received' (duration: 47.929925ms)","trace[1329822558] 'applied index is now lower than readState.Index' (duration: 56.101097ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:43.270547Z","caller":"traceutil/trace.go:171","msg":"trace[443716789] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"104.943855ms","start":"2026-06-24T17:18:43.16556Z","end":"2026-06-24T17:18:43.270503Z","steps":["trace[443716789] 'process raft request' (duration: 104.662268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:43.270725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.402772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:5266"} {"level":"info","ts":"2026-06-24T17:18:43.271603Z","caller":"traceutil/trace.go:171","msg":"trace[863965472] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:856; }","duration":"105.297103ms","start":"2026-06-24T17:18:43.166282Z","end":"2026-06-24T17:18:43.271579Z","steps":["trace[863965472] 'agreement among raft nodes before linearized reading' (duration: 104.273798ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:43.704787Z","caller":"traceutil/trace.go:171","msg":"trace[1924538767] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"189.904756ms","start":"2026-06-24T17:18:43.514848Z","end":"2026-06-24T17:18:43.704753Z","steps":["trace[1924538767] 'process raft request' (duration: 187.515167ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:18:45.131585Z","caller":"traceutil/trace.go:171","msg":"trace[412215276] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:897; }","duration":"154.430648ms","start":"2026-06-24T17:18:44.977126Z","end":"2026-06-24T17:18:45.131557Z","steps":["trace[412215276] 'read index received' (duration: 154.230313ms)","trace[412215276] 'applied index is now lower than readState.Index' (duration: 198.695µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:45.131725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.575072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:18:45.131758Z","caller":"traceutil/trace.go:171","msg":"trace[978196913] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:0; response_revision:868; }","duration":"154.676635ms","start":"2026-06-24T17:18:44.97707Z","end":"2026-06-24T17:18:45.131747Z","steps":["trace[978196913] 'agreement among raft nodes before linearized reading' (duration: 154.602193ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:01.600022Z","caller":"traceutil/trace.go:171","msg":"trace[1208428121] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"174.004473ms","start":"2026-06-24T17:19:01.425996Z","end":"2026-06-24T17:19:01.600001Z","steps":["trace[1208428121] 'process raft request' (duration: 171.002949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:15.983165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151967568189349,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T17:19:16.018758Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.105991393s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T17:19:16.01907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:14.912574Z","time spent":"1.106492535s","remote":"127.0.0.1:60680","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-24T17:19:16.95594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.678478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:19:16.956184Z","caller":"traceutil/trace.go:171","msg":"trace[62176083] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"935.929962ms","start":"2026-06-24T17:19:16.020234Z","end":"2026-06-24T17:19:16.956164Z","steps":["trace[62176083] 'process raft request' (duration: 935.821029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:16.956253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:16.020209Z","time spent":"936.012614ms","remote":"127.0.0.1:60680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:19:16.956469Z","caller":"traceutil/trace.go:171","msg":"trace[290627040] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"984.500178ms","start":"2026-06-24T17:19:15.971957Z","end":"2026-06-24T17:19:16.956457Z","steps":["trace[290627040] 'process raft request' (duration: 615.211635ms)","trace[290627040] 'compare' (duration: 368.487274ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:19:16.956528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.971941Z","time spent":"984.55904ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:19:16.95664Z","caller":"traceutil/trace.go:171","msg":"trace[1294019735] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1069; }","duration":"1.473877731s","start":"2026-06-24T17:19:15.482737Z","end":"2026-06-24T17:19:16.956615Z","steps":["trace[1294019735] 'read index received' (duration: 536.233257ms)","trace[1294019735] 'applied index is now lower than readState.Index' (duration: 937.640414ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:19:16.956902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474163288s","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-06-24T17:19:16.956935Z","caller":"traceutil/trace.go:171","msg":"trace[2100930056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1036; }","duration":"1.474229219s","start":"2026-06-24T17:19:15.482694Z","end":"2026-06-24T17:19:16.956923Z","steps":["trace[2100930056] 'agreement among raft nodes before linearized reading' (duration: 1.474036374s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:16.956965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.482671Z","time spent":"1.474287271s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T17:19:16.957042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298426629s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T17:19:16.957019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.466128452s","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-24T17:19:16.95708Z","caller":"traceutil/trace.go:171","msg":"trace[612235266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1036; }","duration":"1.298489591s","start":"2026-06-24T17:19:15.658576Z","end":"2026-06-24T17:19:16.957066Z","steps":["trace[612235266] 'agreement among raft nodes before linearized reading' (duration: 1.298392608s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:16.957103Z","caller":"traceutil/trace.go:171","msg":"trace[741279716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1036; }","duration":"1.466255995s","start":"2026-06-24T17:19:15.490825Z","end":"2026-06-24T17:19:16.957081Z","steps":["trace[741279716] 'agreement among raft nodes before linearized reading' (duration: 1.466026649s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:16.957076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242415862s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T17:19:16.95711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.658562Z","time spent":"1.298541521s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T17:19:16.957146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.490811Z","time spent":"1.466326356s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T17:19:16.957136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.465256431s","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-06-24T17:19:16.957179Z","caller":"traceutil/trace.go:171","msg":"trace[568591862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1036; }","duration":"1.242544495s","start":"2026-06-24T17:19:15.714594Z","end":"2026-06-24T17:19:16.957139Z","steps":["trace[568591862] 'agreement among raft nodes before linearized reading' (duration: 1.242415622s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:16.957198Z","caller":"traceutil/trace.go:171","msg":"trace[504425739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1036; }","duration":"1.465346942s","start":"2026-06-24T17:19:15.491836Z","end":"2026-06-24T17:19:16.957182Z","steps":["trace[504425739] 'agreement among raft nodes before linearized reading' (duration: 1.465141657s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:16.957212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.714577Z","time spent":"1.242628477s","remote":"127.0.0.1:60632","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-06-24T17:19:16.957235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.491787Z","time spent":"1.465439235s","remote":"127.0.0.1:60900","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":"warn","ts":"2026-06-24T17:19:16.957315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.465547197s","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-24T17:19:16.957427Z","caller":"traceutil/trace.go:171","msg":"trace[1612245102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1036; }","duration":"1.465727062s","start":"2026-06-24T17:19:15.491672Z","end":"2026-06-24T17:19:16.957399Z","steps":["trace[1612245102] 'agreement among raft nodes before linearized reading' (duration: 1.465334172s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:16.957495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:15.491611Z","time spent":"1.465874216s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T17:19:39.265838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.562797ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:19:39.265969Z","caller":"traceutil/trace.go:171","msg":"trace[1362252116] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"146.905365ms","start":"2026-06-24T17:19:39.119035Z","end":"2026-06-24T17:19:39.26594Z","steps":["trace[1362252116] 'read index received' (duration: 41.097893ms)","trace[1362252116] 'applied index is now lower than readState.Index' (duration: 105.806252ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:39.266069Z","caller":"traceutil/trace.go:171","msg":"trace[1763106570] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"164.28818ms","start":"2026-06-24T17:19:39.101745Z","end":"2026-06-24T17:19:39.266033Z","steps":["trace[1763106570] 'process raft request' (duration: 58.442416ms)","trace[1763106570] 'compare' (duration: 105.413603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:19:39.266573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.522431ms","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-24T17:19:39.266658Z","caller":"traceutil/trace.go:171","msg":"trace[1909367665] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1109; }","duration":"147.646873ms","start":"2026-06-24T17:19:39.118993Z","end":"2026-06-24T17:19:39.26664Z","steps":["trace[1909367665] 'agreement among raft nodes before linearized reading' (duration: 147.417918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:39.266762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.412027ms","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-24T17:19:39.266816Z","caller":"traceutil/trace.go:171","msg":"trace[911335359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1109; }","duration":"106.497659ms","start":"2026-06-24T17:19:39.160307Z","end":"2026-06-24T17:19:39.266805Z","steps":["trace[911335359] 'agreement among raft nodes before linearized reading' (duration: 106.329425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:39.266677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.472252ms","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-24T17:19:39.266956Z","caller":"traceutil/trace.go:171","msg":"trace[1154755071] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1109; }","duration":"109.791139ms","start":"2026-06-24T17:19:39.157151Z","end":"2026-06-24T17:19:39.266942Z","steps":["trace[1154755071] 'agreement among raft nodes before linearized reading' (duration: 109.39946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:39.267445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.80714ms","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-24T17:19:39.26752Z","caller":"traceutil/trace.go:171","msg":"trace[440166661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1109; }","duration":"107.912213ms","start":"2026-06-24T17:19:39.159579Z","end":"2026-06-24T17:19:39.267491Z","steps":["trace[440166661] 'agreement among raft nodes before linearized reading' (duration: 107.219626ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:39.453745Z","caller":"traceutil/trace.go:171","msg":"trace[1247948250] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"182.621358ms","start":"2026-06-24T17:19:39.271091Z","end":"2026-06-24T17:19:39.453712Z","steps":["trace[1247948250] 'process raft request' (duration: 182.545226ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:39.453748Z","caller":"traceutil/trace.go:171","msg":"trace[2057386498] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"182.665739ms","start":"2026-06-24T17:19:39.271036Z","end":"2026-06-24T17:19:39.453701Z","steps":["trace[2057386498] 'process raft request' (duration: 182.509905ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:39.45395Z","caller":"traceutil/trace.go:171","msg":"trace[204667404] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"181.963031ms","start":"2026-06-24T17:19:39.271953Z","end":"2026-06-24T17:19:39.453916Z","steps":["trace[204667404] 'process raft request' (duration: 181.708625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:40.73262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.495709ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T17:19:40.732718Z","caller":"traceutil/trace.go:171","msg":"trace[176781362] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1154; }","duration":"192.168439ms","start":"2026-06-24T17:19:40.540532Z","end":"2026-06-24T17:19:40.732701Z","steps":["trace[176781362] 'read index received' (duration: 26.33µs)","trace[176781362] 'applied index is now lower than readState.Index' (duration: 192.140929ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:19:40.733038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.479018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:19:40.73311Z","caller":"traceutil/trace.go:171","msg":"trace[1027634990] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1114; }","duration":"192.5934ms","start":"2026-06-24T17:19:40.540497Z","end":"2026-06-24T17:19:40.73309Z","steps":["trace[1027634990] 'agreement among raft nodes before linearized reading' (duration: 192.463566ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:41.393347Z","caller":"traceutil/trace.go:171","msg":"trace[930237675] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"123.222177ms","start":"2026-06-24T17:19:41.270096Z","end":"2026-06-24T17:19:41.393318Z","steps":["trace[930237675] 'read index received' (duration: 123.049333ms)","trace[930237675] 'applied index is now lower than readState.Index' (duration: 171.334µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:41.393396Z","caller":"traceutil/trace.go:171","msg":"trace[1861914026] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"290.06924ms","start":"2026-06-24T17:19:41.103292Z","end":"2026-06-24T17:19:41.393361Z","steps":["trace[1861914026] 'process raft request' (duration: 289.806224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:41.393616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.488443ms","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-24T17:19:41.393659Z","caller":"traceutil/trace.go:171","msg":"trace[626078525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1115; }","duration":"123.609476ms","start":"2026-06-24T17:19:41.27004Z","end":"2026-06-24T17:19:41.39365Z","steps":["trace[626078525] 'agreement among raft nodes before linearized reading' (duration: 123.433912ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:41.643306Z","caller":"traceutil/trace.go:171","msg":"trace[1862173758] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"245.305276ms","start":"2026-06-24T17:19:41.397974Z","end":"2026-06-24T17:19:41.64328Z","steps":["trace[1862173758] 'process raft request' (duration: 241.369431ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:41.652557Z","caller":"traceutil/trace.go:171","msg":"trace[773941851] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1156; }","duration":"194.391785ms","start":"2026-06-24T17:19:41.458149Z","end":"2026-06-24T17:19:41.652541Z","steps":["trace[773941851] 'read index received' (duration: 181.114121ms)","trace[773941851] 'applied index is now lower than readState.Index' (duration: 13.276854ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:41.652745Z","caller":"traceutil/trace.go:171","msg":"trace[14825199] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"254.629294ms","start":"2026-06-24T17:19:41.398083Z","end":"2026-06-24T17:19:41.652712Z","steps":["trace[14825199] 'process raft request' (duration: 254.332977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:41.652852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.689002ms","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-24T17:19:41.652913Z","caller":"traceutil/trace.go:171","msg":"trace[75924374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1117; }","duration":"194.814676ms","start":"2026-06-24T17:19:41.458085Z","end":"2026-06-24T17:19:41.6529Z","steps":["trace[75924374] 'agreement among raft nodes before linearized reading' (duration: 194.627181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:41.653011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.344314ms","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-24T17:19:41.653093Z","caller":"traceutil/trace.go:171","msg":"trace[1488773137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1117; }","duration":"194.454017ms","start":"2026-06-24T17:19:41.458621Z","end":"2026-06-24T17:19:41.653075Z","steps":["trace[1488773137] 'agreement among raft nodes before linearized reading' (duration: 194.230652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:41.653275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.60116ms","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-24T17:19:41.653535Z","caller":"traceutil/trace.go:171","msg":"trace[229495536] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1117; }","duration":"194.945049ms","start":"2026-06-24T17:19:41.458572Z","end":"2026-06-24T17:19:41.653517Z","steps":["trace[229495536] 'agreement among raft nodes before linearized reading' (duration: 194.223551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:42.073292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.511087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:19:42.07353Z","caller":"traceutil/trace.go:171","msg":"trace[403752460] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1158; }","duration":"358.975971ms","start":"2026-06-24T17:19:41.714534Z","end":"2026-06-24T17:19:42.07351Z","steps":["trace[403752460] 'read index received' (duration: 214.165467ms)","trace[403752460] 'applied index is now lower than readState.Index' (duration: 144.809494ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:42.073544Z","caller":"traceutil/trace.go:171","msg":"trace[859225854] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"415.86175ms","start":"2026-06-24T17:19:41.657648Z","end":"2026-06-24T17:19:42.07351Z","steps":["trace[859225854] 'process raft request' (duration: 271.034715ms)","trace[859225854] 'compare' (duration: 144.010615ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:42.073616Z","caller":"traceutil/trace.go:171","msg":"trace[1355966083] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"415.321286ms","start":"2026-06-24T17:19:41.658285Z","end":"2026-06-24T17:19:42.073606Z","steps":["trace[1355966083] 'process raft request' (duration: 415.188593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:42.073684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:41.658276Z","time spent":"415.368167ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:19:42.073705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:41.657627Z","time spent":"415.991663ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:19:42.07375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.87003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T17:19:42.073807Z","caller":"traceutil/trace.go:171","msg":"trace[679691234] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1120; }","duration":"105.007854ms","start":"2026-06-24T17:19:41.968784Z","end":"2026-06-24T17:19:42.073791Z","steps":["trace[679691234] 'agreement among raft nodes before linearized reading' (duration: 104.84411ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:42.073575Z","caller":"traceutil/trace.go:171","msg":"trace[2045496371] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"415.727357ms","start":"2026-06-24T17:19:41.657832Z","end":"2026-06-24T17:19:42.073559Z","steps":["trace[2045496371] 'process raft request' (duration: 415.577183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:42.073834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.297438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:19:42.073872Z","caller":"traceutil/trace.go:171","msg":"trace[1227899124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1120; }","duration":"359.35373ms","start":"2026-06-24T17:19:41.714507Z","end":"2026-06-24T17:19:42.073861Z","steps":["trace[1227899124] 'agreement among raft nodes before linearized reading' (duration: 359.294359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:42.073888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:41.657812Z","time spent":"416.046674ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:19:42.073898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:41.714498Z","time spent":"359.393631ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:19:43.853289Z","caller":"traceutil/trace.go:171","msg":"trace[611754168] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"206.083299ms","start":"2026-06-24T17:19:43.647181Z","end":"2026-06-24T17:19:43.853264Z","steps":["trace[611754168] 'read index received' (duration: 205.842673ms)","trace[611754168] 'applied index is now lower than readState.Index' (duration: 239.536µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:43.853342Z","caller":"traceutil/trace.go:171","msg":"trace[966886790] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"453.406476ms","start":"2026-06-24T17:19:43.399915Z","end":"2026-06-24T17:19:43.853322Z","steps":["trace[966886790] 'process raft request' (duration: 453.193191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:43.853485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:43.399891Z","time spent":"453.499338ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:19:43.853515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.106795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:19:43.853581Z","caller":"traceutil/trace.go:171","msg":"trace[759456954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1121; }","duration":"139.218018ms","start":"2026-06-24T17:19:43.714346Z","end":"2026-06-24T17:19:43.853564Z","steps":["trace[759456954] 'agreement among raft nodes before linearized reading' (duration: 139.121255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:43.853578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.370136ms","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-24T17:19:43.853623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.475432ms","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-06-24T17:19:43.853664Z","caller":"traceutil/trace.go:171","msg":"trace[41176921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1121; }","duration":"195.543343ms","start":"2026-06-24T17:19:43.65811Z","end":"2026-06-24T17:19:43.853653Z","steps":["trace[41176921] 'agreement among raft nodes before linearized reading' (duration: 195.334198ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:43.853856Z","caller":"traceutil/trace.go:171","msg":"trace[1398008002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1121; }","duration":"206.50087ms","start":"2026-06-24T17:19:43.647147Z","end":"2026-06-24T17:19:43.853648Z","steps":["trace[1398008002] 'agreement among raft nodes before linearized reading' (duration: 206.222613ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:44.338965Z","caller":"traceutil/trace.go:171","msg":"trace[1172477655] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"481.201874ms","start":"2026-06-24T17:19:43.857738Z","end":"2026-06-24T17:19:44.33894Z","steps":["trace[1172477655] 'process raft request' (duration: 481.06355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:44.339178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:43.85769Z","time spent":"481.41551ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:19:44.372412Z","caller":"traceutil/trace.go:171","msg":"trace[713915966] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"514.430405ms","start":"2026-06-24T17:19:43.857962Z","end":"2026-06-24T17:19:44.372392Z","steps":["trace[713915966] 'process raft request' (duration: 514.315432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:44.372513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:19:43.85795Z","time spent":"514.512756ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:19:44.372855Z","caller":"traceutil/trace.go:171","msg":"trace[1689753815] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"272.761257ms","start":"2026-06-24T17:19:44.100079Z","end":"2026-06-24T17:19:44.37284Z","steps":["trace[1689753815] 'process raft request' (duration: 272.279775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:44.373294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.241052ms","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-24T17:19:44.373331Z","caller":"traceutil/trace.go:171","msg":"trace[1049521699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1124; }","duration":"294.326403ms","start":"2026-06-24T17:19:44.078994Z","end":"2026-06-24T17:19:44.37332Z","steps":["trace[1049521699] 'agreement among raft nodes before linearized reading' (duration: 294.18941ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:44.373509Z","caller":"traceutil/trace.go:171","msg":"trace[1621691603] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1162; }","duration":"293.723948ms","start":"2026-06-24T17:19:44.079036Z","end":"2026-06-24T17:19:44.37276Z","steps":["trace[1621691603] 'read index received' (duration: 259.740858ms)","trace[1621691603] 'applied index is now lower than readState.Index' (duration: 33.98119ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:19:44.373692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.57926ms","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-24T17:19:44.373756Z","caller":"traceutil/trace.go:171","msg":"trace[246107421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1124; }","duration":"294.681402ms","start":"2026-06-24T17:19:44.079065Z","end":"2026-06-24T17:19:44.373746Z","steps":["trace[246107421] 'agreement among raft nodes before linearized reading' (duration: 294.538639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:44.373885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.19412ms","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-06-24T17:19:44.373931Z","caller":"traceutil/trace.go:171","msg":"trace[552365782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1124; }","duration":"294.256612ms","start":"2026-06-24T17:19:44.079653Z","end":"2026-06-24T17:19:44.37391Z","steps":["trace[552365782] 'agreement among raft nodes before linearized reading' (duration: 294.17724ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:44.518871Z","caller":"traceutil/trace.go:171","msg":"trace[856691363] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"139.246078ms","start":"2026-06-24T17:19:44.379599Z","end":"2026-06-24T17:19:44.518845Z","steps":["trace[856691363] 'process raft request' (duration: 139.194767ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:44.518988Z","caller":"traceutil/trace.go:171","msg":"trace[1282124647] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"140.099249ms","start":"2026-06-24T17:19:44.378847Z","end":"2026-06-24T17:19:44.518947Z","steps":["trace[1282124647] 'process raft request' (duration: 103.278531ms)","trace[1282124647] 'compare' (duration: 36.534341ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:59.145021Z","caller":"traceutil/trace.go:171","msg":"trace[1210927510] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"168.653806ms","start":"2026-06-24T17:19:58.976329Z","end":"2026-06-24T17:19:59.144983Z","steps":["trace[1210927510] 'process raft request' (duration: 136.113002ms)","trace[1210927510] 'compare' (duration: 32.143515ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:59.145115Z","caller":"traceutil/trace.go:171","msg":"trace[667996689] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"161.332178ms","start":"2026-06-24T17:19:58.983761Z","end":"2026-06-24T17:19:59.145093Z","steps":["trace[667996689] 'process raft request' (duration: 161.039691ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:59.145003Z","caller":"traceutil/trace.go:171","msg":"trace[1956124005] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1262; }","duration":"161.899112ms","start":"2026-06-24T17:19:58.983067Z","end":"2026-06-24T17:19:59.144966Z","steps":["trace[1956124005] 'read index received' (duration: 49.835777ms)","trace[1956124005] 'applied index is now lower than readState.Index' (duration: 112.061475ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:19:59.145151Z","caller":"traceutil/trace.go:171","msg":"trace[597677898] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"159.519883ms","start":"2026-06-24T17:19:58.98561Z","end":"2026-06-24T17:19:59.14513Z","steps":["trace[597677898] 'process raft request' (duration: 159.277577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:19:59.145297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.190799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:8821"} {"level":"info","ts":"2026-06-24T17:19:59.145381Z","caller":"traceutil/trace.go:171","msg":"trace[429079569] range","detail":"{range_begin:/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:1220; }","duration":"162.342552ms","start":"2026-06-24T17:19:58.983022Z","end":"2026-06-24T17:19:59.145364Z","steps":["trace[429079569] 'agreement among raft nodes before linearized reading' (duration: 162.085196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.101656Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151967568189862,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T17:20:07.321406Z","caller":"traceutil/trace.go:171","msg":"trace[599941026] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"720.949955ms","start":"2026-06-24T17:20:06.600436Z","end":"2026-06-24T17:20:07.321386Z","steps":["trace[599941026] 'process raft request' (duration: 720.592586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.321525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:06.600412Z","time spent":"721.049919ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:07.321508Z","caller":"traceutil/trace.go:171","msg":"trace[747619453] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1304; }","duration":"720.376992ms","start":"2026-06-24T17:20:06.601106Z","end":"2026-06-24T17:20:07.321483Z","steps":["trace[747619453] 'read index received' (duration: 720.365722ms)","trace[747619453] 'applied index is now lower than readState.Index' (duration: 5.89µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:07.3218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.058195ms","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":"warn","ts":"2026-06-24T17:20:07.321825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.073621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:07.321852Z","caller":"traceutil/trace.go:171","msg":"trace[1858130737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1256; }","duration":"608.143322ms","start":"2026-06-24T17:20:06.7137Z","end":"2026-06-24T17:20:07.321844Z","steps":["trace[1858130737] 'agreement among raft nodes before linearized reading' (duration: 608.101881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.321992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.193391ms","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-24T17:20:07.322036Z","caller":"traceutil/trace.go:171","msg":"trace[1810945718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"671.267553ms","start":"2026-06-24T17:20:06.650758Z","end":"2026-06-24T17:20:07.322025Z","steps":["trace[1810945718] 'agreement among raft nodes before linearized reading' (duration: 671.1122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.322092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:06.650741Z","time spent":"671.342365ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T17:20:07.322004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:06.713684Z","time spent":"608.315347ms","remote":"127.0.0.1:60632","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-06-24T17:20:07.321942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.079396ms","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-24T17:20:07.322327Z","caller":"traceutil/trace.go:171","msg":"trace[753468835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1256; }","duration":"666.501056ms","start":"2026-06-24T17:20:06.655816Z","end":"2026-06-24T17:20:07.322318Z","steps":["trace[753468835] 'agreement among raft nodes before linearized reading' (duration: 666.051706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.322357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:06.655799Z","time spent":"666.550108ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T17:20:07.321965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.868084ms","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-06-24T17:20:07.322431Z","caller":"traceutil/trace.go:171","msg":"trace[559534953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1256; }","duration":"721.366306ms","start":"2026-06-24T17:20:06.601057Z","end":"2026-06-24T17:20:07.322423Z","steps":["trace[559534953] 'agreement among raft nodes before linearized reading' (duration: 720.837633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.322455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:06.601039Z","time spent":"721.409488ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T17:20:07.32185Z","caller":"traceutil/trace.go:171","msg":"trace[236173044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1256; }","duration":"718.146858ms","start":"2026-06-24T17:20:06.603688Z","end":"2026-06-24T17:20:07.321835Z","steps":["trace[236173044] 'agreement among raft nodes before linearized reading' (duration: 717.909952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.322521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:06.603676Z","time spent":"718.839654ms","remote":"127.0.0.1:60900","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-06-24T17:20:07.813587Z","caller":"traceutil/trace.go:171","msg":"trace[1679976841] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"487.309943ms","start":"2026-06-24T17:20:07.32625Z","end":"2026-06-24T17:20:07.81356Z","steps":["trace[1679976841] 'process raft request' (duration: 487.16578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.813764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:07.326235Z","time spent":"487.424167ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:07.81794Z","caller":"traceutil/trace.go:171","msg":"trace[716679807] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"491.6498ms","start":"2026-06-24T17:20:07.326278Z","end":"2026-06-24T17:20:07.817928Z","steps":["trace[716679807] 'process raft request' (duration: 491.392244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.818009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:07.326264Z","time spent":"491.705831ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:07.818182Z","caller":"traceutil/trace.go:171","msg":"trace[1887770788] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"491.827733ms","start":"2026-06-24T17:20:07.326324Z","end":"2026-06-24T17:20:07.818151Z","steps":["trace[1887770788] 'process raft request' (duration: 491.475445ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:07.81821Z","caller":"traceutil/trace.go:171","msg":"trace[1454888755] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"491.840524ms","start":"2026-06-24T17:20:07.326344Z","end":"2026-06-24T17:20:07.818185Z","steps":["trace[1454888755] 'process raft request' (duration: 491.736662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.818308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.728549ms","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-24T17:20:07.818293Z","caller":"traceutil/trace.go:171","msg":"trace[897904008] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1304; }","duration":"209.543494ms","start":"2026-06-24T17:20:07.608579Z","end":"2026-06-24T17:20:07.818122Z","steps":["trace[897904008] 'read index received' (duration: 204.8799ms)","trace[897904008] 'applied index is now lower than readState.Index' (duration: 4.662764ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:07.818314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:07.32632Z","time spent":"491.921616ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:20:07.81832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:07.326335Z","time spent":"491.922676ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:07.818342Z","caller":"traceutil/trace.go:171","msg":"trace[1189226285] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1260; }","duration":"209.800881ms","start":"2026-06-24T17:20:07.608529Z","end":"2026-06-24T17:20:07.81833Z","steps":["trace[1189226285] 'agreement among raft nodes before linearized reading' (duration: 209.747479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:07.81842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.938055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:07.818469Z","caller":"traceutil/trace.go:171","msg":"trace[500336967] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1260; }","duration":"140.031028ms","start":"2026-06-24T17:20:07.678422Z","end":"2026-06-24T17:20:07.818453Z","steps":["trace[500336967] 'agreement among raft nodes before linearized reading' (duration: 139.951926ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:11.281803Z","caller":"traceutil/trace.go:171","msg":"trace[215232317] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"293.852952ms","start":"2026-06-24T17:20:10.987926Z","end":"2026-06-24T17:20:11.281779Z","steps":["trace[215232317] 'process raft request' (duration: 293.677618ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:19.575421Z","caller":"traceutil/trace.go:171","msg":"trace[1494621716] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"185.930319ms","start":"2026-06-24T17:20:19.389456Z","end":"2026-06-24T17:20:19.575386Z","steps":["trace[1494621716] 'process raft request' (duration: 185.762945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:20.28084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.513685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:20:20.281114Z","caller":"traceutil/trace.go:171","msg":"trace[1642473484] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"418.059541ms","start":"2026-06-24T17:20:19.863026Z","end":"2026-06-24T17:20:20.281085Z","steps":["trace[1642473484] 'process raft request' (duration: 159.000922ms)","trace[1642473484] 'compare' (duration: 258.28646ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:20:20.281155Z","caller":"traceutil/trace.go:171","msg":"trace[349966309] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"263.255241ms","start":"2026-06-24T17:20:20.017882Z","end":"2026-06-24T17:20:20.281138Z","steps":["trace[349966309] 'process raft request' (duration: 263.194779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:20.281262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:19.863016Z","time spent":"418.156924ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:20.281309Z","caller":"traceutil/trace.go:171","msg":"trace[8298753] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1346; }","duration":"418.0097ms","start":"2026-06-24T17:20:19.863262Z","end":"2026-06-24T17:20:20.281272Z","steps":["trace[8298753] 'read index received' (duration: 23.875782ms)","trace[8298753] 'applied index is now lower than readState.Index' (duration: 394.128998ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:20.281569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.312337ms","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-24T17:20:20.281633Z","caller":"traceutil/trace.go:171","msg":"trace[1041452440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1299; }","duration":"418.413789ms","start":"2026-06-24T17:20:19.863203Z","end":"2026-06-24T17:20:20.281617Z","steps":["trace[1041452440] 'agreement among raft nodes before linearized reading' (duration: 418.208274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:20.281649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.594503ms","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":"warn","ts":"2026-06-24T17:20:20.281685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:19.863095Z","time spent":"418.577995ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T17:20:20.281703Z","caller":"traceutil/trace.go:171","msg":"trace[855183634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"413.709206ms","start":"2026-06-24T17:20:19.867979Z","end":"2026-06-24T17:20:20.281688Z","steps":["trace[855183634] 'agreement among raft nodes before linearized reading' (duration: 413.482391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:20.281844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:19.86796Z","time spent":"413.857359ms","remote":"127.0.0.1:60900","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":"warn","ts":"2026-06-24T17:20:21.081383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151967568189970,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T17:20:21.589837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110397752s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T17:20:21.590061Z","caller":"traceutil/trace.go:171","msg":"trace[1261354293] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"1.30167346s","start":"2026-06-24T17:20:20.288371Z","end":"2026-06-24T17:20:21.590044Z","steps":["trace[1261354293] 'process raft request' (duration: 1.301642799s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:21.590146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:20.288335Z","time spent":"1.301758842s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:21.590332Z","caller":"traceutil/trace.go:171","msg":"trace[62838588] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"1.304335394s","start":"2026-06-24T17:20:20.28599Z","end":"2026-06-24T17:20:21.590325Z","steps":["trace[62838588] 'process raft request' (duration: 1.303929445s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:21.590376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:20.28597Z","time spent":"1.304383885s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:21.786918Z","caller":"traceutil/trace.go:171","msg":"trace[1062263916] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1349; }","duration":"1.206284055s","start":"2026-06-24T17:20:20.580606Z","end":"2026-06-24T17:20:21.78689Z","steps":["trace[1062263916] 'read index received' (duration: 818.457491ms)","trace[1062263916] 'applied index is now lower than readState.Index' (duration: 387.825524ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:20:21.786997Z","caller":"traceutil/trace.go:171","msg":"trace[946515628] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"1.228523207s","start":"2026-06-24T17:20:20.558443Z","end":"2026-06-24T17:20:21.786966Z","steps":["trace[946515628] 'process raft request' (duration: 1.225829581s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:21.787098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.20647763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:21.787136Z","caller":"traceutil/trace.go:171","msg":"trace[1640165424] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1302; }","duration":"1.206582562s","start":"2026-06-24T17:20:20.580542Z","end":"2026-06-24T17:20:21.787125Z","steps":["trace[1640165424] 'agreement among raft nodes before linearized reading' (duration: 1.2064929s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:21.787168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:20.558423Z","time spent":"1.228663871s","remote":"127.0.0.1:60900","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-06-24T17:20:21.787176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:20.58052Z","time spent":"1.206645584s","remote":"127.0.0.1:51032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T17:20:21.787263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.007315ms","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-24T17:20:21.787327Z","caller":"traceutil/trace.go:171","msg":"trace[1574149506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1302; }","duration":"208.115738ms","start":"2026-06-24T17:20:21.579194Z","end":"2026-06-24T17:20:21.78731Z","steps":["trace[1574149506] 'agreement among raft nodes before linearized reading' (duration: 207.925193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:21.787275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072626702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:21.787415Z","caller":"traceutil/trace.go:171","msg":"trace[374257901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1302; }","duration":"1.072840157s","start":"2026-06-24T17:20:20.714546Z","end":"2026-06-24T17:20:21.787387Z","steps":["trace[374257901] 'agreement among raft nodes before linearized reading' (duration: 1.072582171s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:21.787486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:20.714526Z","time spent":"1.072946879s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:20:25.52591Z","caller":"traceutil/trace.go:171","msg":"trace[1355839426] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1381; }","duration":"159.30782ms","start":"2026-06-24T17:20:25.366556Z","end":"2026-06-24T17:20:25.525863Z","steps":["trace[1355839426] 'read index received' (duration: 158.972012ms)","trace[1355839426] 'applied index is now lower than readState.Index' (duration: 334.068µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:20:25.525962Z","caller":"traceutil/trace.go:171","msg":"trace[1081303521] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"160.829107ms","start":"2026-06-24T17:20:25.365093Z","end":"2026-06-24T17:20:25.525922Z","steps":["trace[1081303521] 'process raft request' (duration: 160.506849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:25.526104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.505705ms","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-24T17:20:25.52615Z","caller":"traceutil/trace.go:171","msg":"trace[502831002] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1330; }","duration":"159.616217ms","start":"2026-06-24T17:20:25.366521Z","end":"2026-06-24T17:20:25.526137Z","steps":["trace[502831002] 'agreement among raft nodes before linearized reading' (duration: 159.484584ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:26.154232Z","caller":"traceutil/trace.go:171","msg":"trace[1920311863] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"207.228486ms","start":"2026-06-24T17:20:25.946978Z","end":"2026-06-24T17:20:26.154206Z","steps":["trace[1920311863] 'process raft request' (duration: 207.070473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:26.870233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.158221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:20:26.870575Z","caller":"traceutil/trace.go:171","msg":"trace[1615927595] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1386; }","duration":"528.118971ms","start":"2026-06-24T17:20:26.342229Z","end":"2026-06-24T17:20:26.870348Z","steps":["trace[1615927595] 'read index received' (duration: 319.789777ms)","trace[1615927595] 'applied index is now lower than readState.Index' (duration: 208.327684ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:20:26.870576Z","caller":"traceutil/trace.go:171","msg":"trace[1534220840] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"535.589562ms","start":"2026-06-24T17:20:26.334965Z","end":"2026-06-24T17:20:26.870554Z","steps":["trace[1534220840] 'process raft request' (duration: 327.028763ms)","trace[1534220840] 'compare' (duration: 207.75008ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:26.870929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:26.334944Z","time spent":"535.938411ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:20:26.871059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.772896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:26.871265Z","caller":"traceutil/trace.go:171","msg":"trace[2130020984] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1335; }","duration":"414.034213ms","start":"2026-06-24T17:20:26.457207Z","end":"2026-06-24T17:20:26.871242Z","steps":["trace[2130020984] 'agreement among raft nodes before linearized reading' (duration: 413.766606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:26.871325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:26.457188Z","time spent":"414.122045ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-24T17:20:26.870761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.523851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T17:20:26.871486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.8929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:26.871545Z","caller":"traceutil/trace.go:171","msg":"trace[1323138424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1335; }","duration":"156.985893ms","start":"2026-06-24T17:20:26.714542Z","end":"2026-06-24T17:20:26.871528Z","steps":["trace[1323138424] 'agreement among raft nodes before linearized reading' (duration: 156.88423ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:26.871582Z","caller":"traceutil/trace.go:171","msg":"trace[1318482622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1335; }","duration":"529.257528ms","start":"2026-06-24T17:20:26.342205Z","end":"2026-06-24T17:20:26.871462Z","steps":["trace[1318482622] 'agreement among raft nodes before linearized reading' (duration: 528.416848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:26.871723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:26.342197Z","time spent":"529.446393ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T17:20:29.28669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.410426407s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:20:29.286813Z","caller":"traceutil/trace.go:171","msg":"trace[1674259541] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"1.472233062s","start":"2026-06-24T17:20:27.814559Z","end":"2026-06-24T17:20:29.286793Z","steps":["trace[1674259541] 'read index received' (duration: 61.510348ms)","trace[1674259541] 'applied index is now lower than readState.Index' (duration: 1.410720834s)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:20:29.286903Z","caller":"traceutil/trace.go:171","msg":"trace[215340125] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"1.601030258s","start":"2026-06-24T17:20:27.685857Z","end":"2026-06-24T17:20:29.286888Z","steps":["trace[215340125] 'process raft request' (duration: 190.309575ms)","trace[215340125] 'compare' (duration: 1.410101528s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:29.287378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.472799656s","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-24T17:20:29.287447Z","caller":"traceutil/trace.go:171","msg":"trace[713248377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1338; }","duration":"1.472915229s","start":"2026-06-24T17:20:27.814516Z","end":"2026-06-24T17:20:29.287431Z","steps":["trace[713248377] 'agreement among raft nodes before linearized reading' (duration: 1.472715304s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:29.287488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:27.814493Z","time spent":"1.472984121s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T17:20:29.287315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:27.685837Z","time spent":"1.60109934s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:20:29.729936Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.280967385s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T17:20:30.291951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.699098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:20:30.292254Z","caller":"traceutil/trace.go:171","msg":"trace[614234137] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1390; }","duration":"1.005381094s","start":"2026-06-24T17:20:29.286848Z","end":"2026-06-24T17:20:30.292229Z","steps":["trace[614234137] 'read index received' (duration: 443.45552ms)","trace[614234137] 'applied index is now lower than readState.Index' (duration: 561.924144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:30.292684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.43105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T17:20:30.29274Z","caller":"traceutil/trace.go:171","msg":"trace[1010711563] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1341; }","duration":"772.499613ms","start":"2026-06-24T17:20:29.520228Z","end":"2026-06-24T17:20:30.292728Z","steps":["trace[1010711563] 'agreement among raft nodes before linearized reading' (duration: 772.348238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.292719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.830901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T17:20:30.292788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:29.520164Z","time spent":"772.610645ms","remote":"127.0.0.1:60712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-06-24T17:20:30.292812Z","caller":"traceutil/trace.go:171","msg":"trace[404508037] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1341; }","duration":"386.987285ms","start":"2026-06-24T17:20:29.905803Z","end":"2026-06-24T17:20:30.29279Z","steps":["trace[404508037] 'agreement among raft nodes before linearized reading' (duration: 386.784289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.292865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:29.905781Z","time spent":"387.074817ms","remote":"127.0.0.1:32860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-24T17:20:30.292873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.134319856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-24T17:20:30.29289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.323683ms","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-24T17:20:30.292925Z","caller":"traceutil/trace.go:171","msg":"trace[1098431408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1341; }","duration":"2.134392488s","start":"2026-06-24T17:20:28.158514Z","end":"2026-06-24T17:20:30.292906Z","steps":["trace[1098431408] 'agreement among raft nodes before linearized reading' (duration: 2.134261785s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:30.29295Z","caller":"traceutil/trace.go:171","msg":"trace[573343800] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1341; }","duration":"309.422296ms","start":"2026-06-24T17:20:29.983509Z","end":"2026-06-24T17:20:30.292931Z","steps":["trace[573343800] 'agreement among raft nodes before linearized reading' (duration: 309.354964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.292979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:28.158497Z","time spent":"2.13447486s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T17:20:30.292996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:29.983484Z","time spent":"309.501988ms","remote":"127.0.0.1:32904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-24T17:20:30.292726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.318209324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T17:20:30.293064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.449313ms","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":"warn","ts":"2026-06-24T17:20:30.293062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.269437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:44677"} {"level":"info","ts":"2026-06-24T17:20:30.293145Z","caller":"traceutil/trace.go:171","msg":"trace[1025434832] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1341; }","duration":"607.544995ms","start":"2026-06-24T17:20:29.685582Z","end":"2026-06-24T17:20:30.293127Z","steps":["trace[1025434832] 'agreement among raft nodes before linearized reading' (duration: 607.30564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.293202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:29.685521Z","time spent":"607.669359ms","remote":"127.0.0.1:60900","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-06-24T17:20:30.293213Z","caller":"traceutil/trace.go:171","msg":"trace[1715907091] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"1.844316144s","start":"2026-06-24T17:20:28.448882Z","end":"2026-06-24T17:20:30.293198Z","steps":["trace[1715907091] 'process raft request' (duration: 1.281262452s)","trace[1715907091] 'compare' (duration: 561.399571ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:20:30.293151Z","caller":"traceutil/trace.go:171","msg":"trace[1219382397] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1341; }","duration":"772.3886ms","start":"2026-06-24T17:20:29.520745Z","end":"2026-06-24T17:20:30.293134Z","steps":["trace[1219382397] 'agreement among raft nodes before linearized reading' (duration: 772.149644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.293306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:28.448861Z","time spent":"1.844382795s","remote":"127.0.0.1:60720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":895,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:20:30.293318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:29.520731Z","time spent":"772.572935ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":44700,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-06-24T17:20:30.293331Z","caller":"traceutil/trace.go:171","msg":"trace[1144071860] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"1.416902795s","start":"2026-06-24T17:20:28.876412Z","end":"2026-06-24T17:20:30.293315Z","steps":["trace[1144071860] 'process raft request' (duration: 1.415689255s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.292722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.016281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:30.293337Z","caller":"traceutil/trace.go:171","msg":"trace[182494524] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"1.001694184s","start":"2026-06-24T17:20:29.291629Z","end":"2026-06-24T17:20:30.293323Z","steps":["trace[182494524] 'process raft request' (duration: 1.000556856s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:30.293377Z","caller":"traceutil/trace.go:171","msg":"trace[1200475283] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1341; }","duration":"299.698218ms","start":"2026-06-24T17:20:29.993667Z","end":"2026-06-24T17:20:30.293365Z","steps":["trace[1200475283] 'agreement among raft nodes before linearized reading' (duration: 298.923658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.293417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:28.876391Z","time spent":"1.416970037s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:20:30.293451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:29.291606Z","time spent":"1.001766666s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:30.2931Z","caller":"traceutil/trace.go:171","msg":"trace[16539092] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1341; }","duration":"2.318645774s","start":"2026-06-24T17:20:27.97444Z","end":"2026-06-24T17:20:30.293086Z","steps":["trace[16539092] 'agreement among raft nodes before linearized reading' (duration: 2.318115121s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.293551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:27.97442Z","time spent":"2.319118706s","remote":"127.0.0.1:32914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-24T17:20:30.293935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355773717s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T17:20:30.293942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.580319335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:30.293983Z","caller":"traceutil/trace.go:171","msg":"trace[1330122267] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1341; }","duration":"1.355855039s","start":"2026-06-24T17:20:28.938117Z","end":"2026-06-24T17:20:30.293972Z","steps":["trace[1330122267] 'agreement among raft nodes before linearized reading' (duration: 1.35427479s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:30.293992Z","caller":"traceutil/trace.go:171","msg":"trace[1911195786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"1.580404027s","start":"2026-06-24T17:20:28.713576Z","end":"2026-06-24T17:20:30.29398Z","steps":["trace[1911195786] 'agreement among raft nodes before linearized reading' (duration: 1.578799747s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.294014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:28.9381Z","time spent":"1.35590771s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T17:20:30.29403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:28.713556Z","time spent":"1.580467738s","remote":"127.0.0.1:60632","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-06-24T17:20:30.599586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.265689ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T17:20:30.60044Z","caller":"traceutil/trace.go:171","msg":"trace[427887309] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"302.566228ms","start":"2026-06-24T17:20:30.297829Z","end":"2026-06-24T17:20:30.600395Z","steps":["trace[427887309] 'process raft request' (duration: 302.415745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.600609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.297806Z","time spent":"302.707501ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:20:30.601083Z","caller":"traceutil/trace.go:171","msg":"trace[1449752947] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"303.42336ms","start":"2026-06-24T17:20:30.297631Z","end":"2026-06-24T17:20:30.601054Z","steps":["trace[1449752947] 'process raft request' (duration: 302.104538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.601159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.297619Z","time spent":"303.498652ms","remote":"127.0.0.1:60900","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-06-24T17:20:30.601337Z","caller":"traceutil/trace.go:171","msg":"trace[1524939755] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"301.886022ms","start":"2026-06-24T17:20:30.299413Z","end":"2026-06-24T17:20:30.601299Z","steps":["trace[1524939755] 'process raft request' (duration: 300.889457ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:30.601398Z","caller":"traceutil/trace.go:171","msg":"trace[1418259730] linearizableReadLoop","detail":"{readStateIndex:1394; appliedIndex:1393; }","duration":"305.588042ms","start":"2026-06-24T17:20:30.295737Z","end":"2026-06-24T17:20:30.601325Z","steps":["trace[1418259730] 'read index received' (duration: 59.231732ms)","trace[1418259730] 'applied index is now lower than readState.Index' (duration: 246.012371ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:30.601464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.299386Z","time spent":"302.006065ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:20:30.602128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.35027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:30.602212Z","caller":"traceutil/trace.go:171","msg":"trace[1248385602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1344; }","duration":"306.619896ms","start":"2026-06-24T17:20:30.295559Z","end":"2026-06-24T17:20:30.602179Z","steps":["trace[1248385602] 'agreement among raft nodes before linearized reading' (duration: 306.392941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.602263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.295539Z","time spent":"306.713359ms","remote":"127.0.0.1:60644","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-06-24T17:20:30.602391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.626556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:5 size:6175"} {"level":"info","ts":"2026-06-24T17:20:30.602523Z","caller":"traceutil/trace.go:171","msg":"trace[570055968] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:5; response_revision:1344; }","duration":"306.77182ms","start":"2026-06-24T17:20:30.295704Z","end":"2026-06-24T17:20:30.602476Z","steps":["trace[570055968] 'agreement among raft nodes before linearized reading' (duration: 305.782067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.60378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.402499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T17:20:30.603839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.295682Z","time spent":"308.138754ms","remote":"127.0.0.1:60838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":5,"response size":6198,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"warn","ts":"2026-06-24T17:20:30.603874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.711084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:5 size:6175"} {"level":"info","ts":"2026-06-24T17:20:30.6039Z","caller":"traceutil/trace.go:171","msg":"trace[1372665871] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:5; response_revision:1344; }","duration":"307.762625ms","start":"2026-06-24T17:20:30.29613Z","end":"2026-06-24T17:20:30.603892Z","steps":["trace[1372665871] 'agreement among raft nodes before linearized reading' (duration: 307.648583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.603958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.296118Z","time spent":"307.830427ms","remote":"127.0.0.1:60838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":5,"response size":6198,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"info","ts":"2026-06-24T17:20:30.604042Z","caller":"traceutil/trace.go:171","msg":"trace[1738211539] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1344; }","duration":"302.60743ms","start":"2026-06-24T17:20:30.301215Z","end":"2026-06-24T17:20:30.603822Z","steps":["trace[1738211539] 'agreement among raft nodes before linearized reading' (duration: 301.369179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:30.604119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:30.301203Z","time spent":"302.894346ms","remote":"127.0.0.1:59768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-24T17:20:30.605538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.40623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:30.605662Z","caller":"traceutil/trace.go:171","msg":"trace[1540320757] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1344; }","duration":"118.573907ms","start":"2026-06-24T17:20:30.487059Z","end":"2026-06-24T17:20:30.605633Z","steps":["trace[1540320757] 'agreement among raft nodes before linearized reading' (duration: 115.40811ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:31.503377Z","caller":"traceutil/trace.go:171","msg":"trace[1816118057] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"206.797976ms","start":"2026-06-24T17:20:31.296547Z","end":"2026-06-24T17:20:31.503345Z","steps":["trace[1816118057] 'process raft request' (duration: 206.629982ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:32.019952Z","caller":"traceutil/trace.go:171","msg":"trace[1475876581] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"107.936728ms","start":"2026-06-24T17:20:31.911993Z","end":"2026-06-24T17:20:32.01993Z","steps":["trace[1475876581] 'process raft request' (duration: 107.783274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:32.508478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.714965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T17:20:32.508569Z","caller":"traceutil/trace.go:171","msg":"trace[1818872119] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1349; }","duration":"287.833548ms","start":"2026-06-24T17:20:32.220716Z","end":"2026-06-24T17:20:32.50855Z","steps":["trace[1818872119] 'count revisions from in-memory index tree' (duration: 287.591253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:32.508758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.826439ms","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-24T17:20:32.508858Z","caller":"traceutil/trace.go:171","msg":"trace[1894477512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1349; }","duration":"209.970263ms","start":"2026-06-24T17:20:32.298862Z","end":"2026-06-24T17:20:32.508832Z","steps":["trace[1894477512] 'range keys from in-memory index tree' (duration: 209.673876ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:32.509099Z","caller":"traceutil/trace.go:171","msg":"trace[767554452] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"210.191818ms","start":"2026-06-24T17:20:32.298893Z","end":"2026-06-24T17:20:32.509084Z","steps":["trace[767554452] 'process raft request' (duration: 163.86474ms)","trace[767554452] 'compare' (duration: 45.749743ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:34.161859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.183044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:20:34.161974Z","caller":"traceutil/trace.go:171","msg":"trace[2078930840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1355; }","duration":"448.375868ms","start":"2026-06-24T17:20:33.713578Z","end":"2026-06-24T17:20:34.161954Z","steps":["trace[2078930840] 'range keys from in-memory index tree' (duration: 448.03925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:34.162026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:33.71356Z","time spent":"448.452711ms","remote":"127.0.0.1:60644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:20:36.05254Z","caller":"traceutil/trace.go:171","msg":"trace[1225469211] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1420; }","duration":"129.592106ms","start":"2026-06-24T17:20:35.922859Z","end":"2026-06-24T17:20:36.052451Z","steps":["trace[1225469211] 'read index received' (duration: 129.413161ms)","trace[1225469211] 'applied index is now lower than readState.Index' (duration: 177.715µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:20:36.052746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.864404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T17:20:36.052786Z","caller":"traceutil/trace.go:171","msg":"trace[2091871245] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1367; }","duration":"129.963545ms","start":"2026-06-24T17:20:35.922812Z","end":"2026-06-24T17:20:36.052775Z","steps":["trace[2091871245] 'agreement among raft nodes before linearized reading' (duration: 129.794241ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:36.05299Z","caller":"traceutil/trace.go:171","msg":"trace[1130870409] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"254.427236ms","start":"2026-06-24T17:20:35.798553Z","end":"2026-06-24T17:20:36.05298Z","steps":["trace[1130870409] 'process raft request' (duration: 253.77103ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:31.035305Z","caller":"traceutil/trace.go:171","msg":"trace[541855357] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"139.835471ms","start":"2026-06-24T17:21:30.895441Z","end":"2026-06-24T17:21:31.035276Z","steps":["trace[541855357] 'process raft request' (duration: 139.605285ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:35.316468Z","caller":"traceutil/trace.go:171","msg":"trace[1916089860] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"106.896485ms","start":"2026-06-24T17:21:35.209547Z","end":"2026-06-24T17:21:35.316443Z","steps":["trace[1916089860] 'process raft request' (duration: 106.755882ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:35.376497Z","caller":"traceutil/trace.go:171","msg":"trace[1620890862] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"166.509813ms","start":"2026-06-24T17:21:35.209957Z","end":"2026-06-24T17:21:35.376467Z","steps":["trace[1620890862] 'process raft request' (duration: 166.305638ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:35.37658Z","caller":"traceutil/trace.go:171","msg":"trace[262321834] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"166.338639ms","start":"2026-06-24T17:21:35.210213Z","end":"2026-06-24T17:21:35.376552Z","steps":["trace[262321834] 'process raft request' (duration: 166.177605ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:35.376778Z","caller":"traceutil/trace.go:171","msg":"trace[1726758575] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"164.066203ms","start":"2026-06-24T17:21:35.212695Z","end":"2026-06-24T17:21:35.376761Z","steps":["trace[1726758575] 'process raft request' (duration: 163.784636ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:35.9739Z","caller":"traceutil/trace.go:171","msg":"trace[1897652591] transaction","detail":"{read_only:false; response_revision:1697; number_of_response:1; }","duration":"115.558198ms","start":"2026-06-24T17:21:35.858316Z","end":"2026-06-24T17:21:35.973875Z","steps":["trace[1897652591] 'process raft request' (duration: 115.357692ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:36.542922Z","caller":"traceutil/trace.go:171","msg":"trace[1142918128] transaction","detail":"{read_only:false; response_revision:1698; number_of_response:1; }","duration":"111.16392ms","start":"2026-06-24T17:21:36.431719Z","end":"2026-06-24T17:21:36.542883Z","steps":["trace[1142918128] 'process raft request' (duration: 110.947784ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:37.155854Z","caller":"traceutil/trace.go:171","msg":"trace[646444260] transaction","detail":"{read_only:false; response_revision:1702; number_of_response:1; }","duration":"101.588335ms","start":"2026-06-24T17:21:37.054234Z","end":"2026-06-24T17:21:37.155822Z","steps":["trace[646444260] 'process raft request' (duration: 101.405161ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:39.526084Z","caller":"traceutil/trace.go:171","msg":"trace[1526289306] linearizableReadLoop","detail":"{readStateIndex:1780; appliedIndex:1779; }","duration":"133.093717ms","start":"2026-06-24T17:21:39.392964Z","end":"2026-06-24T17:21:39.526058Z","steps":["trace[1526289306] 'read index received' (duration: 132.83257ms)","trace[1526289306] 'applied index is now lower than readState.Index' (duration: 260.037µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:21:39.526113Z","caller":"traceutil/trace.go:171","msg":"trace[501250633] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"133.768813ms","start":"2026-06-24T17:21:39.392323Z","end":"2026-06-24T17:21:39.526092Z","steps":["trace[501250633] 'process raft request' (duration: 133.527726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:21:39.526303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.317202ms","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-24T17:21:39.526356Z","caller":"traceutil/trace.go:171","msg":"trace[473677782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1714; }","duration":"133.397014ms","start":"2026-06-24T17:21:39.392949Z","end":"2026-06-24T17:21:39.526346Z","steps":["trace[473677782] 'agreement among raft nodes before linearized reading' (duration: 133.21217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:21:42.528732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.762354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-24T17:21:42.528809Z","caller":"traceutil/trace.go:171","msg":"trace[903095721] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1729; }","duration":"232.879807ms","start":"2026-06-24T17:21:42.295907Z","end":"2026-06-24T17:21:42.528786Z","steps":["trace[903095721] 'range keys from in-memory index tree' (duration: 232.58425ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:42.713583Z","caller":"traceutil/trace.go:171","msg":"trace[1570540197] transaction","detail":"{read_only:false; response_revision:1730; number_of_response:1; }","duration":"180.494716ms","start":"2026-06-24T17:21:42.533058Z","end":"2026-06-24T17:21:42.713552Z","steps":["trace[1570540197] 'process raft request' (duration: 180.338422ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:43.095415Z","caller":"traceutil/trace.go:171","msg":"trace[1078850559] transaction","detail":"{read_only:false; response_revision:1731; number_of_response:1; }","duration":"113.150999ms","start":"2026-06-24T17:21:42.982237Z","end":"2026-06-24T17:21:43.095388Z","steps":["trace[1078850559] 'process raft request' (duration: 113.009455ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:21:46.804585Z","caller":"traceutil/trace.go:171","msg":"trace[446391790] transaction","detail":"{read_only:false; response_revision:1750; number_of_response:1; }","duration":"115.122366ms","start":"2026-06-24T17:21:46.689429Z","end":"2026-06-24T17:21:46.804552Z","steps":["trace[446391790] 'process raft request' (duration: 32.545245ms)","trace[446391790] 'compare' (duration: 82.402657ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:24:27.097913Z","caller":"traceutil/trace.go:171","msg":"trace[522307336] linearizableReadLoop","detail":"{readStateIndex:2691; appliedIndex:2690; }","duration":"181.282118ms","start":"2026-06-24T17:24:26.916604Z","end":"2026-06-24T17:24:27.097886Z","steps":["trace[522307336] 'read index received' (duration: 181.017701ms)","trace[522307336] 'applied index is now lower than readState.Index' (duration: 263.057µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:24:27.098046Z","caller":"traceutil/trace.go:171","msg":"trace[31422285] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"602.340433ms","start":"2026-06-24T17:24:26.495682Z","end":"2026-06-24T17:24:27.098022Z","steps":["trace[31422285] 'process raft request' (duration: 602.029826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:24:27.098128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.910518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-24T17:24:27.098132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.522723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T17:24:27.098176Z","caller":"traceutil/trace.go:171","msg":"trace[1994040395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2590; }","duration":"133.96523ms","start":"2026-06-24T17:24:26.964201Z","end":"2026-06-24T17:24:27.098167Z","steps":["trace[1994040395] 'agreement among raft nodes before linearized reading' (duration: 133.844647ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:24:27.098187Z","caller":"traceutil/trace.go:171","msg":"trace[377482685] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2590; }","duration":"181.610456ms","start":"2026-06-24T17:24:26.916564Z","end":"2026-06-24T17:24:27.098174Z","steps":["trace[377482685] 'agreement among raft nodes before linearized reading' (duration: 181.461792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:24:27.098181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:24:26.49567Z","time spent":"602.429405ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:24:27.237172Z","caller":"traceutil/trace.go:171","msg":"trace[2089591733] linearizableReadLoop","detail":"{readStateIndex:2693; appliedIndex:2691; }","duration":"124.742583ms","start":"2026-06-24T17:24:27.112405Z","end":"2026-06-24T17:24:27.237147Z","steps":["trace[2089591733] 'read index received' (duration: 31.009499ms)","trace[2089591733] 'applied index is now lower than readState.Index' (duration: 93.732214ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:24:27.23729Z","caller":"traceutil/trace.go:171","msg":"trace[1922457244] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"135.171848ms","start":"2026-06-24T17:24:27.102094Z","end":"2026-06-24T17:24:27.237266Z","steps":["trace[1922457244] 'process raft request' (duration: 134.924222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:24:27.237336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.899977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T17:24:27.237371Z","caller":"traceutil/trace.go:171","msg":"trace[833628959] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2592; }","duration":"124.97378ms","start":"2026-06-24T17:24:27.112388Z","end":"2026-06-24T17:24:27.237361Z","steps":["trace[833628959] 'agreement among raft nodes before linearized reading' (duration: 124.887477ms)"],"step_count":1}