{"level":"warn","ts":"2026-06-15T19:04:45.783962Z","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-15T19:04:45.784055Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.128:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.128:2380","--initial-cluster=instance=https://199.19.213.128:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.128:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.128: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-15T19:04:45.784124Z","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-15T19:04:45.784132Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.128:2380"]} {"level":"info","ts":"2026-06-15T19:04:45.784154Z","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-15T19:04:45.784822Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.128:2379"]} {"level":"info","ts":"2026-06-15T19:04:45.784921Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.128:2380"],"listen-peer-urls":["https://199.19.213.128:2380"],"advertise-client-urls":["https://199.19.213.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.128: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-15T19:04:45.78943Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.301811ms"} {"level":"info","ts":"2026-06-15T19:04:45.804081Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a463a6aa9b462de2","cluster-id":"cd3d14b8ed85e2f2"} {"level":"info","ts":"2026-06-15T19:04:45.804211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T19:04:45.804251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became follower at term 0"} {"level":"info","ts":"2026-06-15T19:04:45.804267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a463a6aa9b462de2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T19:04:45.804279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became follower at term 1"} {"level":"info","ts":"2026-06-15T19:04:45.804328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 switched to configuration voters=(11845494696594255330)"} {"level":"warn","ts":"2026-06-15T19:04:45.811688Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T19:04:45.813096Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T19:04:45.817297Z","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-15T19:04:45.820122Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a463a6aa9b462de2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T19:04:45.820631Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a463a6aa9b462de2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T19:04:45.820737Z","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-15T19:04:45.82079Z","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-15T19:04:45.8208Z","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-15T19:04:45.821504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 switched to configuration voters=(11845494696594255330)"} {"level":"info","ts":"2026-06-15T19:04:45.821959Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cd3d14b8ed85e2f2","local-member-id":"a463a6aa9b462de2","added-peer-id":"a463a6aa9b462de2","added-peer-peer-urls":["https://199.19.213.128:2380"]} {"level":"info","ts":"2026-06-15T19:04:45.825452Z","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-15T19:04:45.825471Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.128:2380"} {"level":"info","ts":"2026-06-15T19:04:45.825513Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.128:2380"} {"level":"info","ts":"2026-06-15T19:04:45.825741Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a463a6aa9b462de2","initial-advertise-peer-urls":["https://199.19.213.128:2380"],"listen-peer-urls":["https://199.19.213.128:2380"],"advertise-client-urls":["https://199.19.213.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T19:04:45.825795Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T19:04:46.805338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T19:04:46.805412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T19:04:46.805472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 received MsgPreVoteResp from a463a6aa9b462de2 at term 1"} {"level":"info","ts":"2026-06-15T19:04:46.805493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became candidate at term 2"} {"level":"info","ts":"2026-06-15T19:04:46.805509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 received MsgVoteResp from a463a6aa9b462de2 at term 2"} {"level":"info","ts":"2026-06-15T19:04:46.805522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became leader at term 2"} {"level":"info","ts":"2026-06-15T19:04:46.805537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a463a6aa9b462de2 elected leader a463a6aa9b462de2 at term 2"} {"level":"info","ts":"2026-06-15T19:04:46.806632Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a463a6aa9b462de2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.128:2379]}","request-path":"/0/members/a463a6aa9b462de2/attributes","cluster-id":"cd3d14b8ed85e2f2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T19:04:46.806722Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:46.806878Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:04:46.807219Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:04:46.807304Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T19:04:46.807328Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T19:04:46.809779Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cd3d14b8ed85e2f2","local-member-id":"a463a6aa9b462de2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:46.809911Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:46.809962Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:46.810835Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.128:2379"} {"level":"info","ts":"2026-06-15T19:04:46.810879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T19:04:52.976031Z","caller":"traceutil/trace.go:171","msg":"trace[111846631] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"197.423516ms","start":"2026-06-15T19:04:52.778571Z","end":"2026-06-15T19:04:52.975994Z","steps":["trace[111846631] 'process raft request' (duration: 197.292043ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:52.976039Z","caller":"traceutil/trace.go:171","msg":"trace[755731366] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"198.419052ms","start":"2026-06-15T19:04:52.777568Z","end":"2026-06-15T19:04:52.975987Z","steps":["trace[755731366] 'process raft request' (duration: 198.135105ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:52.976528Z","caller":"traceutil/trace.go:171","msg":"trace[1805043217] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:284; }","duration":"171.646696ms","start":"2026-06-15T19:04:52.804868Z","end":"2026-06-15T19:04:52.976514Z","steps":["trace[1805043217] 'read index received' (duration: 171.641055ms)","trace[1805043217] 'applied index is now lower than readState.Index' (duration: 4.781µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:04:52.976693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.035865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:04:52.976763Z","caller":"traceutil/trace.go:171","msg":"trace[115091573] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:272; }","duration":"177.18611ms","start":"2026-06-15T19:04:52.799564Z","end":"2026-06-15T19:04:52.97675Z","steps":["trace[115091573] 'agreement among raft nodes before linearized reading' (duration: 177.031696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:53.477497Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3306379678339821194,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:04:53.64783Z","caller":"traceutil/trace.go:171","msg":"trace[442369765] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"824.058197ms","start":"2026-06-15T19:04:52.823745Z","end":"2026-06-15T19:04:53.647803Z","steps":["trace[442369765] 'process raft request' (duration: 823.891973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:53.648534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:52.823727Z","time spent":"824.180392ms","remote":"127.0.0.1:50630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:04:53.887878Z","caller":"traceutil/trace.go:171","msg":"trace[1295059056] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:284; }","duration":"911.276966ms","start":"2026-06-15T19:04:52.976566Z","end":"2026-06-15T19:04:53.887843Z","steps":["trace[1295059056] 'read index received' (duration: 671.113038ms)","trace[1295059056] 'applied index is now lower than readState.Index' (duration: 240.162898ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:04:53.888005Z","caller":"traceutil/trace.go:171","msg":"trace[1744779014] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"906.874383ms","start":"2026-06-15T19:04:52.981067Z","end":"2026-06-15T19:04:53.887941Z","steps":["trace[1744779014] 'process raft request' (duration: 808.619827ms)","trace[1744779014] 'compare' (duration: 97.977749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:04:53.888223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.326155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"warn","ts":"2026-06-15T19:04:53.888222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.752026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-06-15T19:04:53.888278Z","caller":"traceutil/trace.go:171","msg":"trace[1166128594] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:274; }","duration":"234.426308ms","start":"2026-06-15T19:04:53.653837Z","end":"2026-06-15T19:04:53.888263Z","steps":["trace[1166128594] 'agreement among raft nodes before linearized reading' (duration: 234.320695ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:53.888368Z","caller":"traceutil/trace.go:171","msg":"trace[656584355] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:274; }","duration":"909.90242ms","start":"2026-06-15T19:04:52.978366Z","end":"2026-06-15T19:04:53.888268Z","steps":["trace[656584355] 'agreement among raft nodes before linearized reading' (duration: 909.711405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:53.888402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:52.978339Z","time spent":"910.054094ms","remote":"127.0.0.1:50630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4004,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-06-15T19:04:53.888396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.185199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:04:53.888473Z","caller":"traceutil/trace.go:171","msg":"trace[1328309073] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:274; }","duration":"907.341474ms","start":"2026-06-15T19:04:52.981108Z","end":"2026-06-15T19:04:53.88845Z","steps":["trace[1328309073] 'agreement among raft nodes before linearized reading' (duration: 907.123848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:53.888511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:52.981084Z","time spent":"907.416176ms","remote":"127.0.0.1:50648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" "} {"level":"warn","ts":"2026-06-15T19:04:53.889055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:52.981043Z","time spent":"907.091128ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:04:53.889232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083030216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-06-15T19:04:53.889394Z","caller":"traceutil/trace.go:171","msg":"trace[2108505868] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:274; }","duration":"1.083303722s","start":"2026-06-15T19:04:52.806065Z","end":"2026-06-15T19:04:53.889369Z","steps":["trace[2108505868] 'agreement among raft nodes before linearized reading' (duration: 1.081938826s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:53.889446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:52.806048Z","time spent":"1.083385484s","remote":"127.0.0.1:50630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5537,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-06-15T19:04:55.041145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.957332ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:04:55.041398Z","caller":"traceutil/trace.go:171","msg":"trace[455828289] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"1.14742073s","start":"2026-06-15T19:04:53.893938Z","end":"2026-06-15T19:04:55.041359Z","steps":["trace[455828289] 'process raft request' (duration: 306.936506ms)","trace[455828289] 'compare' (duration: 839.748646ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:04:55.041519Z","caller":"traceutil/trace.go:171","msg":"trace[211322089] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"1.127906593s","start":"2026-06-15T19:04:53.913588Z","end":"2026-06-15T19:04:55.041495Z","steps":["trace[211322089] 'process raft request' (duration: 1.127836161s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.041571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:53.893911Z","time spent":"1.147567664s","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:04:55.041638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:53.913557Z","time spent":"1.128028625s","remote":"127.0.0.1:50630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:04:55.041877Z","caller":"traceutil/trace.go:171","msg":"trace[1706168352] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"1.147299386s","start":"2026-06-15T19:04:53.894567Z","end":"2026-06-15T19:04:55.041867Z","steps":["trace[1706168352] 'process raft request' (duration: 1.146768693s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.04193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:53.894547Z","time spent":"1.147359128s","remote":"127.0.0.1:50494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:04:55.042034Z","caller":"traceutil/trace.go:171","msg":"trace[474856171] linearizableReadLoop","detail":"{readStateIndex:287; appliedIndex:286; }","duration":"1.147810311s","start":"2026-06-15T19:04:53.894215Z","end":"2026-06-15T19:04:55.042026Z","steps":["trace[474856171] 'read index received' (duration: 306.623338ms)","trace[474856171] 'applied index is now lower than readState.Index' (duration: 841.185503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:04:55.042165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147948984s","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-15T19:04:55.042196Z","caller":"traceutil/trace.go:171","msg":"trace[1301495374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:277; }","duration":"1.148028826s","start":"2026-06-15T19:04:53.89416Z","end":"2026-06-15T19:04:55.042189Z","steps":["trace[1301495374] 'agreement among raft nodes before linearized reading' (duration: 1.147960274s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.042217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:53.894128Z","time spent":"1.148085017s","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T19:04:55.042321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128734654s","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-15T19:04:55.042344Z","caller":"traceutil/trace.go:171","msg":"trace[282226122] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:277; }","duration":"1.128799616s","start":"2026-06-15T19:04:53.913539Z","end":"2026-06-15T19:04:55.042339Z","steps":["trace[282226122] 'agreement among raft nodes before linearized reading' (duration: 1.128755234s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.042361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:53.913513Z","time spent":"1.128844216s","remote":"127.0.0.1:50536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-15T19:04:55.042582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.801254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T19:04:55.042611Z","caller":"traceutil/trace.go:171","msg":"trace[216052398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:277; }","duration":"516.878615ms","start":"2026-06-15T19:04:54.525726Z","end":"2026-06-15T19:04:55.042604Z","steps":["trace[216052398] 'agreement among raft nodes before linearized reading' (duration: 516.832564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.042629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:54.525696Z","time spent":"516.928687ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:04:55.042731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.631629ms","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-15T19:04:55.04275Z","caller":"traceutil/trace.go:171","msg":"trace[229428867] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:277; }","duration":"343.718231ms","start":"2026-06-15T19:04:54.699026Z","end":"2026-06-15T19:04:55.042744Z","steps":["trace[229428867] 'agreement among raft nodes before linearized reading' (duration: 343.68089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.042765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:54.698996Z","time spent":"343.766082ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T19:04:55.550132Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3306379678339821202,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:04:55.689808Z","caller":"traceutil/trace.go:171","msg":"trace[1365574183] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"643.210673ms","start":"2026-06-15T19:04:55.046532Z","end":"2026-06-15T19:04:55.689743Z","steps":["trace[1365574183] 'process raft request' (duration: 640.658766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.689997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.219424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"warn","ts":"2026-06-15T19:04:55.690021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:55.046511Z","time spent":"643.408437ms","remote":"127.0.0.1:50648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:04:55.690049Z","caller":"traceutil/trace.go:171","msg":"trace[280279203] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:281; }","duration":"640.326758ms","start":"2026-06-15T19:04:55.049711Z","end":"2026-06-15T19:04:55.690037Z","steps":["trace[280279203] 'agreement among raft nodes before linearized reading' (duration: 640.186914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.690096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:55.049702Z","time spent":"640.383519ms","remote":"127.0.0.1:50630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5537,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-06-15T19:04:55.690103Z","caller":"traceutil/trace.go:171","msg":"trace[503428826] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"642.700059ms","start":"2026-06-15T19:04:55.047307Z","end":"2026-06-15T19:04:55.690008Z","steps":["trace[503428826] 'process raft request' (duration: 642.34418ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:55.690411Z","caller":"traceutil/trace.go:171","msg":"trace[776517944] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"641.20913ms","start":"2026-06-15T19:04:55.049186Z","end":"2026-06-15T19:04:55.690395Z","steps":["trace[776517944] 'process raft request' (duration: 640.526662ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:55.690464Z","caller":"traceutil/trace.go:171","msg":"trace[209680317] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"623.611674ms","start":"2026-06-15T19:04:55.066839Z","end":"2026-06-15T19:04:55.690451Z","steps":["trace[209680317] 'process raft request' (duration: 622.906905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:55.690469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:55.04727Z","time spent":"643.090331ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:04:55.690513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:55.049157Z","time spent":"641.286133ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:04:55.69057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:04:55.066819Z","time spent":"623.677815ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:04:55.689829Z","caller":"traceutil/trace.go:171","msg":"trace[1264861929] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:289; }","duration":"640.0585ms","start":"2026-06-15T19:04:55.049739Z","end":"2026-06-15T19:04:55.689797Z","steps":["trace[1264861929] 'read index received' (duration: 637.460502ms)","trace[1264861929] 'applied index is now lower than readState.Index' (duration: 2.596958ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:25.564559Z","caller":"traceutil/trace.go:171","msg":"trace[1065675084] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"438.59359ms","start":"2026-06-15T19:05:25.125934Z","end":"2026-06-15T19:05:25.564528Z","steps":["trace[1065675084] 'process raft request' (duration: 438.447727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.564806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.125907Z","time spent":"438.746155ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.572742Z","caller":"traceutil/trace.go:171","msg":"trace[1979362314] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"436.928997ms","start":"2026-06-15T19:05:25.135794Z","end":"2026-06-15T19:05:25.572723Z","steps":["trace[1979362314] 'process raft request' (duration: 436.619679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.57286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.13575Z","time spent":"437.05588ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.572741Z","caller":"traceutil/trace.go:171","msg":"trace[1633289359] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"443.905649ms","start":"2026-06-15T19:05:25.128803Z","end":"2026-06-15T19:05:25.572708Z","steps":["trace[1633289359] 'process raft request' (duration: 443.561279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.572966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.128796Z","time spent":"444.156365ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.572941Z","caller":"traceutil/trace.go:171","msg":"trace[396392260] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"434.146424ms","start":"2026-06-15T19:05:25.138609Z","end":"2026-06-15T19:05:25.572755Z","steps":["trace[396392260] 'process raft request' (duration: 433.872687ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:25.573029Z","caller":"traceutil/trace.go:171","msg":"trace[1618222658] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"444.270489ms","start":"2026-06-15T19:05:25.128751Z","end":"2026-06-15T19:05:25.573022Z","steps":["trace[1618222658] 'process raft request' (duration: 443.474457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.573062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.128742Z","time spent":"444.306499ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.573132Z","caller":"traceutil/trace.go:171","msg":"trace[1560264348] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"434.341179ms","start":"2026-06-15T19:05:25.138783Z","end":"2026-06-15T19:05:25.573125Z","steps":["trace[1560264348] 'process raft request' (duration: 433.844567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.573161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.138778Z","time spent":"434.36717ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.573213Z","caller":"traceutil/trace.go:171","msg":"trace[1340818306] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"434.496723ms","start":"2026-06-15T19:05:25.138711Z","end":"2026-06-15T19:05:25.573207Z","steps":["trace[1340818306] 'process raft request' (duration: 433.833876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.573197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.138594Z","time spent":"434.465953ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:05:25.573238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.138706Z","time spent":"434.520114ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.57331Z","caller":"traceutil/trace.go:171","msg":"trace[2011830168] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"423.63176ms","start":"2026-06-15T19:05:25.149673Z","end":"2026-06-15T19:05:25.573305Z","steps":["trace[2011830168] 'process raft request' (duration: 423.23858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.573335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.149654Z","time spent":"423.669361ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.57339Z","caller":"traceutil/trace.go:171","msg":"trace[34445574] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"434.539424ms","start":"2026-06-15T19:05:25.138846Z","end":"2026-06-15T19:05:25.573385Z","steps":["trace[34445574] 'process raft request' (duration: 433.944329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.573413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.13884Z","time spent":"434.561625ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.573416Z","caller":"traceutil/trace.go:171","msg":"trace[1380806849] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"423.63288ms","start":"2026-06-15T19:05:25.149767Z","end":"2026-06-15T19:05:25.5734Z","steps":["trace[1380806849] 'process raft request' (duration: 423.327383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.57347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.149659Z","time spent":"423.785544ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.573595Z","caller":"traceutil/trace.go:171","msg":"trace[756073013] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"408.2301ms","start":"2026-06-15T19:05:25.165358Z","end":"2026-06-15T19:05:25.573588Z","steps":["trace[756073013] 'process raft request' (duration: 407.83426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.573628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.165338Z","time spent":"408.274251ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:25.577387Z","caller":"traceutil/trace.go:171","msg":"trace[1646653160] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"279.182312ms","start":"2026-06-15T19:05:25.298185Z","end":"2026-06-15T19:05:25.577367Z","steps":["trace[1646653160] 'process raft request' (duration: 278.528455ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:25.58894Z","caller":"traceutil/trace.go:171","msg":"trace[1697195540] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:502; }","duration":"369.315427ms","start":"2026-06-15T19:05:25.219592Z","end":"2026-06-15T19:05:25.588907Z","steps":["trace[1697195540] 'read index received' (duration: 344.689687ms)","trace[1697195540] 'applied index is now lower than readState.Index' (duration: 24.62441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:25.589299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.665847ms","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-15T19:05:25.589381Z","caller":"traceutil/trace.go:171","msg":"trace[1754953061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:497; }","duration":"369.79695ms","start":"2026-06-15T19:05:25.219542Z","end":"2026-06-15T19:05:25.589339Z","steps":["trace[1754953061] 'agreement among raft nodes before linearized reading' (duration: 369.487961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:25.589489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:25.219526Z","time spent":"369.949864ms","remote":"127.0.0.1:50696","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-15T19:05:32.909805Z","caller":"traceutil/trace.go:171","msg":"trace[52281340] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"296.182645ms","start":"2026-06-15T19:05:32.613579Z","end":"2026-06-15T19:05:32.909761Z","steps":["trace[52281340] 'process raft request' (duration: 294.953652ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:33.052911Z","caller":"traceutil/trace.go:171","msg":"trace[472886717] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"128.320069ms","start":"2026-06-15T19:05:32.92455Z","end":"2026-06-15T19:05:33.05287Z","steps":["trace[472886717] 'process raft request' (duration: 128.000521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:34.353557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.479695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:05:34.353728Z","caller":"traceutil/trace.go:171","msg":"trace[1478957525] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"707.70095ms","start":"2026-06-15T19:05:33.645996Z","end":"2026-06-15T19:05:34.353697Z","steps":["trace[1478957525] 'read index received' (duration: 9.870206ms)","trace[1478957525] 'applied index is now lower than readState.Index' (duration: 697.828184ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:34.353797Z","caller":"traceutil/trace.go:171","msg":"trace[1697006646] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.383400059s","start":"2026-06-15T19:05:32.970374Z","end":"2026-06-15T19:05:34.353774Z","steps":["trace[1697006646] 'process raft request' (duration: 685.612636ms)","trace[1697006646] 'compare' (duration: 696.546161ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:34.353896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:32.970343Z","time spent":"1.383508752s","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:05:34.354008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.635145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:34.354059Z","caller":"traceutil/trace.go:171","msg":"trace[1954301599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"467.744048ms","start":"2026-06-15T19:05:33.8863Z","end":"2026-06-15T19:05:34.354044Z","steps":["trace[1954301599] 'agreement among raft nodes before linearized reading' (duration: 467.550873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:34.354107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:33.886275Z","time spent":"467.81721ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T19:05:34.35407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.045639ms","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-15T19:05:34.354176Z","caller":"traceutil/trace.go:171","msg":"trace[992119371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:589; }","duration":"708.220175ms","start":"2026-06-15T19:05:33.645928Z","end":"2026-06-15T19:05:34.354148Z","steps":["trace[992119371] 'agreement among raft nodes before linearized reading' (duration: 707.890316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:34.354226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:33.645896Z","time spent":"708.319347ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:05:34.354214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.097461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-15T19:05:34.354297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.910143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:34.354331Z","caller":"traceutil/trace.go:171","msg":"trace[962196243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"384.989115ms","start":"2026-06-15T19:05:33.969332Z","end":"2026-06-15T19:05:34.354321Z","steps":["trace[962196243] 'agreement among raft nodes before linearized reading' (duration: 384.940214ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:34.354325Z","caller":"traceutil/trace.go:171","msg":"trace[2146372646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"369.290166ms","start":"2026-06-15T19:05:33.985005Z","end":"2026-06-15T19:05:34.354295Z","steps":["trace[2146372646] 'agreement among raft nodes before linearized reading' (duration: 368.883656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:34.354345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.582608ms","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-15T19:05:34.354365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:33.969296Z","time spent":"385.063847ms","remote":"127.0.0.1:50410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:05:34.354381Z","caller":"traceutil/trace.go:171","msg":"trace[1156247898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"378.622169ms","start":"2026-06-15T19:05:33.975748Z","end":"2026-06-15T19:05:34.35437Z","steps":["trace[1156247898] 'agreement among raft nodes before linearized reading' (duration: 378.453345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:34.354386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:33.98499Z","time spent":"369.384608ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:05:34.354412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:33.975719Z","time spent":"378.685531ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T19:05:34.354637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.247916ms","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-15T19:05:34.354669Z","caller":"traceutil/trace.go:171","msg":"trace[1075839555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:589; }","duration":"364.339358ms","start":"2026-06-15T19:05:33.99032Z","end":"2026-06-15T19:05:34.354659Z","steps":["trace[1075839555] 'agreement among raft nodes before linearized reading' (duration: 364.231125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:34.354732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:33.990282Z","time spent":"364.443021ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T19:05:35.471116Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3306379678339821901,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:05:35.972192Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3306379678339821901,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:05:36.057524Z","caller":"traceutil/trace.go:171","msg":"trace[207189881] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.265636344s","start":"2026-06-15T19:05:34.791848Z","end":"2026-06-15T19:05:36.057484Z","steps":["trace[207189881] 'process raft request' (duration: 1.263672054s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:36.057719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:34.791774Z","time spent":"1.26584909s","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:05:36.072127Z","caller":"traceutil/trace.go:171","msg":"trace[1368271101] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:618; }","duration":"1.101308791s","start":"2026-06-15T19:05:34.970783Z","end":"2026-06-15T19:05:36.072091Z","steps":["trace[1368271101] 'read index received' (duration: 1.084406931s)","trace[1368271101] 'applied index is now lower than readState.Index' (duration: 16.90052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:36.072272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101470725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:36.072317Z","caller":"traceutil/trace.go:171","msg":"trace[1316957567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"1.101593019s","start":"2026-06-15T19:05:34.970714Z","end":"2026-06-15T19:05:36.072307Z","steps":["trace[1316957567] 'agreement among raft nodes before linearized reading' (duration: 1.101489866s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:36.072353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:34.970689Z","time spent":"1.10165743s","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:05:37.464775Z","caller":"traceutil/trace.go:171","msg":"trace[1001046693] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"376.615158ms","start":"2026-06-15T19:05:37.088118Z","end":"2026-06-15T19:05:37.464733Z","steps":["trace[1001046693] 'process raft request' (duration: 375.726184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:37.465093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:37.088079Z","time spent":"376.820773ms","remote":"127.0.0.1:50512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:05:41.354394Z","caller":"traceutil/trace.go:171","msg":"trace[1897833643] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"180.867692ms","start":"2026-06-15T19:05:41.173482Z","end":"2026-06-15T19:05:41.354349Z","steps":["trace[1897833643] 'process raft request' (duration: 180.514033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:52.595422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.510235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:52.595548Z","caller":"traceutil/trace.go:171","msg":"trace[1485151381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"625.68143ms","start":"2026-06-15T19:05:51.969826Z","end":"2026-06-15T19:05:52.595507Z","steps":["trace[1485151381] 'range keys from in-memory index tree' (duration: 625.397353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:52.595605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.137892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T19:05:52.595632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:51.969802Z","time spent":"625.813274ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:05:52.595673Z","caller":"traceutil/trace.go:171","msg":"trace[1376500172] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:765; }","duration":"676.266444ms","start":"2026-06-15T19:05:51.91939Z","end":"2026-06-15T19:05:52.595657Z","steps":["trace[1376500172] 'count revisions from in-memory index tree' (duration: 676.002807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:52.595742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:51.919176Z","time spent":"676.550472ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":14,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:05:52.595736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.47463ms","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-15T19:05:52.595806Z","caller":"traceutil/trace.go:171","msg":"trace[1271528486] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:765; }","duration":"834.603133ms","start":"2026-06-15T19:05:51.761186Z","end":"2026-06-15T19:05:52.59579Z","steps":["trace[1271528486] 'range keys from in-memory index tree' (duration: 833.915525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:52.595849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:51.761155Z","time spent":"834.680885ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T19:05:52.595972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154264067s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:52.596161Z","caller":"traceutil/trace.go:171","msg":"trace[202743243] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:765; }","duration":"1.154745951s","start":"2026-06-15T19:05:51.441383Z","end":"2026-06-15T19:05:52.596128Z","steps":["trace[202743243] 'range keys from in-memory index tree' (duration: 1.154239637s)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.596834Z","caller":"traceutil/trace.go:171","msg":"trace[2125611748] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"131.417138ms","start":"2026-06-15T19:05:52.465402Z","end":"2026-06-15T19:05:52.596819Z","steps":["trace[2125611748] 'read index received' (duration: 131.060138ms)","trace[2125611748] 'applied index is now lower than readState.Index' (duration: 355.54µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:52.596939Z","caller":"traceutil/trace.go:171","msg":"trace[428040091] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"590.792709ms","start":"2026-06-15T19:05:52.006132Z","end":"2026-06-15T19:05:52.596925Z","steps":["trace[428040091] 'process raft request' (duration: 590.510422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:52.597109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:52.006099Z","time spent":"590.885372ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:05:52.597511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.110896ms","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-15T19:05:52.597553Z","caller":"traceutil/trace.go:171","msg":"trace[370964773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:766; }","duration":"132.200719ms","start":"2026-06-15T19:05:52.465342Z","end":"2026-06-15T19:05:52.597542Z","steps":["trace[370964773] 'agreement among raft nodes before linearized reading' (duration: 132.040855ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.782712Z","caller":"traceutil/trace.go:171","msg":"trace[1898116671] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"179.211079ms","start":"2026-06-15T19:05:52.603468Z","end":"2026-06-15T19:05:52.782679Z","steps":["trace[1898116671] 'process raft request' (duration: 179.000303ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.784212Z","caller":"traceutil/trace.go:171","msg":"trace[1870106452] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"170.11183ms","start":"2026-06-15T19:05:52.614061Z","end":"2026-06-15T19:05:52.784173Z","steps":["trace[1870106452] 'process raft request' (duration: 170.059038ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.784677Z","caller":"traceutil/trace.go:171","msg":"trace[625565071] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"180.930964ms","start":"2026-06-15T19:05:52.603707Z","end":"2026-06-15T19:05:52.784638Z","steps":["trace[625565071] 'process raft request' (duration: 180.281947ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.784785Z","caller":"traceutil/trace.go:171","msg":"trace[1937722647] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"181.045736ms","start":"2026-06-15T19:05:52.603703Z","end":"2026-06-15T19:05:52.784749Z","steps":["trace[1937722647] 'process raft request' (duration: 180.335458ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.784836Z","caller":"traceutil/trace.go:171","msg":"trace[1732706194] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"181.077197ms","start":"2026-06-15T19:05:52.603739Z","end":"2026-06-15T19:05:52.784816Z","steps":["trace[1732706194] 'process raft request' (duration: 180.344318ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:52.78487Z","caller":"traceutil/trace.go:171","msg":"trace[419317141] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"181.140069ms","start":"2026-06-15T19:05:52.603703Z","end":"2026-06-15T19:05:52.784843Z","steps":["trace[419317141] 'process raft request' (duration: 180.096752ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:27.459486Z","caller":"traceutil/trace.go:171","msg":"trace[1912458988] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"480.749555ms","start":"2026-06-15T19:06:26.978709Z","end":"2026-06-15T19:06:27.459458Z","steps":["trace[1912458988] 'process raft request' (duration: 480.716714ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:27.4595Z","caller":"traceutil/trace.go:171","msg":"trace[1558395818] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"482.849711ms","start":"2026-06-15T19:06:26.976606Z","end":"2026-06-15T19:06:27.459455Z","steps":["trace[1558395818] 'process raft request' (duration: 482.589454ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:27.459572Z","caller":"traceutil/trace.go:171","msg":"trace[1384883320] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"482.831291ms","start":"2026-06-15T19:06:26.976692Z","end":"2026-06-15T19:06:27.459524Z","steps":["trace[1384883320] 'process raft request' (duration: 482.674256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:27.459677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:26.978693Z","time spent":"480.889399ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:06:27.459727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:26.976585Z","time spent":"483.015006ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:06:27.45982Z","caller":"traceutil/trace.go:171","msg":"trace[423081638] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"481.985658ms","start":"2026-06-15T19:06:26.97782Z","end":"2026-06-15T19:06:27.459806Z","steps":["trace[423081638] 'process raft request' (duration: 481.580957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:27.460028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:26.976686Z","time spent":"482.979824ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:06:27.46005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:26.977793Z","time spent":"482.225414ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:06:59.838694Z","caller":"traceutil/trace.go:171","msg":"trace[1677537805] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"650.827011ms","start":"2026-06-15T19:06:59.187821Z","end":"2026-06-15T19:06:59.838648Z","steps":["trace[1677537805] 'process raft request' (duration: 650.590235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:59.838973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:59.187795Z","time spent":"651.046297ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:06:59.847598Z","caller":"traceutil/trace.go:171","msg":"trace[1973819461] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1128; }","duration":"220.761244ms","start":"2026-06-15T19:06:59.6268Z","end":"2026-06-15T19:06:59.847561Z","steps":["trace[1973819461] 'read index received' (duration: 211.645327ms)","trace[1973819461] 'applied index is now lower than readState.Index' (duration: 9.114677ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:06:59.847737Z","caller":"traceutil/trace.go:171","msg":"trace[32623742] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"261.946881ms","start":"2026-06-15T19:06:59.58578Z","end":"2026-06-15T19:06:59.847727Z","steps":["trace[32623742] 'process raft request' (duration: 261.599981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:59.84794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.119853ms","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-15T19:06:59.847992Z","caller":"traceutil/trace.go:171","msg":"trace[911531491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"221.251076ms","start":"2026-06-15T19:06:59.626728Z","end":"2026-06-15T19:06:59.847979Z","steps":["trace[911531491] 'agreement among raft nodes before linearized reading' (duration: 221.00346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:59.848012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.185395ms","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-15T19:06:59.84805Z","caller":"traceutil/trace.go:171","msg":"trace[2025372202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1084; }","duration":"221.288778ms","start":"2026-06-15T19:06:59.626752Z","end":"2026-06-15T19:06:59.848041Z","steps":["trace[2025372202] 'agreement among raft nodes before linearized reading' (duration: 221.163675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:59.848338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.337463ms","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-15T19:06:59.848364Z","caller":"traceutil/trace.go:171","msg":"trace[451464856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1084; }","duration":"189.413415ms","start":"2026-06-15T19:06:59.658945Z","end":"2026-06-15T19:06:59.848358Z","steps":["trace[451464856] 'agreement among raft nodes before linearized reading' (duration: 189.212839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:59.848479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.376782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T19:06:59.848579Z","caller":"traceutil/trace.go:171","msg":"trace[1234482739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1084; }","duration":"193.550266ms","start":"2026-06-15T19:06:59.654999Z","end":"2026-06-15T19:06:59.848549Z","steps":["trace[1234482739] 'agreement among raft nodes before linearized reading' (duration: 193.269368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:00.381877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.296549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:00.38213Z","caller":"traceutil/trace.go:171","msg":"trace[2081478125] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"529.966955ms","start":"2026-06-15T19:06:59.852128Z","end":"2026-06-15T19:07:00.382095Z","steps":["trace[2081478125] 'process raft request' (duration: 139.355097ms)","trace[2081478125] 'compare' (duration: 390.134735ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:00.382166Z","caller":"traceutil/trace.go:171","msg":"trace[1525281566] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1130; }","duration":"411.329139ms","start":"2026-06-15T19:06:59.970816Z","end":"2026-06-15T19:07:00.382145Z","steps":["trace[1525281566] 'read index received' (duration: 20.727242ms)","trace[1525281566] 'applied index is now lower than readState.Index' (duration: 390.600807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:00.382311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:59.852099Z","time spent":"530.109209ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:00.382554Z","caller":"traceutil/trace.go:171","msg":"trace[1202075481] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"530.275224ms","start":"2026-06-15T19:06:59.852264Z","end":"2026-06-15T19:07:00.382539Z","steps":["trace[1202075481] 'process raft request' (duration: 529.728139ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:00.382644Z","caller":"traceutil/trace.go:171","msg":"trace[1437933975] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"530.148401ms","start":"2026-06-15T19:06:59.852482Z","end":"2026-06-15T19:07:00.38263Z","steps":["trace[1437933975] 'process raft request' (duration: 529.619756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:00.382649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:59.852251Z","time spent":"530.354126ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:00.38272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:59.852462Z","time spent":"530.216833ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:00.382777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.931946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:00.382851Z","caller":"traceutil/trace.go:171","msg":"trace[956337683] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"530.50704ms","start":"2026-06-15T19:06:59.852332Z","end":"2026-06-15T19:07:00.382839Z","steps":["trace[956337683] 'process raft request' (duration: 529.734089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:00.382855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.409443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.128\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T19:07:00.382903Z","caller":"traceutil/trace.go:171","msg":"trace[480227925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"412.11777ms","start":"2026-06-15T19:06:59.970749Z","end":"2026-06-15T19:07:00.382867Z","steps":["trace[480227925] 'agreement among raft nodes before linearized reading' (duration: 411.895364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:00.382921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:59.852301Z","time spent":"530.585853ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:00.38288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.346306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:07:00.382964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:59.970717Z","time spent":"412.237304ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:07:00.38297Z","caller":"traceutil/trace.go:171","msg":"trace[1594861576] range","detail":"{range_begin:/registry/masterleases/199.19.213.128; range_end:; response_count:1; response_revision:1088; }","duration":"200.595187ms","start":"2026-06-15T19:07:00.182347Z","end":"2026-06-15T19:07:00.382942Z","steps":["trace[1594861576] 'agreement among raft nodes before linearized reading' (duration: 200.279179ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:00.383044Z","caller":"traceutil/trace.go:171","msg":"trace[1454769945] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1088; }","duration":"198.599993ms","start":"2026-06-15T19:07:00.184382Z","end":"2026-06-15T19:07:00.382982Z","steps":["trace[1454769945] 'agreement among raft nodes before linearized reading' (duration: 198.328396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:16.02184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.180949ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-15T19:07:16.024709Z","caller":"traceutil/trace.go:171","msg":"trace[752346975] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"108.795599ms","start":"2026-06-15T19:07:15.915893Z","end":"2026-06-15T19:07:16.024689Z","steps":["trace[752346975] 'process raft request' (duration: 108.480151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:16.024914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.954791ms","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-15T19:07:16.025005Z","caller":"traceutil/trace.go:171","msg":"trace[1147514360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1137; }","duration":"106.097395ms","start":"2026-06-15T19:07:15.918879Z","end":"2026-06-15T19:07:16.024977Z","steps":["trace[1147514360] 'agreement among raft nodes before linearized reading' (duration: 105.835238ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:16.02463Z","caller":"traceutil/trace.go:171","msg":"trace[2003479979] linearizableReadLoop","detail":"{readStateIndex:1187; appliedIndex:1186; }","duration":"105.664114ms","start":"2026-06-15T19:07:15.918937Z","end":"2026-06-15T19:07:16.024601Z","steps":["trace[2003479979] 'read index received' (duration: 105.379006ms)","trace[2003479979] 'applied index is now lower than readState.Index' (duration: 283.678µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:17.422044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.91709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:17.422368Z","caller":"traceutil/trace.go:171","msg":"trace[663190834] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"893.858889ms","start":"2026-06-15T19:07:16.528476Z","end":"2026-06-15T19:07:17.422335Z","steps":["trace[663190834] 'process raft request' (duration: 393.399084ms)","trace[663190834] 'compare' (duration: 499.212141ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:17.422402Z","caller":"traceutil/trace.go:171","msg":"trace[2007599867] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"893.550341ms","start":"2026-06-15T19:07:16.528827Z","end":"2026-06-15T19:07:17.422377Z","steps":["trace[2007599867] 'process raft request' (duration: 893.362736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:17.422489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:16.528773Z","time spent":"893.673994ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:17.422517Z","caller":"traceutil/trace.go:171","msg":"trace[1712012702] linearizableReadLoop","detail":"{readStateIndex:1192; appliedIndex:1189; }","duration":"452.30266ms","start":"2026-06-15T19:07:16.9702Z","end":"2026-06-15T19:07:17.422503Z","steps":["trace[1712012702] 'read index received' (duration: 450.79044ms)","trace[1712012702] 'applied index is now lower than readState.Index' (duration: 1.51131ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:17.422527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:16.528446Z","time spent":"893.990732ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:17.422596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.407012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:17.42264Z","caller":"traceutil/trace.go:171","msg":"trace[184438391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1142; }","duration":"452.509416ms","start":"2026-06-15T19:07:16.970122Z","end":"2026-06-15T19:07:17.422632Z","steps":["trace[184438391] 'agreement among raft nodes before linearized reading' (duration: 452.423833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:17.422661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:16.970093Z","time spent":"452.563656ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:07:17.422672Z","caller":"traceutil/trace.go:171","msg":"trace[1591508096] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"893.421577ms","start":"2026-06-15T19:07:16.529217Z","end":"2026-06-15T19:07:17.422639Z","steps":["trace[1591508096] 'process raft request' (duration: 893.101068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:17.422847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:16.529202Z","time spent":"893.54833ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:34.352428Z","caller":"traceutil/trace.go:171","msg":"trace[1561519602] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"166.810932ms","start":"2026-06-15T19:07:34.185563Z","end":"2026-06-15T19:07:34.352374Z","steps":["trace[1561519602] 'process raft request' (duration: 166.582196ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:35.825885Z","caller":"traceutil/trace.go:171","msg":"trace[2112052291] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"297.551706ms","start":"2026-06-15T19:07:35.528307Z","end":"2026-06-15T19:07:35.825859Z","steps":["trace[2112052291] 'process raft request' (duration: 297.393922ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:36.280848Z","caller":"traceutil/trace.go:171","msg":"trace[1323889043] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1305; }","duration":"697.714832ms","start":"2026-06-15T19:07:35.583111Z","end":"2026-06-15T19:07:36.280826Z","steps":["trace[1323889043] 'read index received' (duration: 242.691628ms)","trace[1323889043] 'applied index is now lower than readState.Index' (duration: 455.021954ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:36.281138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.913698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T19:07:36.281167Z","caller":"traceutil/trace.go:171","msg":"trace[150171928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1251; }","duration":"684.003361ms","start":"2026-06-15T19:07:35.597156Z","end":"2026-06-15T19:07:36.281159Z","steps":["trace[150171928] 'agreement among raft nodes before linearized reading' (duration: 683.820986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:36.281194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:35.597125Z","time spent":"684.063482ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:07:36.281168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.02017ms","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-15T19:07:36.281319Z","caller":"traceutil/trace.go:171","msg":"trace[272061892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1251; }","duration":"698.231626ms","start":"2026-06-15T19:07:35.583057Z","end":"2026-06-15T19:07:36.281289Z","steps":["trace[272061892] 'agreement among raft nodes before linearized reading' (duration: 697.838506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:36.281379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:35.583022Z","time spent":"698.345659ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T19:07:50.340862Z","caller":"traceutil/trace.go:171","msg":"trace[1012217825] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"129.579198ms","start":"2026-06-15T19:07:50.211255Z","end":"2026-06-15T19:07:50.340834Z","steps":["trace[1012217825] 'process raft request' (duration: 129.233499ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:50.747786Z","caller":"traceutil/trace.go:171","msg":"trace[2100283980] linearizableReadLoop","detail":"{readStateIndex:1359; appliedIndex:1358; }","duration":"302.41522ms","start":"2026-06-15T19:07:50.445338Z","end":"2026-06-15T19:07:50.747753Z","steps":["trace[2100283980] 'read index received' (duration: 301.67386ms)","trace[2100283980] 'applied index is now lower than readState.Index' (duration: 740.01µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:50.747837Z","caller":"traceutil/trace.go:171","msg":"trace[144114234] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"314.409939ms","start":"2026-06-15T19:07:50.433383Z","end":"2026-06-15T19:07:50.747792Z","steps":["trace[144114234] 'process raft request' (duration: 313.68635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:50.747959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.599914ms","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-15T19:07:50.748016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.433372Z","time spent":"314.548562ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:50.748045Z","caller":"traceutil/trace.go:171","msg":"trace[1609209988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1300; }","duration":"302.744288ms","start":"2026-06-15T19:07:50.445283Z","end":"2026-06-15T19:07:50.748027Z","steps":["trace[1609209988] 'agreement among raft nodes before linearized reading' (duration: 302.574373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:50.748087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.445248Z","time spent":"302.83152ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T19:07:52.205594Z","caller":"traceutil/trace.go:171","msg":"trace[514782761] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"234.24413ms","start":"2026-06-15T19:07:51.971316Z","end":"2026-06-15T19:07:52.205561Z","steps":["trace[514782761] 'read index received' (duration: 233.988693ms)","trace[514782761] 'applied index is now lower than readState.Index' (duration: 254.037µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:52.205747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.408894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:52.20571Z","caller":"traceutil/trace.go:171","msg":"trace[687688225] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"302.528442ms","start":"2026-06-15T19:07:51.903128Z","end":"2026-06-15T19:07:52.205656Z","steps":["trace[687688225] 'process raft request' (duration: 302.232004ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:52.205795Z","caller":"traceutil/trace.go:171","msg":"trace[954869165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1304; }","duration":"234.531328ms","start":"2026-06-15T19:07:51.971252Z","end":"2026-06-15T19:07:52.205783Z","steps":["trace[954869165] 'agreement among raft nodes before linearized reading' (duration: 234.432135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.205934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:51.903104Z","time spent":"302.711577ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:54.871509Z","caller":"traceutil/trace.go:171","msg":"trace[1605862216] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"107.96881ms","start":"2026-06-15T19:07:54.763511Z","end":"2026-06-15T19:07:54.87148Z","steps":["trace[1605862216] 'process raft request' (duration: 107.553279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:58.219084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.69285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:58.219192Z","caller":"traceutil/trace.go:171","msg":"trace[660863192] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1351; }","duration":"798.899045ms","start":"2026-06-15T19:07:57.420264Z","end":"2026-06-15T19:07:58.219163Z","steps":["trace[660863192] 'range keys from in-memory index tree' (duration: 798.536216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:58.21924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:57.420239Z","time spent":"798.989588ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-15T19:07:58.219319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.982483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:58.220209Z","caller":"traceutil/trace.go:171","msg":"trace[1957450484] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1351; }","duration":"651.010491ms","start":"2026-06-15T19:07:57.569153Z","end":"2026-06-15T19:07:58.220163Z","steps":["trace[1957450484] 'count revisions from in-memory index tree' (duration: 649.813928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:58.220875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:57.569068Z","time spent":"651.782401ms","remote":"127.0.0.1:50714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:07:58.219579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.108377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:58.221248Z","caller":"traceutil/trace.go:171","msg":"trace[2114321188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1351; }","duration":"250.868085ms","start":"2026-06-15T19:07:57.970357Z","end":"2026-06-15T19:07:58.221225Z","steps":["trace[2114321188] 'range keys from in-memory index tree' (duration: 248.967912ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:59.222342Z","caller":"traceutil/trace.go:171","msg":"trace[1107530545] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1419; }","duration":"320.617454ms","start":"2026-06-15T19:07:58.901697Z","end":"2026-06-15T19:07:59.222314Z","steps":["trace[1107530545] 'read index received' (duration: 320.350957ms)","trace[1107530545] 'applied index is now lower than readState.Index' (duration: 265.337µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:59.222464Z","caller":"traceutil/trace.go:171","msg":"trace[230171917] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"334.266249ms","start":"2026-06-15T19:07:58.888186Z","end":"2026-06-15T19:07:59.222453Z","steps":["trace[230171917] 'process raft request' (duration: 333.92719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:59.222586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:58.888145Z","time spent":"334.344971ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:59.222792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.093838ms","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-15T19:07:59.222828Z","caller":"traceutil/trace.go:171","msg":"trace[1821713309] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1360; }","duration":"321.16461ms","start":"2026-06-15T19:07:58.901653Z","end":"2026-06-15T19:07:59.222817Z","steps":["trace[1821713309] 'agreement among raft nodes before linearized reading' (duration: 321.042016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:59.222852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:58.901638Z","time spent":"321.208221ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T19:07:59.22294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.408646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:59.222993Z","caller":"traceutil/trace.go:171","msg":"trace[1442043874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1360; }","duration":"252.517429ms","start":"2026-06-15T19:07:58.970461Z","end":"2026-06-15T19:07:59.222978Z","steps":["trace[1442043874] 'agreement among raft nodes before linearized reading' (duration: 252.442427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:59.222982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.28868ms","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-15T19:07:59.223089Z","caller":"traceutil/trace.go:171","msg":"trace[1803435316] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1360; }","duration":"319.482895ms","start":"2026-06-15T19:07:58.90358Z","end":"2026-06-15T19:07:59.223063Z","steps":["trace[1803435316] 'agreement among raft nodes before linearized reading' (duration: 319.172187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:59.223149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:58.903546Z","time spent":"319.593557ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T19:07:59.742943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3306379678339823631,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:08:00.002402Z","caller":"traceutil/trace.go:171","msg":"trace[761955037] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1421; }","duration":"760.482441ms","start":"2026-06-15T19:07:59.241892Z","end":"2026-06-15T19:08:00.002374Z","steps":["trace[761955037] 'read index received' (duration: 716.20901ms)","trace[761955037] 'applied index is now lower than readState.Index' (duration: 44.272561ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:00.002534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.615915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:08:00.002602Z","caller":"traceutil/trace.go:171","msg":"trace[347630966] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1362; }","duration":"760.759039ms","start":"2026-06-15T19:07:59.241833Z","end":"2026-06-15T19:08:00.002592Z","steps":["trace[347630966] 'agreement among raft nodes before linearized reading' (duration: 760.638136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:00.002631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:59.241807Z","time spent":"760.81507ms","remote":"127.0.0.1:36520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:08:00.002591Z","caller":"traceutil/trace.go:171","msg":"trace[1780225022] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"773.802616ms","start":"2026-06-15T19:07:59.228748Z","end":"2026-06-15T19:08:00.002551Z","steps":["trace[1780225022] 'process raft request' (duration: 729.36625ms)","trace[1780225022] 'compare' (duration: 43.978884ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:00.002813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:59.228736Z","time spent":"773.94188ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:08:00.516015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.25182ms","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-15T19:08:00.51612Z","caller":"traceutil/trace.go:171","msg":"trace[1078973661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1363; }","duration":"201.409985ms","start":"2026-06-15T19:08:00.314687Z","end":"2026-06-15T19:08:00.516097Z","steps":["trace[1078973661] 'range keys from in-memory index tree' (duration: 200.970083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:01.241849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.511061ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:08:01.241986Z","caller":"traceutil/trace.go:171","msg":"trace[1342769630] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"717.660528ms","start":"2026-06-15T19:08:00.524303Z","end":"2026-06-15T19:08:01.241963Z","steps":["trace[1342769630] 'process raft request' (duration: 435.936432ms)","trace[1342769630] 'compare' (duration: 281.300075ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:01.242048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:00.524282Z","time spent":"717.738991ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:08:01.256959Z","caller":"traceutil/trace.go:171","msg":"trace[158953873] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1425; }","duration":"566.534177ms","start":"2026-06-15T19:08:00.690393Z","end":"2026-06-15T19:08:01.256928Z","steps":["trace[158953873] 'read index received' (duration: 269.865241ms)","trace[158953873] 'applied index is now lower than readState.Index' (duration: 296.668066ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:08:01.257046Z","caller":"traceutil/trace.go:171","msg":"trace[823209705] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"681.659088ms","start":"2026-06-15T19:08:00.57535Z","end":"2026-06-15T19:08:01.257009Z","steps":["trace[823209705] 'process raft request' (duration: 681.400812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:01.257234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.822484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-15T19:08:01.257298Z","caller":"traceutil/trace.go:171","msg":"trace[715416124] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1366; }","duration":"566.973549ms","start":"2026-06-15T19:08:00.690314Z","end":"2026-06-15T19:08:01.257288Z","steps":["trace[715416124] 'agreement among raft nodes before linearized reading' (duration: 566.751373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:01.25733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:00.690267Z","time spent":"567.055251ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-15T19:08:01.257438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:00.575323Z","time spent":"681.899655ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:08:01.338947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.526906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:08:01.338962Z","caller":"traceutil/trace.go:171","msg":"trace[1567332847] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"107.359885ms","start":"2026-06-15T19:08:01.231553Z","end":"2026-06-15T19:08:01.338913Z","steps":["trace[1567332847] 'process raft request' (duration: 107.147849ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:01.339032Z","caller":"traceutil/trace.go:171","msg":"trace[468045440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1367; }","duration":"370.69058ms","start":"2026-06-15T19:08:00.968321Z","end":"2026-06-15T19:08:01.339012Z","steps":["trace[468045440] 'agreement among raft nodes before linearized reading' (duration: 370.525866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:01.339069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:00.968282Z","time spent":"370.781223ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T19:08:01.339062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.465581ms","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-15T19:08:01.339123Z","caller":"traceutil/trace.go:171","msg":"trace[281899310] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1367; }","duration":"100.579394ms","start":"2026-06-15T19:08:01.238527Z","end":"2026-06-15T19:08:01.339106Z","steps":["trace[281899310] 'agreement among raft nodes before linearized reading' (duration: 100.367948ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:01.410841Z","caller":"traceutil/trace.go:171","msg":"trace[1581537807] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"148.232525ms","start":"2026-06-15T19:08:01.262578Z","end":"2026-06-15T19:08:01.410811Z","steps":["trace[1581537807] 'process raft request' (duration: 91.11173ms)","trace[1581537807] 'compare' (duration: 56.679593ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:08:01.46097Z","caller":"traceutil/trace.go:171","msg":"trace[1154324332] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"116.811306ms","start":"2026-06-15T19:08:01.344086Z","end":"2026-06-15T19:08:01.460897Z","steps":["trace[1154324332] 'process raft request' (duration: 116.297152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:02.188846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.588991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:08:02.188929Z","caller":"traceutil/trace.go:171","msg":"trace[1608024306] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1371; }","duration":"128.747015ms","start":"2026-06-15T19:08:02.060164Z","end":"2026-06-15T19:08:02.188911Z","steps":["trace[1608024306] 'count revisions from in-memory index tree' (duration: 128.492858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:09.827356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.884725ms","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-15T19:08:09.82747Z","caller":"traceutil/trace.go:171","msg":"trace[1147185205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1426; }","duration":"326.07621ms","start":"2026-06-15T19:08:09.50137Z","end":"2026-06-15T19:08:09.827446Z","steps":["trace[1147185205] 'range keys from in-memory index tree' (duration: 325.612278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:09.827521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:09.501332Z","time spent":"326.177493ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T19:08:09.947255Z","caller":"traceutil/trace.go:171","msg":"trace[1610897713] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"113.715475ms","start":"2026-06-15T19:08:09.833504Z","end":"2026-06-15T19:08:09.94722Z","steps":["trace[1610897713] 'process raft request' (duration: 113.5256ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:09.979646Z","caller":"traceutil/trace.go:171","msg":"trace[676592324] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"145.559964ms","start":"2026-06-15T19:08:09.834054Z","end":"2026-06-15T19:08:09.979614Z","steps":["trace[676592324] 'process raft request' (duration: 145.37675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:11.106695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.639792ms","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-15T19:08:11.106798Z","caller":"traceutil/trace.go:171","msg":"trace[1931862554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1428; }","duration":"496.812966ms","start":"2026-06-15T19:08:10.609961Z","end":"2026-06-15T19:08:11.106774Z","steps":["trace[1931862554] 'range keys from in-memory index tree' (duration: 496.400616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:11.106853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:10.609933Z","time spent":"496.907399ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T19:08:11.106878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054971509s","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-15T19:08:11.106993Z","caller":"traceutil/trace.go:171","msg":"trace[431749406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1428; }","duration":"1.055157254s","start":"2026-06-15T19:08:10.051808Z","end":"2026-06-15T19:08:11.106965Z","steps":["trace[431749406] 'range keys from in-memory index tree' (duration: 1.054699302s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:11.10705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:10.051781Z","time spent":"1.055256447s","remote":"127.0.0.1:50696","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-15T19:08:11.107179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.82765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.128\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-15T19:08:11.107277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.872862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:08:11.10732Z","caller":"traceutil/trace.go:171","msg":"trace[314780008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1428; }","duration":"136.960514ms","start":"2026-06-15T19:08:10.970348Z","end":"2026-06-15T19:08:11.107308Z","steps":["trace[314780008] 'range keys from in-memory index tree' (duration: 136.630116ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:11.107301Z","caller":"traceutil/trace.go:171","msg":"trace[1180919346] range","detail":"{range_begin:/registry/masterleases/199.19.213.128; range_end:; response_count:1; response_revision:1428; }","duration":"921.012695ms","start":"2026-06-15T19:08:10.186262Z","end":"2026-06-15T19:08:11.107274Z","steps":["trace[1180919346] 'range keys from in-memory index tree' (duration: 920.457031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:11.107438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:10.186234Z","time spent":"921.189099ms","remote":"127.0.0.1:50454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.128\" "} {"level":"warn","ts":"2026-06-15T19:08:11.107221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.97758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-15T19:08:11.107538Z","caller":"traceutil/trace.go:171","msg":"trace[181661296] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1428; }","duration":"223.341459ms","start":"2026-06-15T19:08:10.884188Z","end":"2026-06-15T19:08:11.10753Z","steps":["trace[181661296] 'range keys from in-memory index tree' (duration: 222.845886ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:11.290852Z","caller":"traceutil/trace.go:171","msg":"trace[755457974] linearizableReadLoop","detail":"{readStateIndex:1491; appliedIndex:1490; }","duration":"181.015889ms","start":"2026-06-15T19:08:11.109801Z","end":"2026-06-15T19:08:11.290817Z","steps":["trace[755457974] 'read index received' (duration: 140.274µs)","trace[755457974] 'applied index is now lower than readState.Index' (duration: 180.873905ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:11.293446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.276673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:08:11.297427Z","caller":"traceutil/trace.go:171","msg":"trace[1491498769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1428; }","duration":"184.315488ms","start":"2026-06-15T19:08:11.109735Z","end":"2026-06-15T19:08:11.29405Z","steps":["trace[1491498769] 'agreement among raft nodes before linearized reading' (duration: 181.695398ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:11.304418Z","caller":"traceutil/trace.go:171","msg":"trace[423078535] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"191.353526ms","start":"2026-06-15T19:08:11.113047Z","end":"2026-06-15T19:08:11.3044Z","steps":["trace[423078535] 'process raft request' (duration: 191.282724ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:11.305143Z","caller":"traceutil/trace.go:171","msg":"trace[1453990146] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"191.904ms","start":"2026-06-15T19:08:11.112927Z","end":"2026-06-15T19:08:11.304832Z","steps":["trace[1453990146] 'process raft request' (duration: 191.029757ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:11.304847Z","caller":"traceutil/trace.go:171","msg":"trace[1247703214] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"190.606016ms","start":"2026-06-15T19:08:11.114058Z","end":"2026-06-15T19:08:11.304664Z","steps":["trace[1247703214] 'process raft request' (duration: 190.299287ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:47.93048Z","caller":"traceutil/trace.go:171","msg":"trace[743625774] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"129.028316ms","start":"2026-06-15T19:09:47.8014Z","end":"2026-06-15T19:09:47.930429Z","steps":["trace[743625774] 'process raft request' (duration: 59.926488ms)","trace[743625774] 'compare' (duration: 68.83719ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:09:47.932614Z","caller":"traceutil/trace.go:171","msg":"trace[2115152208] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1956; }","duration":"126.412006ms","start":"2026-06-15T19:09:47.806184Z","end":"2026-06-15T19:09:47.932596Z","steps":["trace[2115152208] 'read index received' (duration: 55.151172ms)","trace[2115152208] 'applied index is now lower than readState.Index' (duration: 71.259684ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:09:47.932721Z","caller":"traceutil/trace.go:171","msg":"trace[2119266694] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"129.079335ms","start":"2026-06-15T19:09:47.80363Z","end":"2026-06-15T19:09:47.93271Z","steps":["trace[2119266694] 'process raft request' (duration: 128.88581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:09:47.933156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.94608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-15T19:09:47.933208Z","caller":"traceutil/trace.go:171","msg":"trace[502257708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1876; }","duration":"127.045813ms","start":"2026-06-15T19:09:47.806151Z","end":"2026-06-15T19:09:47.933197Z","steps":["trace[502257708] 'agreement among raft nodes before linearized reading' (duration: 126.682593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:09:47.933588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.012006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-15T19:09:47.93386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.961455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-15T19:09:47.93391Z","caller":"traceutil/trace.go:171","msg":"trace[2031130540] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1876; }","duration":"126.025586ms","start":"2026-06-15T19:09:47.807872Z","end":"2026-06-15T19:09:47.933898Z","steps":["trace[2031130540] 'agreement among raft nodes before linearized reading' (duration: 125.908823ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:47.933881Z","caller":"traceutil/trace.go:171","msg":"trace[1957322184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1876; }","duration":"126.332194ms","start":"2026-06-15T19:09:47.807512Z","end":"2026-06-15T19:09:47.933844Z","steps":["trace[1957322184] 'agreement among raft nodes before linearized reading' (duration: 125.575783ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:48.734601Z","caller":"traceutil/trace.go:171","msg":"trace[1905605256] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"103.617091ms","start":"2026-06-15T19:09:48.630948Z","end":"2026-06-15T19:09:48.734565Z","steps":["trace[1905605256] 'process raft request' (duration: 103.394534ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:50.269247Z","caller":"traceutil/trace.go:171","msg":"trace[347406014] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"248.824288ms","start":"2026-06-15T19:09:50.020388Z","end":"2026-06-15T19:09:50.269213Z","steps":["trace[347406014] 'process raft request' (duration: 248.476759ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:50.269924Z","caller":"traceutil/trace.go:171","msg":"trace[1515535781] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"249.470035ms","start":"2026-06-15T19:09:50.020428Z","end":"2026-06-15T19:09:50.269898Z","steps":["trace[1515535781] 'process raft request' (duration: 248.719845ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:50.270013Z","caller":"traceutil/trace.go:171","msg":"trace[332201990] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"249.509546ms","start":"2026-06-15T19:09:50.020457Z","end":"2026-06-15T19:09:50.269966Z","steps":["trace[332201990] 'process raft request' (duration: 249.28782ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:50.270068Z","caller":"traceutil/trace.go:171","msg":"trace[1533935266] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"249.331081ms","start":"2026-06-15T19:09:50.020712Z","end":"2026-06-15T19:09:50.270043Z","steps":["trace[1533935266] 'process raft request' (duration: 249.161107ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:50.463823Z","caller":"traceutil/trace.go:171","msg":"trace[1845262245] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"188.333406ms","start":"2026-06-15T19:09:50.27544Z","end":"2026-06-15T19:09:50.463774Z","steps":["trace[1845262245] 'process raft request' (duration: 109.481974ms)","trace[1845262245] 'compare' (duration: 78.522764ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:09:50.464053Z","caller":"traceutil/trace.go:171","msg":"trace[1160086495] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"172.797649ms","start":"2026-06-15T19:09:50.291217Z","end":"2026-06-15T19:09:50.464015Z","steps":["trace[1160086495] 'process raft request' (duration: 172.414709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:09:50.698838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.17628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:09:50.698949Z","caller":"traceutil/trace.go:171","msg":"trace[260451576] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"143.699989ms","start":"2026-06-15T19:09:50.555229Z","end":"2026-06-15T19:09:50.698929Z","steps":["trace[260451576] 'process raft request' (duration: 27.332955ms)","trace[260451576] 'compare' (duration: 115.945793ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:09:52.253803Z","caller":"traceutil/trace.go:171","msg":"trace[600022773] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"164.680418ms","start":"2026-06-15T19:09:52.089084Z","end":"2026-06-15T19:09:52.253764Z","steps":["trace[600022773] 'process raft request' (duration: 164.473233ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:53.342483Z","caller":"traceutil/trace.go:171","msg":"trace[2007519130] linearizableReadLoop","detail":"{readStateIndex:1983; appliedIndex:1982; }","duration":"115.543152ms","start":"2026-06-15T19:09:53.226906Z","end":"2026-06-15T19:09:53.342449Z","steps":["trace[2007519130] 'read index received' (duration: 115.362877ms)","trace[2007519130] 'applied index is now lower than readState.Index' (duration: 179.335µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:09:53.342605Z","caller":"traceutil/trace.go:171","msg":"trace[597888541] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"134.924549ms","start":"2026-06-15T19:09:53.20764Z","end":"2026-06-15T19:09:53.342564Z","steps":["trace[597888541] 'process raft request' (duration: 134.630691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:09:53.342712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.744928ms","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-15T19:09:53.342783Z","caller":"traceutil/trace.go:171","msg":"trace[190343106] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1900; }","duration":"115.890962ms","start":"2026-06-15T19:09:53.226873Z","end":"2026-06-15T19:09:53.342764Z","steps":["trace[190343106] 'agreement among raft nodes before linearized reading' (duration: 115.709966ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:10:00.560673Z","caller":"traceutil/trace.go:171","msg":"trace[456328258] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"158.328081ms","start":"2026-06-15T19:10:00.4023Z","end":"2026-06-15T19:10:00.560628Z","steps":["trace[456328258] 'process raft request' (duration: 69.544683ms)","trace[456328258] 'compare' (duration: 88.461149ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:10:00.560762Z","caller":"traceutil/trace.go:171","msg":"trace[1539909386] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"154.801839ms","start":"2026-06-15T19:10:00.405927Z","end":"2026-06-15T19:10:00.560729Z","steps":["trace[1539909386] 'process raft request' (duration: 154.642065ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:10:00.56069Z","caller":"traceutil/trace.go:171","msg":"trace[416337219] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"154.82291ms","start":"2026-06-15T19:10:00.405816Z","end":"2026-06-15T19:10:00.560639Z","steps":["trace[416337219] 'process raft request' (duration: 154.671716ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:10:00.561294Z","caller":"traceutil/trace.go:171","msg":"trace[1234823970] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"155.21712ms","start":"2026-06-15T19:10:00.406006Z","end":"2026-06-15T19:10:00.561223Z","steps":["trace[1234823970] 'process raft request' (duration: 154.603064ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:12:03.552306Z","caller":"traceutil/trace.go:171","msg":"trace[1621349956] linearizableReadLoop","detail":"{readStateIndex:2625; appliedIndex:2624; }","duration":"328.765769ms","start":"2026-06-15T19:12:03.223507Z","end":"2026-06-15T19:12:03.552273Z","steps":["trace[1621349956] 'read index received' (duration: 328.514602ms)","trace[1621349956] 'applied index is now lower than readState.Index' (duration: 249.817µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:12:03.55239Z","caller":"traceutil/trace.go:171","msg":"trace[1819889278] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"361.660613ms","start":"2026-06-15T19:12:03.19069Z","end":"2026-06-15T19:12:03.552351Z","steps":["trace[1819889278] 'process raft request' (duration: 361.390886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:12:03.552583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:12:03.190656Z","time spent":"361.803386ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:12:03.552639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.119817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T19:12:03.552683Z","caller":"traceutil/trace.go:171","msg":"trace[1598285068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2515; }","duration":"329.22494ms","start":"2026-06-15T19:12:03.223447Z","end":"2026-06-15T19:12:03.552672Z","steps":["trace[1598285068] 'agreement among raft nodes before linearized reading' (duration: 329.011164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:12:03.552722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:12:03.223421Z","time spent":"329.293092ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:12:03.552894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.339587ms","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-15T19:12:03.552928Z","caller":"traceutil/trace.go:171","msg":"trace[370768885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2515; }","duration":"328.372068ms","start":"2026-06-15T19:12:03.224547Z","end":"2026-06-15T19:12:03.552919Z","steps":["trace[370768885] 'agreement among raft nodes before linearized reading' (duration: 328.275926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:12:03.552961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:12:03.22453Z","time spent":"328.424429ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:12:03.552926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.299682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-15T19:12:03.553063Z","caller":"traceutil/trace.go:171","msg":"trace[775711998] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2515; }","duration":"329.525888ms","start":"2026-06-15T19:12:03.223511Z","end":"2026-06-15T19:12:03.553037Z","steps":["trace[775711998] 'agreement among raft nodes before linearized reading' (duration: 329.141078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:12:03.553137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:12:03.223485Z","time spent":"329.63567ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-15T19:12:10.881826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.531958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:12:10.881954Z","caller":"traceutil/trace.go:171","msg":"trace[2041492042] transaction","detail":"{read_only:false; response_revision:2556; number_of_response:1; }","duration":"433.259176ms","start":"2026-06-15T19:12:10.448672Z","end":"2026-06-15T19:12:10.881931Z","steps":["trace[2041492042] 'process raft request' (duration: 188.499232ms)","trace[2041492042] 'compare' (duration: 244.286322ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:12:10.882012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:12:10.448645Z","time spent":"433.339669ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}