{"level":"warn","ts":"2026-06-24T03:47:41.667566Z","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-24T03:47:41.667677Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-24T03:47:41.667759Z","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-24T03:47:41.667774Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-06-24T03:47:41.667802Z","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-24T03:47:41.668623Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-06-24T03:47:41.668704Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-24T03:47:41.674693Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.692797ms"} {"level":"info","ts":"2026-06-24T03:47:41.684633Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-06-24T03:47:41.684751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T03:47:41.684899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-06-24T03:47:41.684921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T03:47:41.684934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-06-24T03:47:41.685021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-06-24T03:47:41.690675Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T03:47:41.692185Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T03:47:41.694265Z","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-24T03:47:41.697882Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T03:47:41.698165Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T03:47:41.698322Z","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-24T03:47:41.698397Z","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-24T03:47:41.698417Z","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-24T03:47:41.699942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-06-24T03:47:41.700134Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-06-24T03:47:41.702157Z","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-24T03:47:41.702298Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-06-24T03:47:41.70233Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-06-24T03:47:41.702514Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T03:47:41.702555Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T03:47:41.885338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T03:47:41.885407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T03:47:41.885442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-06-24T03:47:41.885466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-06-24T03:47:41.885481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-06-24T03:47:41.885501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-06-24T03:47:41.885519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-06-24T03:47:41.887024Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T03:47:41.88704Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T03:47:41.887108Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T03:47:41.887159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T03:47:41.887649Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T03:47:41.8877Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T03:47:41.890259Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-06-24T03:47:41.890722Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T03:47:41.890891Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T03:47:41.890964Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T03:47:41.892459Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T03:47:52.480538Z","caller":"traceutil/trace.go:171","msg":"trace[388008256] linearizableReadLoop","detail":"{readStateIndex:379; appliedIndex:378; }","duration":"491.34382ms","start":"2026-06-24T03:47:51.989169Z","end":"2026-06-24T03:47:52.480513Z","steps":["trace[388008256] 'read index received' (duration: 474.262618ms)","trace[388008256] 'applied index is now lower than readState.Index' (duration: 17.080362ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:47:52.480644Z","caller":"traceutil/trace.go:171","msg":"trace[294719064] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"530.920296ms","start":"2026-06-24T03:47:51.94969Z","end":"2026-06-24T03:47:52.480611Z","steps":["trace[294719064] 'process raft request' (duration: 513.748951ms)","trace[294719064] 'compare' (duration: 16.97858ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:47:52.480709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.497894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-24T03:47:52.480855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.631132ms","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-24T03:47:52.48087Z","caller":"traceutil/trace.go:171","msg":"trace[486946931] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:363; }","duration":"491.617807ms","start":"2026-06-24T03:47:51.989133Z","end":"2026-06-24T03:47:52.480751Z","steps":["trace[486946931] 'agreement among raft nodes before linearized reading' (duration: 491.496704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.481072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:51.989119Z","time spent":"491.946036ms","remote":"127.0.0.1:39022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-06-24T03:47:52.480897Z","caller":"traceutil/trace.go:171","msg":"trace[1194507664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:363; }","duration":"468.708884ms","start":"2026-06-24T03:47:52.012179Z","end":"2026-06-24T03:47:52.480888Z","steps":["trace[1194507664] 'agreement among raft nodes before linearized reading' (duration: 468.603772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.481174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.720426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-06-24T03:47:52.481315Z","caller":"traceutil/trace.go:171","msg":"trace[44847437] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:363; }","duration":"391.915521ms","start":"2026-06-24T03:47:52.089367Z","end":"2026-06-24T03:47:52.481283Z","steps":["trace[44847437] 'agreement among raft nodes before linearized reading' (duration: 391.540382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.481318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:51.949676Z","time spent":"531.050799ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:47:52.481352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:52.012168Z","time spent":"469.066903ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T03:47:52.481386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:52.089351Z","time spent":"392.022643ms","remote":"127.0.0.1:39022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-06-24T03:47:52.480872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.574475ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:47:52.481471Z","caller":"traceutil/trace.go:171","msg":"trace[1655970892] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:363; }","duration":"376.182471ms","start":"2026-06-24T03:47:52.105279Z","end":"2026-06-24T03:47:52.481461Z","steps":["trace[1655970892] 'agreement among raft nodes before linearized reading' (duration: 375.542046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.480932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.009349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T03:47:52.481627Z","caller":"traceutil/trace.go:171","msg":"trace[1228422245] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:363; }","duration":"442.730807ms","start":"2026-06-24T03:47:52.038888Z","end":"2026-06-24T03:47:52.481619Z","steps":["trace[1228422245] 'agreement among raft nodes before linearized reading' (duration: 442.02191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.480989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.175711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T03:47:52.481658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:52.038875Z","time spent":"442.773578ms","remote":"127.0.0.1:39022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-06-24T03:47:52.481691Z","caller":"traceutil/trace.go:171","msg":"trace[1923770676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:363; }","duration":"132.923909ms","start":"2026-06-24T03:47:52.348731Z","end":"2026-06-24T03:47:52.481655Z","steps":["trace[1923770676] 'agreement among raft nodes before linearized reading' (duration: 132.215242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.481017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.041756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-24T03:47:52.481855Z","caller":"traceutil/trace.go:171","msg":"trace[1785583684] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:363; }","duration":"342.880986ms","start":"2026-06-24T03:47:52.138958Z","end":"2026-06-24T03:47:52.481839Z","steps":["trace[1785583684] 'agreement among raft nodes before linearized reading' (duration: 341.991125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:52.481889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:52.138919Z","time spent":"342.959788ms","remote":"127.0.0.1:39022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-06-24T03:47:53.449345Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236137577,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T03:47:53.472572Z","caller":"traceutil/trace.go:171","msg":"trace[1110414334] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"524.100142ms","start":"2026-06-24T03:47:52.948447Z","end":"2026-06-24T03:47:53.472548Z","steps":["trace[1110414334] 'read index received' (duration: 523.971139ms)","trace[1110414334] 'applied index is now lower than readState.Index' (duration: 128.263µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:47:53.472713Z","caller":"traceutil/trace.go:171","msg":"trace[1651433871] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"605.106627ms","start":"2026-06-24T03:47:52.867591Z","end":"2026-06-24T03:47:53.472698Z","steps":["trace[1651433871] 'process raft request' (duration: 604.827411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:53.472753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.348711ms","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-24T03:47:53.472855Z","caller":"traceutil/trace.go:171","msg":"trace[1146961761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:387; }","duration":"189.497355ms","start":"2026-06-24T03:47:53.283341Z","end":"2026-06-24T03:47:53.472839Z","steps":["trace[1146961761] 'agreement among raft nodes before linearized reading' (duration: 189.346971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:53.472921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.435489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"warn","ts":"2026-06-24T03:47:53.472998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:52.867562Z","time spent":"605.310232ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:47:53.473038Z","caller":"traceutil/trace.go:171","msg":"trace[1495822653] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:387; }","duration":"524.580683ms","start":"2026-06-24T03:47:52.948432Z","end":"2026-06-24T03:47:53.473012Z","steps":["trace[1495822653] 'agreement among raft nodes before linearized reading' (duration: 524.235445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:53.473201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:52.948382Z","time spent":"524.791719ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5359,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-06-24T03:47:53.976479Z","caller":"traceutil/trace.go:171","msg":"trace[1775465204] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"499.466406ms","start":"2026-06-24T03:47:53.476986Z","end":"2026-06-24T03:47:53.976453Z","steps":["trace[1775465204] 'process raft request' (duration: 493.690947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:53.976644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:53.476967Z","time spent":"499.572009ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:47:53.977088Z","caller":"traceutil/trace.go:171","msg":"trace[2106350708] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"214.59348ms","start":"2026-06-24T03:47:53.762467Z","end":"2026-06-24T03:47:53.977061Z","steps":["trace[2106350708] 'process raft request' (duration: 214.540778ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:47:53.977162Z","caller":"traceutil/trace.go:171","msg":"trace[1156547839] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"497.625472ms","start":"2026-06-24T03:47:53.4795Z","end":"2026-06-24T03:47:53.977126Z","steps":["trace[1156547839] 'process raft request' (duration: 497.406667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:53.977385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:53.479487Z","time spent":"497.800596ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:47:55.696282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.080808ms","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-24T03:47:55.696357Z","caller":"traceutil/trace.go:171","msg":"trace[686385821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:390; }","duration":"219.186291ms","start":"2026-06-24T03:47:55.477153Z","end":"2026-06-24T03:47:55.69634Z","steps":["trace[686385821] 'range keys from in-memory index tree' (duration: 219.011986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:55.696371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202825225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:47:55.69641Z","caller":"traceutil/trace.go:171","msg":"trace[1850045845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:390; }","duration":"1.202884877s","start":"2026-06-24T03:47:54.493514Z","end":"2026-06-24T03:47:55.696399Z","steps":["trace[1850045845] 'range keys from in-memory index tree' (duration: 1.202760713s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:55.696446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:54.493502Z","time spent":"1.202935128s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T03:47:55.696454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.392112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-24T03:47:55.696535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203615104s","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-24T03:47:55.696539Z","caller":"traceutil/trace.go:171","msg":"trace[705402134] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:390; }","duration":"455.510155ms","start":"2026-06-24T03:47:55.241006Z","end":"2026-06-24T03:47:55.696517Z","steps":["trace[705402134] 'range keys from in-memory index tree' (duration: 455.31246ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:47:55.696561Z","caller":"traceutil/trace.go:171","msg":"trace[408010938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:390; }","duration":"1.203694006s","start":"2026-06-24T03:47:54.492859Z","end":"2026-06-24T03:47:55.696553Z","steps":["trace[408010938] 'range keys from in-memory index tree' (duration: 1.203515872s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:47:55.696586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:54.492826Z","time spent":"1.203754637s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T03:47:55.696592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:47:55.240991Z","time spent":"455.586247ms","remote":"127.0.0.1:38902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.246\" "} {"level":"warn","ts":"2026-06-24T03:48:24.538373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.736133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T03:48:24.53855Z","caller":"traceutil/trace.go:171","msg":"trace[346570800] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:555; }","duration":"636.855843ms","start":"2026-06-24T03:48:23.901674Z","end":"2026-06-24T03:48:24.53853Z","steps":["trace[346570800] 'read index received' (duration: 43.438705ms)","trace[346570800] 'applied index is now lower than readState.Index' (duration: 593.415988ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:48:24.538639Z","caller":"traceutil/trace.go:171","msg":"trace[1839225794] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"668.273378ms","start":"2026-06-24T03:48:23.870355Z","end":"2026-06-24T03:48:24.538628Z","steps":["trace[1839225794] 'process raft request' (duration: 247.072284ms)","trace[1839225794] 'compare' (duration: 420.621791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:48:24.538698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:23.870338Z","time spent":"668.32801ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:48:24.538968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.268313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:24.539043Z","caller":"traceutil/trace.go:171","msg":"trace[774156405] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:534; }","duration":"637.382326ms","start":"2026-06-24T03:48:23.901641Z","end":"2026-06-24T03:48:24.539023Z","steps":["trace[774156405] 'agreement among raft nodes before linearized reading' (duration: 637.241713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:24.539086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:23.901625Z","time spent":"637.453227ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-06-24T03:48:24.539088Z","caller":"traceutil/trace.go:171","msg":"trace[1232506607] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"668.138405ms","start":"2026-06-24T03:48:23.870938Z","end":"2026-06-24T03:48:24.539076Z","steps":["trace[1232506607] 'process raft request' (duration: 667.533431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:24.53913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.455948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-24T03:48:24.53916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:23.870926Z","time spent":"668.201117ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:48:24.539189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.319134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:24.539203Z","caller":"traceutil/trace.go:171","msg":"trace[2071755831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:534; }","duration":"435.53679ms","start":"2026-06-24T03:48:24.103646Z","end":"2026-06-24T03:48:24.539183Z","steps":["trace[2071755831] 'agreement among raft nodes before linearized reading' (duration: 435.330955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:24.539248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.103589Z","time spent":"435.650512ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T03:48:24.539247Z","caller":"traceutil/trace.go:171","msg":"trace[1007749803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"127.377955ms","start":"2026-06-24T03:48:24.411851Z","end":"2026-06-24T03:48:24.539229Z","steps":["trace[1007749803] 'agreement among raft nodes before linearized reading' (duration: 127.268892ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:24.924893Z","caller":"traceutil/trace.go:171","msg":"trace[1356578812] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"115.325985ms","start":"2026-06-24T03:48:24.809514Z","end":"2026-06-24T03:48:24.92484Z","steps":["trace[1356578812] 'process raft request' (duration: 115.183901ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.202455Z","caller":"traceutil/trace.go:171","msg":"trace[205821122] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"378.180709ms","start":"2026-06-24T03:48:24.824232Z","end":"2026-06-24T03:48:25.202412Z","steps":["trace[205821122] 'process raft request' (duration: 377.978354ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.202467Z","caller":"traceutil/trace.go:171","msg":"trace[290472221] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"386.573032ms","start":"2026-06-24T03:48:24.815864Z","end":"2026-06-24T03:48:25.202437Z","steps":["trace[290472221] 'process raft request' (duration: 386.174542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.202607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.815839Z","time spent":"386.706764ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T03:48:25.202615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.824204Z","time spent":"378.338183ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T03:48:25.202721Z","caller":"traceutil/trace.go:171","msg":"trace[1402200067] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"364.151022ms","start":"2026-06-24T03:48:24.838545Z","end":"2026-06-24T03:48:25.202696Z","steps":["trace[1402200067] 'process raft request' (duration: 363.831164ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.202755Z","caller":"traceutil/trace.go:171","msg":"trace[2097321738] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"331.322302ms","start":"2026-06-24T03:48:24.871423Z","end":"2026-06-24T03:48:25.202745Z","steps":["trace[2097321738] 'process raft request' (duration: 331.115007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.203263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.838525Z","time spent":"364.233324ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T03:48:25.203384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.871403Z","time spent":"331.929126ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T03:48:25.203396Z","caller":"traceutil/trace.go:171","msg":"trace[1877512186] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"309.24069ms","start":"2026-06-24T03:48:24.894125Z","end":"2026-06-24T03:48:25.203366Z","steps":["trace[1877512186] 'process raft request' (duration: 308.594285ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.20353Z","caller":"traceutil/trace.go:171","msg":"trace[1766250697] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"366.810606ms","start":"2026-06-24T03:48:24.836602Z","end":"2026-06-24T03:48:25.203413Z","steps":["trace[1766250697] 'process raft request' (duration: 365.662149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.203583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.894113Z","time spent":"309.391165ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T03:48:25.203688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.836584Z","time spent":"367.045392ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T03:48:25.203819Z","caller":"traceutil/trace.go:171","msg":"trace[1442396801] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"338.157216ms","start":"2026-06-24T03:48:24.865328Z","end":"2026-06-24T03:48:25.203485Z","steps":["trace[1442396801] 'process raft request' (duration: 337.135321ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.203895Z","caller":"traceutil/trace.go:171","msg":"trace[853758018] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"366.9874ms","start":"2026-06-24T03:48:24.836721Z","end":"2026-06-24T03:48:25.203708Z","steps":["trace[853758018] 'process raft request' (duration: 365.600307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.203905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.865308Z","time spent":"338.555826ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T03:48:25.203984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.836717Z","time spent":"367.238556ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T03:48:25.204013Z","caller":"traceutil/trace.go:171","msg":"trace[1630324366] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"326.859315ms","start":"2026-06-24T03:48:24.877033Z","end":"2026-06-24T03:48:25.203892Z","steps":["trace[1630324366] 'process raft request' (duration: 325.551753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.204099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.877011Z","time spent":"327.04806ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T03:48:25.204392Z","caller":"traceutil/trace.go:171","msg":"trace[1848410556] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"324.371315ms","start":"2026-06-24T03:48:24.879983Z","end":"2026-06-24T03:48:25.204354Z","steps":["trace[1848410556] 'process raft request' (duration: 322.658424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.204503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.879966Z","time spent":"324.472037ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:48:25.204923Z","caller":"traceutil/trace.go:171","msg":"trace[430537095] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"306.947765ms","start":"2026-06-24T03:48:24.897947Z","end":"2026-06-24T03:48:25.204895Z","steps":["trace[430537095] 'process raft request' (duration: 305.341536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:25.204994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:24.897925Z","time spent":"307.037818ms","remote":"127.0.0.1:38916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T03:48:25.216328Z","caller":"traceutil/trace.go:171","msg":"trace[630023520] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"207.238476ms","start":"2026-06-24T03:48:25.009075Z","end":"2026-06-24T03:48:25.216313Z","steps":["trace[630023520] 'process raft request' (duration: 207.196155ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.216558Z","caller":"traceutil/trace.go:171","msg":"trace[1440948361] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"284.989708ms","start":"2026-06-24T03:48:24.931562Z","end":"2026-06-24T03:48:25.216552Z","steps":["trace[1440948361] 'process raft request' (duration: 284.563157ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.216648Z","caller":"traceutil/trace.go:171","msg":"trace[1292048835] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"283.210435ms","start":"2026-06-24T03:48:24.933432Z","end":"2026-06-24T03:48:25.216643Z","steps":["trace[1292048835] 'process raft request' (duration: 282.761434ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:25.216705Z","caller":"traceutil/trace.go:171","msg":"trace[121992637] transaction","detail":"{read_only:false; number_of_response:1; response_revision:549; }","duration":"282.654531ms","start":"2026-06-24T03:48:24.934046Z","end":"2026-06-24T03:48:25.216701Z","steps":["trace[121992637] 'process raft request' (duration: 282.17728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:28.168888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.529003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:28.168997Z","caller":"traceutil/trace.go:171","msg":"trace[994145690] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:622; }","duration":"102.332493ms","start":"2026-06-24T03:48:28.066639Z","end":"2026-06-24T03:48:28.168971Z","steps":["trace[994145690] 'range keys from in-memory index tree' (duration: 101.472532ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:30.100634Z","caller":"traceutil/trace.go:171","msg":"trace[1426166605] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"114.692309ms","start":"2026-06-24T03:48:29.985913Z","end":"2026-06-24T03:48:30.100605Z","steps":["trace[1426166605] 'process raft request' (duration: 114.505705ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:30.245723Z","caller":"traceutil/trace.go:171","msg":"trace[496403941] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"190.241938ms","start":"2026-06-24T03:48:30.055457Z","end":"2026-06-24T03:48:30.245699Z","steps":["trace[496403941] 'process raft request' (duration: 189.689935ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:31.368073Z","caller":"traceutil/trace.go:171","msg":"trace[1218251620] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"312.174731ms","start":"2026-06-24T03:48:31.055878Z","end":"2026-06-24T03:48:31.368053Z","steps":["trace[1218251620] 'process raft request' (duration: 312.019227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:31.368231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:31.055853Z","time spent":"312.283874ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:48:31.520346Z","caller":"traceutil/trace.go:171","msg":"trace[1639860726] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"109.006413ms","start":"2026-06-24T03:48:31.411314Z","end":"2026-06-24T03:48:31.52032Z","steps":["trace[1639860726] 'read index received' (duration: 108.204694ms)","trace[1639860726] 'applied index is now lower than readState.Index' (duration: 800.839µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:48:31.520466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.137776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:31.520504Z","caller":"traceutil/trace.go:171","msg":"trace[711672100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"109.224419ms","start":"2026-06-24T03:48:31.411269Z","end":"2026-06-24T03:48:31.520494Z","steps":["trace[711672100] 'agreement among raft nodes before linearized reading' (duration: 109.148087ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:31.521124Z","caller":"traceutil/trace.go:171","msg":"trace[1552380934] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"274.209998ms","start":"2026-06-24T03:48:31.246724Z","end":"2026-06-24T03:48:31.520934Z","steps":["trace[1552380934] 'process raft request' (duration: 273.068531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:33.028334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.345422ms","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-24T03:48:33.028467Z","caller":"traceutil/trace.go:171","msg":"trace[2046883489] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:644; }","duration":"230.487606ms","start":"2026-06-24T03:48:32.797959Z","end":"2026-06-24T03:48:33.028447Z","steps":["trace[2046883489] 'range keys from in-memory index tree' (duration: 230.327722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:33.02888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.117729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T03:48:33.029034Z","caller":"traceutil/trace.go:171","msg":"trace[33320429] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"924.439894ms","start":"2026-06-24T03:48:32.10457Z","end":"2026-06-24T03:48:33.02901Z","steps":["trace[33320429] 'read index received' (duration: 124.909816ms)","trace[33320429] 'applied index is now lower than readState.Index' (duration: 799.528358ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:48:33.029073Z","caller":"traceutil/trace.go:171","msg":"trace[782827672] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.451442165s","start":"2026-06-24T03:48:31.577579Z","end":"2026-06-24T03:48:33.029022Z","steps":["trace[782827672] 'process raft request' (duration: 652.003679ms)","trace[782827672] 'compare' (duration: 798.860982ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:48:33.029254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:31.577559Z","time spent":"1.451603548s","remote":"127.0.0.1:39344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T03:48:33.029268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.69351ms","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-24T03:48:33.029269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.125105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T03:48:33.029351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.036784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:48:33.029365Z","caller":"traceutil/trace.go:171","msg":"trace[919951455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"924.827623ms","start":"2026-06-24T03:48:32.104519Z","end":"2026-06-24T03:48:33.029346Z","steps":["trace[919951455] 'agreement among raft nodes before linearized reading' (duration: 924.546757ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:33.02938Z","caller":"traceutil/trace.go:171","msg":"trace[88571439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"616.31222ms","start":"2026-06-24T03:48:32.413046Z","end":"2026-06-24T03:48:33.029358Z","steps":["trace[88571439] 'agreement among raft nodes before linearized reading' (duration: 616.124605ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:33.02941Z","caller":"traceutil/trace.go:171","msg":"trace[920092682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"407.124257ms","start":"2026-06-24T03:48:32.622269Z","end":"2026-06-24T03:48:33.029393Z","steps":["trace[920092682] 'agreement among raft nodes before linearized reading' (duration: 406.899321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:33.029411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:32.1045Z","time spent":"924.902705ms","remote":"127.0.0.1:39090","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-24T03:48:33.02942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:32.413022Z","time spent":"616.387711ms","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T03:48:33.029457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:32.622259Z","time spent":"407.187938ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T03:48:33.029498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.770436ms","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-24T03:48:33.029896Z","caller":"traceutil/trace.go:171","msg":"trace[1262203610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"313.212597ms","start":"2026-06-24T03:48:32.716656Z","end":"2026-06-24T03:48:33.029869Z","steps":["trace[1262203610] 'agreement among raft nodes before linearized reading' (duration: 312.558801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:33.030058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:32.71664Z","time spent":"313.307199ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T03:48:33.030463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.646296ms","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-24T03:48:33.030533Z","caller":"traceutil/trace.go:171","msg":"trace[422074207] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"416.754259ms","start":"2026-06-24T03:48:32.613761Z","end":"2026-06-24T03:48:33.030515Z","steps":["trace[422074207] 'agreement among raft nodes before linearized reading' (duration: 415.813606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:33.030582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:32.613741Z","time spent":"416.83018ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T03:48:34.72819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.940713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:34.728254Z","caller":"traceutil/trace.go:171","msg":"trace[1017537191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"316.051275ms","start":"2026-06-24T03:48:34.412187Z","end":"2026-06-24T03:48:34.728238Z","steps":["trace[1017537191] 'range keys from in-memory index tree' (duration: 315.84488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:34.728284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:34.412169Z","time spent":"316.109086ms","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T03:48:45.292751Z","caller":"traceutil/trace.go:171","msg":"trace[1436346211] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"195.254538ms","start":"2026-06-24T03:48:45.09748Z","end":"2026-06-24T03:48:45.292734Z","steps":["trace[1436346211] 'process raft request' (duration: 195.155996ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:45.300818Z","caller":"traceutil/trace.go:171","msg":"trace[2033558365] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"201.98381ms","start":"2026-06-24T03:48:45.098811Z","end":"2026-06-24T03:48:45.300795Z","steps":["trace[2033558365] 'process raft request' (duration: 201.616311ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:45.300877Z","caller":"traceutil/trace.go:171","msg":"trace[1689925332] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"201.509949ms","start":"2026-06-24T03:48:45.099349Z","end":"2026-06-24T03:48:45.300859Z","steps":["trace[1689925332] 'process raft request' (duration: 201.280523ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:45.300922Z","caller":"traceutil/trace.go:171","msg":"trace[1979733625] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"201.258623ms","start":"2026-06-24T03:48:45.099653Z","end":"2026-06-24T03:48:45.300912Z","steps":["trace[1979733625] 'process raft request' (duration: 201.079699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.352348Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236138396,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T03:48:48.63343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221148762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:48.633765Z","caller":"traceutil/trace.go:171","msg":"trace[1589036178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:808; }","duration":"1.221521971s","start":"2026-06-24T03:48:47.41222Z","end":"2026-06-24T03:48:48.633742Z","steps":["trace[1589036178] 'range keys from in-memory index tree' (duration: 1.220848535s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.633819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:47.4122Z","time spent":"1.221609064s","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T03:48:48.853063Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236138396,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T03:48:48.923353Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.304672892s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T03:48:48.923753Z","caller":"traceutil/trace.go:171","msg":"trace[241850918] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"1.305153903s","start":"2026-06-24T03:48:47.618578Z","end":"2026-06-24T03:48:48.923732Z","steps":["trace[241850918] 'process raft request' (duration: 1.3050145s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.923894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:47.618554Z","time spent":"1.305268226s","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:48:48.932017Z","caller":"traceutil/trace.go:171","msg":"trace[613360905] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:844; }","duration":"1.080040078s","start":"2026-06-24T03:48:47.851965Z","end":"2026-06-24T03:48:48.932005Z","steps":["trace[613360905] 'read index received' (duration: 1.071688717s)","trace[613360905] 'applied index is now lower than readState.Index' (duration: 8.350771ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:48:48.932084Z","caller":"traceutil/trace.go:171","msg":"trace[1688727731] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"498.231548ms","start":"2026-06-24T03:48:48.433847Z","end":"2026-06-24T03:48:48.932079Z","steps":["trace[1688727731] 'process raft request' (duration: 498.081115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.932125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:48.433819Z","time spent":"498.27918ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:48:48.932258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080289204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T03:48:48.932308Z","caller":"traceutil/trace.go:171","msg":"trace[1381211643] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:811; }","duration":"1.080368366s","start":"2026-06-24T03:48:47.851925Z","end":"2026-06-24T03:48:48.932293Z","steps":["trace[1381211643] 'agreement among raft nodes before linearized reading' (duration: 1.080308184s)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:48:48.932299Z","caller":"traceutil/trace.go:171","msg":"trace[161542984] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"780.801228ms","start":"2026-06-24T03:48:48.151472Z","end":"2026-06-24T03:48:48.932274Z","steps":["trace[161542984] 'process raft request' (duration: 780.398268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.93237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065639351s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T03:48:48.932389Z","caller":"traceutil/trace.go:171","msg":"trace[1416403037] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:811; }","duration":"1.065679743s","start":"2026-06-24T03:48:47.866704Z","end":"2026-06-24T03:48:48.932383Z","steps":["trace[1416403037] 'agreement among raft nodes before linearized reading' (duration: 1.065649422s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.932407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:47.866692Z","time spent":"1.065710933s","remote":"127.0.0.1:39264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-24T03:48:48.932449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:48.151449Z","time spent":"780.923011ms","remote":"127.0.0.1:39060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:48:48.932518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.621991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:48:48.93254Z","caller":"traceutil/trace.go:171","msg":"trace[74283056] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"297.681742ms","start":"2026-06-24T03:48:48.634853Z","end":"2026-06-24T03:48:48.932535Z","steps":["trace[74283056] 'agreement among raft nodes before linearized reading' (duration: 297.648152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:48:48.932334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:48:47.851907Z","time spent":"1.080421226s","remote":"127.0.0.1:39074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-06-24T03:48:48.932713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.848813ms","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-24T03:48:48.932842Z","caller":"traceutil/trace.go:171","msg":"trace[1418688817] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"105.020107ms","start":"2026-06-24T03:48:48.827802Z","end":"2026-06-24T03:48:48.932822Z","steps":["trace[1418688817] 'agreement among raft nodes before linearized reading' (duration: 104.662869ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:45.387127Z","caller":"traceutil/trace.go:171","msg":"trace[1243910590] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1146; }","duration":"121.698949ms","start":"2026-06-24T03:49:45.265379Z","end":"2026-06-24T03:49:45.387078Z","steps":["trace[1243910590] 'read index received' (duration: 121.364341ms)","trace[1243910590] 'applied index is now lower than readState.Index' (duration: 331.738µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:49:45.387466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.058259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T03:49:45.388138Z","caller":"traceutil/trace.go:171","msg":"trace[4282227] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1097; }","duration":"122.770176ms","start":"2026-06-24T03:49:45.265332Z","end":"2026-06-24T03:49:45.388102Z","steps":["trace[4282227] 'agreement among raft nodes before linearized reading' (duration: 121.918166ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:45.892571Z","caller":"traceutil/trace.go:171","msg":"trace[104864120] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"549.270173ms","start":"2026-06-24T03:49:45.343276Z","end":"2026-06-24T03:49:45.892546Z","steps":["trace[104864120] 'process raft request' (duration: 480.64765ms)","trace[104864120] 'compare' (duration: 68.349567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:49:45.89291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.343259Z","time spent":"549.584232ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:49:45.954923Z","caller":"traceutil/trace.go:171","msg":"trace[1594415255] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1147; }","duration":"409.855165ms","start":"2026-06-24T03:49:45.545042Z","end":"2026-06-24T03:49:45.954897Z","steps":["trace[1594415255] 'read index received' (duration: 278.88594ms)","trace[1594415255] 'applied index is now lower than readState.Index' (duration: 130.968455ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:49:45.955131Z","caller":"traceutil/trace.go:171","msg":"trace[590808290] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"566.545963ms","start":"2026-06-24T03:49:45.388565Z","end":"2026-06-24T03:49:45.955111Z","steps":["trace[590808290] 'process raft request' (duration: 566.104812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:45.955366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.388547Z","time spent":"566.637465ms","remote":"127.0.0.1:38902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:49:45.955963Z","caller":"traceutil/trace.go:171","msg":"trace[1001345896] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"561.054219ms","start":"2026-06-24T03:49:45.394898Z","end":"2026-06-24T03:49:45.955952Z","steps":["trace[1001345896] 'process raft request' (duration: 559.955853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:45.956028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.394887Z","time spent":"561.10856ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:49:45.956063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.949589ms","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-24T03:49:45.956154Z","caller":"traceutil/trace.go:171","msg":"trace[728835469] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1100; }","duration":"406.093083ms","start":"2026-06-24T03:49:45.550041Z","end":"2026-06-24T03:49:45.956134Z","steps":["trace[728835469] 'agreement among raft nodes before linearized reading' (duration: 405.851697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:45.956202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.550023Z","time spent":"406.170165ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T03:49:45.956197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.183395ms","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-24T03:49:45.956259Z","caller":"traceutil/trace.go:171","msg":"trace[467220674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1100; }","duration":"406.263127ms","start":"2026-06-24T03:49:45.549977Z","end":"2026-06-24T03:49:45.95624Z","steps":["trace[467220674] 'agreement among raft nodes before linearized reading' (duration: 406.113114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:45.956273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.242658ms","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-24T03:49:45.956307Z","caller":"traceutil/trace.go:171","msg":"trace[2137914354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1100; }","duration":"411.3167ms","start":"2026-06-24T03:49:45.544981Z","end":"2026-06-24T03:49:45.956297Z","steps":["trace[2137914354] 'agreement among raft nodes before linearized reading' (duration: 411.173166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:45.956308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.549966Z","time spent":"406.334029ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T03:49:45.956342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.544957Z","time spent":"411.379091ms","remote":"127.0.0.1:39090","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-24T03:49:45.955963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.252117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:49:45.956535Z","caller":"traceutil/trace.go:171","msg":"trace[1971923374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1100; }","duration":"406.869982ms","start":"2026-06-24T03:49:45.549646Z","end":"2026-06-24T03:49:45.956516Z","steps":["trace[1971923374] 'agreement among raft nodes before linearized reading' (duration: 406.009301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:45.956663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:45.54963Z","time spent":"407.018395ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T03:49:46.071702Z","caller":"traceutil/trace.go:171","msg":"trace[454071696] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"111.135704ms","start":"2026-06-24T03:49:45.960545Z","end":"2026-06-24T03:49:46.07168Z","steps":["trace[454071696] 'process raft request' (duration: 97.180596ms)","trace[454071696] 'compare' (duration: 13.808845ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:49:46.072077Z","caller":"traceutil/trace.go:171","msg":"trace[1153877716] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"110.989231ms","start":"2026-06-24T03:49:45.961067Z","end":"2026-06-24T03:49:46.072056Z","steps":["trace[1153877716] 'process raft request' (duration: 110.580531ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:46.072207Z","caller":"traceutil/trace.go:171","msg":"trace[794903526] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"110.411307ms","start":"2026-06-24T03:49:45.961779Z","end":"2026-06-24T03:49:46.07219Z","steps":["trace[794903526] 'process raft request' (duration: 110.070759ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:47.500238Z","caller":"traceutil/trace.go:171","msg":"trace[151690104] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1154; }","duration":"487.016544ms","start":"2026-06-24T03:49:47.013198Z","end":"2026-06-24T03:49:47.500215Z","steps":["trace[151690104] 'read index received' (duration: 486.884831ms)","trace[151690104] 'applied index is now lower than readState.Index' (duration: 130.683µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:49:47.500358Z","caller":"traceutil/trace.go:171","msg":"trace[807595189] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"519.261036ms","start":"2026-06-24T03:49:46.981068Z","end":"2026-06-24T03:49:47.500329Z","steps":["trace[807595189] 'process raft request' (duration: 519.00046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:47.500425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.188199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:49:47.500465Z","caller":"traceutil/trace.go:171","msg":"trace[974601068] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1105; }","duration":"487.290851ms","start":"2026-06-24T03:49:47.013163Z","end":"2026-06-24T03:49:47.500454Z","steps":["trace[974601068] 'agreement among raft nodes before linearized reading' (duration: 487.189089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:47.500504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:47.013148Z","time spent":"487.345902ms","remote":"127.0.0.1:47604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T03:49:47.500501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:46.981041Z","time spent":"519.38484ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:49:48.208741Z","caller":"traceutil/trace.go:171","msg":"trace[25067586] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"310.515747ms","start":"2026-06-24T03:49:47.898194Z","end":"2026-06-24T03:49:48.20871Z","steps":["trace[25067586] 'process raft request' (duration: 310.331892ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:48.208828Z","caller":"traceutil/trace.go:171","msg":"trace[286557115] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1156; }","duration":"246.583467ms","start":"2026-06-24T03:49:47.962214Z","end":"2026-06-24T03:49:48.208798Z","steps":["trace[286557115] 'read index received' (duration: 246.542286ms)","trace[286557115] 'applied index is now lower than readState.Index' (duration: 7.12µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:49:48.208972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:47.898156Z","time spent":"310.704161ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:49:48.20913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.59223ms","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-24T03:49:48.209176Z","caller":"traceutil/trace.go:171","msg":"trace[1751807095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1106; }","duration":"223.697143ms","start":"2026-06-24T03:49:47.985466Z","end":"2026-06-24T03:49:48.209163Z","steps":["trace[1751807095] 'agreement among raft nodes before linearized reading' (duration: 223.459687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.209187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.751527ms","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-24T03:49:48.209271Z","caller":"traceutil/trace.go:171","msg":"trace[685353357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1106; }","duration":"132.868151ms","start":"2026-06-24T03:49:48.076383Z","end":"2026-06-24T03:49:48.209251Z","steps":["trace[685353357] 'agreement among raft nodes before linearized reading' (duration: 132.616715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.209285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.83657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:49:48.209338Z","caller":"traceutil/trace.go:171","msg":"trace[2010393181] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1106; }","duration":"198.920741ms","start":"2026-06-24T03:49:48.010403Z","end":"2026-06-24T03:49:48.209324Z","steps":["trace[2010393181] 'agreement among raft nodes before linearized reading' (duration: 198.823779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.209373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.250994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:49:48.209446Z","caller":"traceutil/trace.go:171","msg":"trace[1351237757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1106; }","duration":"134.379187ms","start":"2026-06-24T03:49:48.075048Z","end":"2026-06-24T03:49:48.209427Z","steps":["trace[1351237757] 'agreement among raft nodes before linearized reading' (duration: 134.158672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.209517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.302835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T03:49:48.209553Z","caller":"traceutil/trace.go:171","msg":"trace[1830460248] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1106; }","duration":"247.396357ms","start":"2026-06-24T03:49:47.962147Z","end":"2026-06-24T03:49:48.209544Z","steps":["trace[1830460248] 'agreement among raft nodes before linearized reading' (duration: 247.271614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.209674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.106121ms","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-24T03:49:48.209729Z","caller":"traceutil/trace.go:171","msg":"trace[725985602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1106; }","duration":"134.164352ms","start":"2026-06-24T03:49:48.075552Z","end":"2026-06-24T03:49:48.209716Z","steps":["trace[725985602] 'agreement among raft nodes before linearized reading' (duration: 133.809423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.653395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.320781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T03:49:48.653681Z","caller":"traceutil/trace.go:171","msg":"trace[888177454] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1157; }","duration":"241.368961ms","start":"2026-06-24T03:49:48.412295Z","end":"2026-06-24T03:49:48.653664Z","steps":["trace[888177454] 'read index received' (duration: 30.641µs)","trace[888177454] 'applied index is now lower than readState.Index' (duration: 241.33717ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:49:48.653771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.473293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:49:48.653816Z","caller":"traceutil/trace.go:171","msg":"trace[2013500807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1111; }","duration":"241.552885ms","start":"2026-06-24T03:49:48.412252Z","end":"2026-06-24T03:49:48.653804Z","steps":["trace[2013500807] 'agreement among raft nodes before linearized reading' (duration: 241.466533ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:48.653941Z","caller":"traceutil/trace.go:171","msg":"trace[1825558355] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"439.251287ms","start":"2026-06-24T03:49:48.214645Z","end":"2026-06-24T03:49:48.653896Z","steps":["trace[1825558355] 'process raft request' (duration: 438.866488ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:48.65399Z","caller":"traceutil/trace.go:171","msg":"trace[1108618520] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"439.279678ms","start":"2026-06-24T03:49:48.214678Z","end":"2026-06-24T03:49:48.653957Z","steps":["trace[1108618520] 'process raft request' (duration: 438.917139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.65407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:48.21464Z","time spent":"439.36255ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:49:48.654103Z","caller":"traceutil/trace.go:171","msg":"trace[2117329145] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"439.337439ms","start":"2026-06-24T03:49:48.21475Z","end":"2026-06-24T03:49:48.654087Z","steps":["trace[2117329145] 'process raft request' (duration: 438.878918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:48.654133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:48.214674Z","time spent":"439.38463ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:49:48.654168Z","caller":"traceutil/trace.go:171","msg":"trace[2067849837] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"439.571655ms","start":"2026-06-24T03:49:48.214586Z","end":"2026-06-24T03:49:48.654158Z","steps":["trace[2067849837] 'process raft request' (duration: 100.394503ms)","trace[2067849837] 'compare' (duration: 338.084255ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:49:48.654185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:48.214745Z","time spent":"439.39429ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:49:48.654203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:49:48.214578Z","time spent":"439.608545ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:49:49.083501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.726639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:49:49.083585Z","caller":"traceutil/trace.go:171","msg":"trace[1091663730] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1111; }","duration":"156.869202ms","start":"2026-06-24T03:49:48.9267Z","end":"2026-06-24T03:49:49.083569Z","steps":["trace[1091663730] 'count revisions from in-memory index tree' (duration: 156.629956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:49.083707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.384379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T03:49:49.083782Z","caller":"traceutil/trace.go:171","msg":"trace[1359247746] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1111; }","duration":"212.528082ms","start":"2026-06-24T03:49:48.871239Z","end":"2026-06-24T03:49:49.083767Z","steps":["trace[1359247746] 'count revisions from in-memory index tree' (duration: 212.266365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:49:49.083807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.608771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:49:49.08388Z","caller":"traceutil/trace.go:171","msg":"trace[855421946] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1111; }","duration":"162.697933ms","start":"2026-06-24T03:49:48.921163Z","end":"2026-06-24T03:49:49.083861Z","steps":["trace[855421946] 'count revisions from in-memory index tree' (duration: 162.489099ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:49:50.030107Z","caller":"traceutil/trace.go:171","msg":"trace[1866461900] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"140.161216ms","start":"2026-06-24T03:49:49.889929Z","end":"2026-06-24T03:49:50.03009Z","steps":["trace[1866461900] 'process raft request' (duration: 140.054464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:05.241247Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236139363,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T03:50:05.742083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236139363,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T03:50:06.033007Z","caller":"traceutil/trace.go:171","msg":"trace[1864859906] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"1.291954515s","start":"2026-06-24T03:50:04.741034Z","end":"2026-06-24T03:50:06.032989Z","steps":["trace[1864859906] 'read index received' (duration: 1.291841493s)","trace[1864859906] 'applied index is now lower than readState.Index' (duration: 112.312µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:50:06.033099Z","caller":"traceutil/trace.go:171","msg":"trace[797988176] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"1.293883043s","start":"2026-06-24T03:50:04.739207Z","end":"2026-06-24T03:50:06.03309Z","steps":["trace[797988176] 'process raft request' (duration: 1.293668338s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.033192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:04.739191Z","time spent":"1.293933504s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:50:06.033296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.544096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T03:50:06.033289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292123409s","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-24T03:50:06.033314Z","caller":"traceutil/trace.go:171","msg":"trace[1076671815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1211; }","duration":"621.588386ms","start":"2026-06-24T03:50:05.411719Z","end":"2026-06-24T03:50:06.033307Z","steps":["trace[1076671815] 'agreement among raft nodes before linearized reading' (duration: 621.560855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.033333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:05.411703Z","time spent":"621.626548ms","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T03:50:06.033342Z","caller":"traceutil/trace.go:171","msg":"trace[903243403] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1211; }","duration":"1.292213582s","start":"2026-06-24T03:50:04.741112Z","end":"2026-06-24T03:50:06.033326Z","steps":["trace[903243403] 'agreement among raft nodes before linearized reading' (duration: 1.292050518s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.033379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:04.741093Z","time spent":"1.292277794s","remote":"127.0.0.1:39090","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-24T03:50:06.033503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292467268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T03:50:06.033508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.028491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T03:50:06.03352Z","caller":"traceutil/trace.go:171","msg":"trace[336087956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1211; }","duration":"1.292499839s","start":"2026-06-24T03:50:04.741015Z","end":"2026-06-24T03:50:06.033515Z","steps":["trace[336087956] 'agreement among raft nodes before linearized reading' (duration: 1.292446248s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.033538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:04.741007Z","time spent":"1.29252499s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-24T03:50:06.033538Z","caller":"traceutil/trace.go:171","msg":"trace[755691406] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:1211; }","duration":"781.091933ms","start":"2026-06-24T03:50:05.252436Z","end":"2026-06-24T03:50:06.033528Z","steps":["trace[755691406] 'agreement among raft nodes before linearized reading' (duration: 781.011211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.033564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:05.252416Z","time spent":"781.142254ms","remote":"127.0.0.1:38902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.246\" "} {"level":"warn","ts":"2026-06-24T03:50:06.033598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.163863ms","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-24T03:50:06.033613Z","caller":"traceutil/trace.go:171","msg":"trace[328874553] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1211; }","duration":"429.219553ms","start":"2026-06-24T03:50:05.604388Z","end":"2026-06-24T03:50:06.033608Z","steps":["trace[328874553] 'agreement among raft nodes before linearized reading' (duration: 429.192743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.03363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:05.604359Z","time spent":"429.266495ms","remote":"127.0.0.1:34500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T03:50:06.033759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290569002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:50:06.033787Z","caller":"traceutil/trace.go:171","msg":"trace[2096781205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1211; }","duration":"1.290606704s","start":"2026-06-24T03:50:04.743171Z","end":"2026-06-24T03:50:06.033778Z","steps":["trace[2096781205] 'agreement among raft nodes before linearized reading' (duration: 1.290530522s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:06.033815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:04.743163Z","time spent":"1.290645774s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T03:50:25.58811Z","caller":"traceutil/trace.go:171","msg":"trace[1823654830] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"100.606383ms","start":"2026-06-24T03:50:25.487472Z","end":"2026-06-24T03:50:25.588078Z","steps":["trace[1823654830] 'process raft request' (duration: 100.439399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:26.695516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236139558,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T03:50:26.821118Z","caller":"traceutil/trace.go:171","msg":"trace[1661063810] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"720.053493ms","start":"2026-06-24T03:50:26.101044Z","end":"2026-06-24T03:50:26.821097Z","steps":["trace[1661063810] 'process raft request' (duration: 719.92245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:26.821243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.101027Z","time spent":"720.144666ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:50:27.087382Z","caller":"traceutil/trace.go:171","msg":"trace[815600584] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1355; }","duration":"892.243497ms","start":"2026-06-24T03:50:26.195114Z","end":"2026-06-24T03:50:27.087358Z","steps":["trace[815600584] 'read index received' (duration: 625.888615ms)","trace[815600584] 'applied index is now lower than readState.Index' (duration: 266.353922ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:50:27.087402Z","caller":"traceutil/trace.go:171","msg":"trace[401033161] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"707.452379ms","start":"2026-06-24T03:50:26.379937Z","end":"2026-06-24T03:50:27.08739Z","steps":["trace[401033161] 'process raft request' (duration: 700.231434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.087505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.389591ms","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-24T03:50:27.087522Z","caller":"traceutil/trace.go:171","msg":"trace[711731593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1297; }","duration":"892.451892ms","start":"2026-06-24T03:50:26.195066Z","end":"2026-06-24T03:50:27.087517Z","steps":["trace[711731593] 'agreement among raft nodes before linearized reading' (duration: 892.36177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.087536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.195047Z","time spent":"892.486183ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T03:50:27.087541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.379911Z","time spent":"707.568141ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:50:27.087615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.382557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:50:27.087628Z","caller":"traceutil/trace.go:171","msg":"trace[1324796081] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1297; }","duration":"719.422438ms","start":"2026-06-24T03:50:26.3682Z","end":"2026-06-24T03:50:27.087622Z","steps":["trace[1324796081] 'agreement among raft nodes before linearized reading' (duration: 719.397548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.087641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.368185Z","time spent":"719.451949ms","remote":"127.0.0.1:34578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-24T03:50:27.08765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.794895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-24T03:50:27.087675Z","caller":"traceutil/trace.go:171","msg":"trace[1657747502] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1297; }","duration":"262.906549ms","start":"2026-06-24T03:50:26.82476Z","end":"2026-06-24T03:50:27.087667Z","steps":["trace[1657747502] 'agreement among raft nodes before linearized reading' (duration: 262.853977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.08767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.290168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:50:27.087745Z","caller":"traceutil/trace.go:171","msg":"trace[1768214422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1297; }","duration":"782.394641ms","start":"2026-06-24T03:50:26.305331Z","end":"2026-06-24T03:50:27.087726Z","steps":["trace[1768214422] 'agreement among raft nodes before linearized reading' (duration: 782.189106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.087764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.202935ms","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-24T03:50:27.08778Z","caller":"traceutil/trace.go:171","msg":"trace[1810113901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1297; }","duration":"631.248216ms","start":"2026-06-24T03:50:26.456527Z","end":"2026-06-24T03:50:27.087775Z","steps":["trace[1810113901] 'agreement among raft nodes before linearized reading' (duration: 631.201645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.087792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.456509Z","time spent":"631.280527ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T03:50:27.087784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.305315Z","time spent":"782.460952ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T03:50:27.087966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.515494ms","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-24T03:50:27.087998Z","caller":"traceutil/trace.go:171","msg":"trace[1466475069] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1297; }","duration":"770.586985ms","start":"2026-06-24T03:50:26.317403Z","end":"2026-06-24T03:50:27.08799Z","steps":["trace[1466475069] 'agreement among raft nodes before linearized reading' (duration: 770.500583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.087989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.377886ms","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-24T03:50:27.088031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.317384Z","time spent":"770.638266ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-24T03:50:27.088067Z","caller":"traceutil/trace.go:171","msg":"trace[1777418598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1297; }","duration":"733.491138ms","start":"2026-06-24T03:50:26.354556Z","end":"2026-06-24T03:50:27.088047Z","steps":["trace[1777418598] 'agreement among raft nodes before linearized reading' (duration: 733.300083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:27.088107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:26.354542Z","time spent":"733.55753ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T03:50:28.614408Z","caller":"traceutil/trace.go:171","msg":"trace[149196577] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1363; }","duration":"201.680107ms","start":"2026-06-24T03:50:28.412697Z","end":"2026-06-24T03:50:28.614377Z","steps":["trace[149196577] 'read index received' (duration: 201.111994ms)","trace[149196577] 'applied index is now lower than readState.Index' (duration: 566.313µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:50:28.614556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.837501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:50:28.61479Z","caller":"traceutil/trace.go:171","msg":"trace[83161392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1304; }","duration":"202.096957ms","start":"2026-06-24T03:50:28.412672Z","end":"2026-06-24T03:50:28.614769Z","steps":["trace[83161392] 'agreement among raft nodes before linearized reading' (duration: 201.81266ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:28.615183Z","caller":"traceutil/trace.go:171","msg":"trace[215082077] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"202.877536ms","start":"2026-06-24T03:50:28.412288Z","end":"2026-06-24T03:50:28.615166Z","steps":["trace[215082077] 'process raft request' (duration: 201.639097ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:29.284961Z","caller":"traceutil/trace.go:171","msg":"trace[655978428] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"150.630203ms","start":"2026-06-24T03:50:29.134306Z","end":"2026-06-24T03:50:29.284936Z","steps":["trace[655978428] 'read index received' (duration: 150.562262ms)","trace[655978428] 'applied index is now lower than readState.Index' (duration: 67.071µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:50:29.285255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.93779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:50:29.285195Z","caller":"traceutil/trace.go:171","msg":"trace[1432798899] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"192.113536ms","start":"2026-06-24T03:50:29.092934Z","end":"2026-06-24T03:50:29.285048Z","steps":["trace[1432798899] 'process raft request' (duration: 191.848399ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:29.285329Z","caller":"traceutil/trace.go:171","msg":"trace[1993190043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1305; }","duration":"151.041013ms","start":"2026-06-24T03:50:29.134261Z","end":"2026-06-24T03:50:29.285302Z","steps":["trace[1993190043] 'agreement among raft nodes before linearized reading' (duration: 150.864899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:29.285491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.366202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T03:50:29.285517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.718095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-24T03:50:29.285617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.413513ms","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-24T03:50:29.28564Z","caller":"traceutil/trace.go:171","msg":"trace[756984668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1305; }","duration":"125.436203ms","start":"2026-06-24T03:50:29.160198Z","end":"2026-06-24T03:50:29.285634Z","steps":["trace[756984668] 'agreement among raft nodes before linearized reading' (duration: 125.360691ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:29.285543Z","caller":"traceutil/trace.go:171","msg":"trace[570614027] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1305; }","duration":"125.444254ms","start":"2026-06-24T03:50:29.160088Z","end":"2026-06-24T03:50:29.285532Z","steps":["trace[570614027] 'agreement among raft nodes before linearized reading' (duration: 125.28944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:29.285783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.564305ms","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-24T03:50:29.285844Z","caller":"traceutil/trace.go:171","msg":"trace[1366270400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1305; }","duration":"127.659888ms","start":"2026-06-24T03:50:29.158167Z","end":"2026-06-24T03:50:29.285826Z","steps":["trace[1366270400] 'agreement among raft nodes before linearized reading' (duration: 127.107424ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:29.285578Z","caller":"traceutil/trace.go:171","msg":"trace[321999481] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1305; }","duration":"126.794426ms","start":"2026-06-24T03:50:29.158767Z","end":"2026-06-24T03:50:29.285561Z","steps":["trace[321999481] 'agreement among raft nodes before linearized reading' (duration: 126.645103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:31.805034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836961390236139584,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T03:50:32.088759Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.087330985s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T03:50:32.30147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.3000469s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T03:50:32.302034Z","caller":"traceutil/trace.go:171","msg":"trace[1885875174] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"1.502865555s","start":"2026-06-24T03:50:30.799151Z","end":"2026-06-24T03:50:32.302016Z","steps":["trace[1885875174] 'process raft request' (duration: 1.502415514s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.302118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:30.79913Z","time spent":"1.502934926s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:50:32.391012Z","caller":"traceutil/trace.go:171","msg":"trace[1838123417] linearizableReadLoop","detail":"{readStateIndex:1373; appliedIndex:1370; }","duration":"1.087015457s","start":"2026-06-24T03:50:31.303973Z","end":"2026-06-24T03:50:32.390988Z","steps":["trace[1838123417] 'read index received' (duration: 785.299101ms)","trace[1838123417] 'applied index is now lower than readState.Index' (duration: 301.715436ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:50:32.39106Z","caller":"traceutil/trace.go:171","msg":"trace[1277278310] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"1.100638437s","start":"2026-06-24T03:50:31.290388Z","end":"2026-06-24T03:50:32.391027Z","steps":["trace[1277278310] 'process raft request' (duration: 1.011621134s)","trace[1277278310] 'compare' (duration: 88.855389ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:50:32.391213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.290365Z","time spent":"1.10077117s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:50:32.391324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061260545s","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-24T03:50:32.391361Z","caller":"traceutil/trace.go:171","msg":"trace[1710677862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1312; }","duration":"1.061353457s","start":"2026-06-24T03:50:31.329999Z","end":"2026-06-24T03:50:32.391352Z","steps":["trace[1710677862] 'agreement among raft nodes before linearized reading' (duration: 1.061233234s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.391327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087332475s","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-24T03:50:32.39137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060441375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T03:50:32.39142Z","caller":"traceutil/trace.go:171","msg":"trace[1005844939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1312; }","duration":"1.087463938s","start":"2026-06-24T03:50:31.303941Z","end":"2026-06-24T03:50:32.391404Z","steps":["trace[1005844939] 'agreement among raft nodes before linearized reading' (duration: 1.087176782s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.391481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061338597s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-24T03:50:32.39148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.444725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:50:32.391507Z","caller":"traceutil/trace.go:171","msg":"trace[1246758458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1312; }","duration":"1.061377938s","start":"2026-06-24T03:50:31.330122Z","end":"2026-06-24T03:50:32.3915Z","steps":["trace[1246758458] 'agreement among raft nodes before linearized reading' (duration: 1.061329877s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.391509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.30392Z","time spent":"1.087578112s","remote":"127.0.0.1:39090","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-24T03:50:32.391384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.329982Z","time spent":"1.061396878s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T03:50:32.391427Z","caller":"traceutil/trace.go:171","msg":"trace[380547664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1312; }","duration":"1.060514357s","start":"2026-06-24T03:50:31.330897Z","end":"2026-06-24T03:50:32.391412Z","steps":["trace[380547664] 'agreement among raft nodes before linearized reading' (duration: 1.060365663s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.39144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060557458s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-24T03:50:32.391572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.330886Z","time spent":"1.06067439s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T03:50:32.391581Z","caller":"traceutil/trace.go:171","msg":"trace[114246796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1312; }","duration":"1.060711682s","start":"2026-06-24T03:50:31.330861Z","end":"2026-06-24T03:50:32.391573Z","steps":["trace[114246796] 'agreement among raft nodes before linearized reading' (duration: 1.060538407s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.391616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.330851Z","time spent":"1.060758322s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T03:50:32.391527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.330115Z","time spent":"1.061407788s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T03:50:32.391517Z","caller":"traceutil/trace.go:171","msg":"trace[1212899316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1312; }","duration":"981.501036ms","start":"2026-06-24T03:50:31.410005Z","end":"2026-06-24T03:50:32.391506Z","steps":["trace[1212899316] 'agreement among raft nodes before linearized reading' (duration: 981.449895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.391669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:31.409994Z","time spent":"981.671421ms","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T03:50:32.82492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.239272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T03:50:32.825047Z","caller":"traceutil/trace.go:171","msg":"trace[746939665] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"429.083586ms","start":"2026-06-24T03:50:32.395928Z","end":"2026-06-24T03:50:32.825012Z","steps":["trace[746939665] 'process raft request' (duration: 185.6662ms)","trace[746939665] 'compare' (duration: 243.064378ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:50:32.825134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:32.395913Z","time spent":"429.180599ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:50:32.881711Z","caller":"traceutil/trace.go:171","msg":"trace[870916609] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"485.675685ms","start":"2026-06-24T03:50:32.396011Z","end":"2026-06-24T03:50:32.881686Z","steps":["trace[870916609] 'process raft request' (duration: 485.419679ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:32.881775Z","caller":"traceutil/trace.go:171","msg":"trace[465374721] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"485.679506ms","start":"2026-06-24T03:50:32.396071Z","end":"2026-06-24T03:50:32.88175Z","steps":["trace[465374721] 'process raft request' (duration: 485.528592ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:32.88179Z","caller":"traceutil/trace.go:171","msg":"trace[460699647] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"485.624554ms","start":"2026-06-24T03:50:32.396141Z","end":"2026-06-24T03:50:32.881766Z","steps":["trace[460699647] 'process raft request' (duration: 485.495971ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:32.881836Z","caller":"traceutil/trace.go:171","msg":"trace[2078974037] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1373; }","duration":"471.463701ms","start":"2026-06-24T03:50:32.410348Z","end":"2026-06-24T03:50:32.881811Z","steps":["trace[2078974037] 'read index received' (duration: 171.261551ms)","trace[2078974037] 'applied index is now lower than readState.Index' (duration: 300.2011ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:50:32.881876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:32.396064Z","time spent":"485.759878ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:50:32.881952Z","caller":"traceutil/trace.go:171","msg":"trace[1679161154] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"485.513132ms","start":"2026-06-24T03:50:32.396428Z","end":"2026-06-24T03:50:32.881941Z","steps":["trace[1679161154] 'process raft request' (duration: 485.274396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.882112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.760098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T03:50:32.88214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:32.396419Z","time spent":"485.564833ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T03:50:32.882154Z","caller":"traceutil/trace.go:171","msg":"trace[820094241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1317; }","duration":"471.802359ms","start":"2026-06-24T03:50:32.410341Z","end":"2026-06-24T03:50:32.882143Z","steps":["trace[820094241] 'agreement among raft nodes before linearized reading' (duration: 471.739598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.882115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.632498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T03:50:32.882201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:32.410306Z","time spent":"471.874461ms","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T03:50:32.882961Z","caller":"traceutil/trace.go:171","msg":"trace[1563680227] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1317; }","duration":"200.468248ms","start":"2026-06-24T03:50:32.682422Z","end":"2026-06-24T03:50:32.88289Z","steps":["trace[1563680227] 'agreement among raft nodes before linearized reading' (duration: 199.632978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:32.881835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:32.396002Z","time spent":"485.770447ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:50:32.882315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:32.395209Z","time spent":"486.67437ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:50:35.93394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047218396s","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-24T03:50:35.934025Z","caller":"traceutil/trace.go:171","msg":"trace[145846456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"1.047336778s","start":"2026-06-24T03:50:34.88667Z","end":"2026-06-24T03:50:35.934007Z","steps":["trace[145846456] 'range keys from in-memory index tree' (duration: 1.047070182s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.934075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.705588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T03:50:35.934123Z","caller":"traceutil/trace.go:171","msg":"trace[1007279255] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:1325; }","duration":"679.831441ms","start":"2026-06-24T03:50:35.254278Z","end":"2026-06-24T03:50:35.93411Z","steps":["trace[1007279255] 'range keys from in-memory index tree' (duration: 679.471142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.934162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:35.25425Z","time spent":"679.904863ms","remote":"127.0.0.1:38902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.246\" "} {"level":"warn","ts":"2026-06-24T03:50:35.934273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.209855499s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:50:35.934359Z","caller":"traceutil/trace.go:171","msg":"trace[2112162384] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1325; }","duration":"1.209990412s","start":"2026-06-24T03:50:34.724349Z","end":"2026-06-24T03:50:35.934339Z","steps":["trace[2112162384] 'count revisions from in-memory index tree' (duration: 1.209772337s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.9344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.724329Z","time spent":"1.210060844s","remote":"127.0.0.1:39292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-24T03:50:35.934441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046208271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T03:50:35.934515Z","caller":"traceutil/trace.go:171","msg":"trace[264412470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"1.046314814s","start":"2026-06-24T03:50:34.888182Z","end":"2026-06-24T03:50:35.934497Z","steps":["trace[264412470] 'range keys from in-memory index tree' (duration: 1.046032617s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.934554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.888171Z","time spent":"1.046374985s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T03:50:35.934596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.482405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T03:50:35.934594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046776035s","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-24T03:50:35.93463Z","caller":"traceutil/trace.go:171","msg":"trace[1403324677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1325; }","duration":"522.568408ms","start":"2026-06-24T03:50:35.41205Z","end":"2026-06-24T03:50:35.934619Z","steps":["trace[1403324677] 'range keys from in-memory index tree' (duration: 522.370773ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:35.934646Z","caller":"traceutil/trace.go:171","msg":"trace[288207883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1325; }","duration":"1.046842776s","start":"2026-06-24T03:50:34.887785Z","end":"2026-06-24T03:50:35.934628Z","steps":["trace[288207883] 'range keys from in-memory index tree' (duration: 1.046680903s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.934666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:35.412021Z","time spent":"522.635199ms","remote":"127.0.0.1:38880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T03:50:35.93468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.887777Z","time spent":"1.046894627s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T03:50:35.934671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174616826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T03:50:35.93481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046805816s","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-24T03:50:35.934846Z","caller":"traceutil/trace.go:171","msg":"trace[765164767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1325; }","duration":"1.046839786s","start":"2026-06-24T03:50:34.887995Z","end":"2026-06-24T03:50:35.934835Z","steps":["trace[765164767] 'range keys from in-memory index tree' (duration: 1.046690783s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.934858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105407103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T03:50:35.934874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.887926Z","time spent":"1.046941049s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T03:50:35.934892Z","caller":"traceutil/trace.go:171","msg":"trace[1184682409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"1.105469494s","start":"2026-06-24T03:50:34.829412Z","end":"2026-06-24T03:50:35.934881Z","steps":["trace[1184682409] 'range keys from in-memory index tree' (duration: 1.10528677s)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:35.934801Z","caller":"traceutil/trace.go:171","msg":"trace[1608158198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1325; }","duration":"1.174796561s","start":"2026-06-24T03:50:34.759977Z","end":"2026-06-24T03:50:35.934774Z","steps":["trace[1608158198] 'range keys from in-memory index tree' (duration: 1.174512854s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:35.93492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.829396Z","time spent":"1.105517935s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T03:50:35.934952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.759956Z","time spent":"1.174990556s","remote":"127.0.0.1:38870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T03:50:35.934096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:34.886658Z","time spent":"1.04742355s","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T03:50:37.247237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.268963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T03:50:37.247354Z","caller":"traceutil/trace.go:171","msg":"trace[372067197] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"232.264577ms","start":"2026-06-24T03:50:37.015066Z","end":"2026-06-24T03:50:37.247331Z","steps":["trace[372067197] 'process raft request' (duration: 86.795959ms)","trace[372067197] 'compare' (duration: 144.910725ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:50:43.692648Z","caller":"traceutil/trace.go:171","msg":"trace[1134063644] linearizableReadLoop","detail":"{readStateIndex:1451; appliedIndex:1450; }","duration":"432.301294ms","start":"2026-06-24T03:50:43.260328Z","end":"2026-06-24T03:50:43.692629Z","steps":["trace[1134063644] 'read index received' (duration: 432.185921ms)","trace[1134063644] 'applied index is now lower than readState.Index' (duration: 114.353µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:50:43.692789Z","caller":"traceutil/trace.go:171","msg":"trace[2137143229] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"606.094447ms","start":"2026-06-24T03:50:43.08666Z","end":"2026-06-24T03:50:43.692755Z","steps":["trace[2137143229] 'process raft request' (duration: 605.855661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:43.692897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:43.086632Z","time spent":"606.200208ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:50:43.693155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.077253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T03:50:43.693242Z","caller":"traceutil/trace.go:171","msg":"trace[1799393826] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1388; }","duration":"223.223697ms","start":"2026-06-24T03:50:43.469998Z","end":"2026-06-24T03:50:43.693221Z","steps":["trace[1799393826] 'agreement among raft nodes before linearized reading' (duration: 222.867198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:43.693268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.913388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T03:50:43.693462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.504746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:102953"} {"level":"info","ts":"2026-06-24T03:50:43.693547Z","caller":"traceutil/trace.go:171","msg":"trace[1138978502] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1388; }","duration":"221.628228ms","start":"2026-06-24T03:50:43.471898Z","end":"2026-06-24T03:50:43.693526Z","steps":["trace[1138978502] 'agreement among raft nodes before linearized reading' (duration: 221.262879ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:50:43.693655Z","caller":"traceutil/trace.go:171","msg":"trace[731245204] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1388; }","duration":"433.189355ms","start":"2026-06-24T03:50:43.260291Z","end":"2026-06-24T03:50:43.693481Z","steps":["trace[731245204] 'agreement among raft nodes before linearized reading' (duration: 432.822926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:50:43.694605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:50:43.260275Z","time spent":"434.306542ms","remote":"127.0.0.1:39194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-06-24T03:51:10.290624Z","caller":"traceutil/trace.go:171","msg":"trace[197725474] linearizableReadLoop","detail":"{readStateIndex:1580; appliedIndex:1578; }","duration":"144.663729ms","start":"2026-06-24T03:51:10.145939Z","end":"2026-06-24T03:51:10.290603Z","steps":["trace[197725474] 'read index received' (duration: 60.811121ms)","trace[197725474] 'applied index is now lower than readState.Index' (duration: 83.851898ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:51:10.290739Z","caller":"traceutil/trace.go:171","msg":"trace[484615758] transaction","detail":"{read_only:false; response_revision:1512; number_of_response:1; }","duration":"147.494017ms","start":"2026-06-24T03:51:10.143215Z","end":"2026-06-24T03:51:10.290709Z","steps":["trace[484615758] 'process raft request' (duration: 91.997205ms)","trace[484615758] 'compare' (duration: 55.276627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:51:10.290865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.909394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T03:51:10.290915Z","caller":"traceutil/trace.go:171","msg":"trace[256668734] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1512; }","duration":"145.012027ms","start":"2026-06-24T03:51:10.145895Z","end":"2026-06-24T03:51:10.290907Z","steps":["trace[256668734] 'agreement among raft nodes before linearized reading' (duration: 144.850113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:51:10.291159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.677406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T03:51:10.291213Z","caller":"traceutil/trace.go:171","msg":"trace[282042354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1512; }","duration":"136.739607ms","start":"2026-06-24T03:51:10.154459Z","end":"2026-06-24T03:51:10.291198Z","steps":["trace[282042354] 'agreement among raft nodes before linearized reading' (duration: 136.599534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:51:10.291388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.88567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T03:51:10.29153Z","caller":"traceutil/trace.go:171","msg":"trace[1028679266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1512; }","duration":"137.050685ms","start":"2026-06-24T03:51:10.154423Z","end":"2026-06-24T03:51:10.291474Z","steps":["trace[1028679266] 'agreement among raft nodes before linearized reading' (duration: 136.608294ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:51:10.568955Z","caller":"traceutil/trace.go:171","msg":"trace[483879746] transaction","detail":"{read_only:false; response_revision:1514; number_of_response:1; }","duration":"272.610422ms","start":"2026-06-24T03:51:10.296317Z","end":"2026-06-24T03:51:10.568928Z","steps":["trace[483879746] 'process raft request' (duration: 272.327716ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:51:10.56904Z","caller":"traceutil/trace.go:171","msg":"trace[608950379] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"272.361426ms","start":"2026-06-24T03:51:10.296645Z","end":"2026-06-24T03:51:10.569007Z","steps":["trace[608950379] 'process raft request' (duration: 272.200642ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:51:10.606145Z","caller":"traceutil/trace.go:171","msg":"trace[56669106] linearizableReadLoop","detail":"{readStateIndex:1584; appliedIndex:1581; }","duration":"193.5037ms","start":"2026-06-24T03:51:10.412623Z","end":"2026-06-24T03:51:10.606127Z","steps":["trace[56669106] 'read index received' (duration: 155.979863ms)","trace[56669106] 'applied index is now lower than readState.Index' (duration: 37.522717ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T03:51:10.606398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.611842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:51:10.606455Z","caller":"traceutil/trace.go:171","msg":"trace[125942479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1515; }","duration":"193.868868ms","start":"2026-06-24T03:51:10.412562Z","end":"2026-06-24T03:51:10.606431Z","steps":["trace[125942479] 'agreement among raft nodes before linearized reading' (duration: 193.629023ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:54:23.490314Z","caller":"traceutil/trace.go:171","msg":"trace[137275138] linearizableReadLoop","detail":"{readStateIndex:2530; appliedIndex:2529; }","duration":"385.273633ms","start":"2026-06-24T03:54:23.10502Z","end":"2026-06-24T03:54:23.490293Z","steps":["trace[137275138] 'read index received' (duration: 385.174801ms)","trace[137275138] 'applied index is now lower than readState.Index' (duration: 97.892µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T03:54:23.490423Z","caller":"traceutil/trace.go:171","msg":"trace[2065835416] transaction","detail":"{read_only:false; response_revision:2422; number_of_response:1; }","duration":"406.56958ms","start":"2026-06-24T03:54:23.083843Z","end":"2026-06-24T03:54:23.490413Z","steps":["trace[2065835416] 'process raft request' (duration: 406.297363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:54:23.490515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:54:23.083812Z","time spent":"406.633712ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T03:54:23.490767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.738824ms","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-24T03:54:23.49084Z","caller":"traceutil/trace.go:171","msg":"trace[991365139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2422; }","duration":"385.865656ms","start":"2026-06-24T03:54:23.104954Z","end":"2026-06-24T03:54:23.49082Z","steps":["trace[991365139] 'agreement among raft nodes before linearized reading' (duration: 385.656521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:54:23.490881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:54:23.104929Z","time spent":"385.944109ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T03:54:23.518438Z","caller":"traceutil/trace.go:171","msg":"trace[1056174024] transaction","detail":"{read_only:false; response_revision:2423; number_of_response:1; }","duration":"277.655578ms","start":"2026-06-24T03:54:23.240755Z","end":"2026-06-24T03:54:23.51841Z","steps":["trace[1056174024] 'process raft request' (duration: 277.526095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:54:23.518515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.325024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:54:23.518563Z","caller":"traceutil/trace.go:171","msg":"trace[740544084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2423; }","duration":"106.416837ms","start":"2026-06-24T03:54:23.412134Z","end":"2026-06-24T03:54:23.518551Z","steps":["trace[740544084] 'agreement among raft nodes before linearized reading' (duration: 106.316264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:54:23.518681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.309611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T03:54:23.518769Z","caller":"traceutil/trace.go:171","msg":"trace[1857866095] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2423; }","duration":"340.407193ms","start":"2026-06-24T03:54:23.178331Z","end":"2026-06-24T03:54:23.518738Z","steps":["trace[1857866095] 'agreement among raft nodes before linearized reading' (duration: 340.29483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:54:23.518773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.411594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T03:54:23.51882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T03:54:23.178319Z","time spent":"340.485676ms","remote":"127.0.0.1:39090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":13,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-06-24T03:54:23.51887Z","caller":"traceutil/trace.go:171","msg":"trace[568931675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2423; }","duration":"275.545008ms","start":"2026-06-24T03:54:23.243304Z","end":"2026-06-24T03:54:23.518849Z","steps":["trace[568931675] 'agreement among raft nodes before linearized reading' (duration: 275.298422ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:54:23.629934Z","caller":"traceutil/trace.go:171","msg":"trace[355360081] transaction","detail":"{read_only:false; response_revision:2425; number_of_response:1; }","duration":"106.102949ms","start":"2026-06-24T03:54:23.523802Z","end":"2026-06-24T03:54:23.629905Z","steps":["trace[355360081] 'process raft request' (duration: 100.27319ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:54:23.630212Z","caller":"traceutil/trace.go:171","msg":"trace[1067053467] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"106.272123ms","start":"2026-06-24T03:54:23.523929Z","end":"2026-06-24T03:54:23.630201Z","steps":["trace[1067053467] 'process raft request' (duration: 105.929685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T03:54:23.630397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.550704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T03:54:23.630512Z","caller":"traceutil/trace.go:171","msg":"trace[1047147171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2428; }","duration":"110.666517ms","start":"2026-06-24T03:54:23.519817Z","end":"2026-06-24T03:54:23.630484Z","steps":["trace[1047147171] 'agreement among raft nodes before linearized reading' (duration: 110.485202ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T03:54:23.630558Z","caller":"traceutil/trace.go:171","msg":"trace[813462] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"106.607211ms","start":"2026-06-24T03:54:23.523926Z","end":"2026-06-24T03:54:23.630533Z","steps":["trace[813462] 'process raft request' (duration: 106.1643ms)"],"step_count":1}