{"level":"warn","ts":"2026-04-10T01:09:26.753207Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T01:09:26.753289Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.102: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.102:2380","--initial-cluster=instance=https://199.204.45.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.102: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-04-10T01:09:26.753361Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T01:09:26.753373Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-04-10T01:09:26.753393Z","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-04-10T01:09:26.753966Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"]} {"level":"info","ts":"2026-04-10T01:09:26.754039Z","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.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.102: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-04-10T01:09:26.757884Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.644326ms"} {"level":"info","ts":"2026-04-10T01:09:26.762305Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e7960f761c1028e","cluster-id":"502e2b31b867adf"} {"level":"info","ts":"2026-04-10T01:09:26.762375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T01:09:26.762394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 0"} {"level":"info","ts":"2026-04-10T01:09:26.762424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e7960f761c1028e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T01:09:26.762437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 1"} {"level":"info","ts":"2026-04-10T01:09:26.762473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"warn","ts":"2026-04-10T01:09:26.769399Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T01:09:26.771001Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T01:09:26.772196Z","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-04-10T01:09:26.774721Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e7960f761c1028e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T01:09:26.774944Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e7960f761c1028e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T01:09:26.77523Z","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-04-10T01:09:26.775382Z","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-04-10T01:09:26.775476Z","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-04-10T01:09:26.776261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"info","ts":"2026-04-10T01:09:26.776472Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","added-peer-id":"6e7960f761c1028e","added-peer-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-04-10T01:09:26.780177Z","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-04-10T01:09:26.780452Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e7960f761c1028e","initial-advertise-peer-urls":["https://199.204.45.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T01:09:26.780501Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T01:09:26.780658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-04-10T01:09:26.780681Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-04-10T01:09:27.663149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T01:09:27.663249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T01:09:27.663286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgPreVoteResp from 6e7960f761c1028e at term 1"} {"level":"info","ts":"2026-04-10T01:09:27.663311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became candidate at term 2"} {"level":"info","ts":"2026-04-10T01:09:27.663323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgVoteResp from 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-04-10T01:09:27.663342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became leader at term 2"} {"level":"info","ts":"2026-04-10T01:09:27.663357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e7960f761c1028e elected leader 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-04-10T01:09:27.664349Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e7960f761c1028e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.102:2379]}","request-path":"/0/members/6e7960f761c1028e/attributes","cluster-id":"502e2b31b867adf","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T01:09:27.664414Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T01:09:27.664393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T01:09:27.66455Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:09:27.664846Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T01:09:27.664902Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T01:09:27.665963Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:09:27.666098Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:09:27.666137Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:09:27.667993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T01:09:27.668297Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.102:2379"} {"level":"warn","ts":"2026-04-10T01:09:55.157387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.177396ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:09:55.157533Z","caller":"traceutil/trace.go:171","msg":"trace[228978925] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:519; }","duration":"590.801426ms","start":"2026-04-10T01:09:54.566704Z","end":"2026-04-10T01:09:55.157506Z","steps":["trace[228978925] 'read index received' (duration: 409.889463ms)","trace[228978925] 'applied index is now lower than readState.Index' (duration: 180.910743ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:09:55.157805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.557859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:09:55.157828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.157476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-04-10T01:09:55.157881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.388434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-04-10T01:09:55.157963Z","caller":"traceutil/trace.go:171","msg":"trace[1814111245] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:500; }","duration":"363.522218ms","start":"2026-04-10T01:09:54.79442Z","end":"2026-04-10T01:09:55.157942Z","steps":["trace[1814111245] 'agreement among raft nodes before linearized reading' (duration: 363.379464ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:55.157987Z","caller":"traceutil/trace.go:171","msg":"trace[1851499755] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"610.42853ms","start":"2026-04-10T01:09:54.547149Z","end":"2026-04-10T01:09:55.157578Z","steps":["trace[1851499755] 'process raft request' (duration: 429.515466ms)","trace[1851499755] 'compare' (duration: 179.875739ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:09:55.158012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:54.794366Z","time spent":"363.63425ms","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":542,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"info","ts":"2026-04-10T01:09:55.158059Z","caller":"traceutil/trace.go:171","msg":"trace[1291758927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:500; }","duration":"101.645971ms","start":"2026-04-10T01:09:55.056187Z","end":"2026-04-10T01:09:55.157833Z","steps":["trace[1291758927] 'agreement among raft nodes before linearized reading' (duration: 101.574409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:55.158218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:54.54713Z","time spent":"610.984064ms","remote":"127.0.0.1:43436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317275,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:09:55.158271Z","caller":"traceutil/trace.go:171","msg":"trace[948405500] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:500; }","duration":"365.31511ms","start":"2026-04-10T01:09:54.792595Z","end":"2026-04-10T01:09:55.15791Z","steps":["trace[948405500] 'agreement among raft nodes before linearized reading' (duration: 365.035623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:55.158311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:54.792576Z","time spent":"365.721879ms","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":560,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-04-10T01:09:55.158714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.968294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:09:55.158824Z","caller":"traceutil/trace.go:171","msg":"trace[896884455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:500; }","duration":"592.119538ms","start":"2026-04-10T01:09:54.566647Z","end":"2026-04-10T01:09:55.158766Z","steps":["trace[896884455] 'agreement among raft nodes before linearized reading' (duration: 590.93729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:55.158917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:54.566617Z","time spent":"592.282341ms","remote":"127.0.0.1:43596","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-04-10T01:09:57.056702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.690915ms","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-04-10T01:09:57.056785Z","caller":"traceutil/trace.go:171","msg":"trace[44367518] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:506; }","duration":"240.823699ms","start":"2026-04-10T01:09:56.81594Z","end":"2026-04-10T01:09:57.056764Z","steps":["trace[44367518] 'range keys from in-memory index tree' (duration: 240.602234ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:58.319096Z","caller":"traceutil/trace.go:171","msg":"trace[509778586] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"676.471811ms","start":"2026-04-10T01:09:57.642608Z","end":"2026-04-10T01:09:58.319079Z","steps":["trace[509778586] 'process raft request' (duration: 676.352058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:58.319192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:57.642588Z","time spent":"676.558692ms","remote":"127.0.0.1:43410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:09:58.9232Z","caller":"traceutil/trace.go:171","msg":"trace[471157339] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:585; }","duration":"866.54263ms","start":"2026-04-10T01:09:58.056634Z","end":"2026-04-10T01:09:58.923176Z","steps":["trace[471157339] 'read index received' (duration: 262.280006ms)","trace[471157339] 'applied index is now lower than readState.Index' (duration: 604.261764ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:09:58.923251Z","caller":"traceutil/trace.go:171","msg":"trace[267974163] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"1.26023283s","start":"2026-04-10T01:09:57.662986Z","end":"2026-04-10T01:09:58.923219Z","steps":["trace[267974163] 'process raft request' (duration: 1.254886484s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:58.923321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.663703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:09:58.923346Z","caller":"traceutil/trace.go:171","msg":"trace[1954180827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"866.766056ms","start":"2026-04-10T01:09:58.056572Z","end":"2026-04-10T01:09:58.923338Z","steps":["trace[1954180827] 'agreement among raft nodes before linearized reading' (duration: 866.695394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:58.923367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:58.056551Z","time spent":"866.811217ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:09:58.923366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:57.662959Z","time spent":"1.260344163s","remote":"127.0.0.1:43410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:09:58.924161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.73803ms","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-04-10T01:09:58.924156Z","caller":"traceutil/trace.go:171","msg":"trace[2085410730] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"546.241804ms","start":"2026-04-10T01:09:58.377893Z","end":"2026-04-10T01:09:58.924135Z","steps":["trace[2085410730] 'process raft request' (duration: 546.110861ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:58.92419Z","caller":"traceutil/trace.go:171","msg":"trace[185518941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"423.798562ms","start":"2026-04-10T01:09:58.500383Z","end":"2026-04-10T01:09:58.924182Z","steps":["trace[185518941] 'agreement among raft nodes before linearized reading' (duration: 423.695599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:58.924208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:58.500365Z","time spent":"423.838562ms","remote":"127.0.0.1:43596","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-04-10T01:09:58.924267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:09:58.377858Z","time spent":"546.350887ms","remote":"127.0.0.1:43410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:10:03.187379Z","caller":"traceutil/trace.go:171","msg":"trace[1271947701] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"116.880191ms","start":"2026-04-10T01:10:03.070474Z","end":"2026-04-10T01:10:03.187355Z","steps":["trace[1271947701] 'process raft request' (duration: 116.287447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:03.928902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.965012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:10:03.929071Z","caller":"traceutil/trace.go:171","msg":"trace[1452123983] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"463.830796ms","start":"2026-04-10T01:10:03.465222Z","end":"2026-04-10T01:10:03.929053Z","steps":["trace[1452123983] 'read index received' (duration: 244.595418ms)","trace[1452123983] 'applied index is now lower than readState.Index' (duration: 219.234118ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:03.929218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.99407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zvb2t\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-10T01:10:03.929289Z","caller":"traceutil/trace.go:171","msg":"trace[787228203] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zvb2t; range_end:; response_count:1; response_revision:612; }","duration":"464.096442ms","start":"2026-04-10T01:10:03.46518Z","end":"2026-04-10T01:10:03.929277Z","steps":["trace[787228203] 'agreement among raft nodes before linearized reading' (duration: 463.951549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:03.929346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:03.46516Z","time spent":"464.175474ms","remote":"127.0.0.1:43510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-zvb2t\" "} {"level":"info","ts":"2026-04-10T01:10:03.929377Z","caller":"traceutil/trace.go:171","msg":"trace[1966155433] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"684.450648ms","start":"2026-04-10T01:10:03.244886Z","end":"2026-04-10T01:10:03.929337Z","steps":["trace[1966155433] 'process raft request' (duration: 464.982884ms)","trace[1966155433] 'compare' (duration: 218.835079ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:03.929464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:03.244868Z","time spent":"684.560081ms","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:10:04.110725Z","caller":"traceutil/trace.go:171","msg":"trace[1954125917] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"165.268824ms","start":"2026-04-10T01:10:03.945415Z","end":"2026-04-10T01:10:04.110684Z","steps":["trace[1954125917] 'process raft request' (duration: 164.806793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.453466Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333950726,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:10:05.604778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:05.105771Z","time spent":"498.999338ms","remote":"127.0.0.1:53244","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-10T01:10:05.614761Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.281707218s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T01:10:05.61633Z","caller":"traceutil/trace.go:171","msg":"trace[1475987123] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.28518385s","start":"2026-04-10T01:10:04.331114Z","end":"2026-04-10T01:10:05.616298Z","steps":["trace[1475987123] 'process raft request' (duration: 1.284237818s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.616607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.686189ms","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-04-10T01:10:05.616681Z","caller":"traceutil/trace.go:171","msg":"trace[1675675524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"663.814491ms","start":"2026-04-10T01:10:04.952849Z","end":"2026-04-10T01:10:05.616664Z","steps":["trace[1675675524] 'agreement among raft nodes before linearized reading' (duration: 663.525664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.616757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:04.952829Z","time spent":"663.917254ms","remote":"127.0.0.1:43596","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-04-10T01:10:05.616682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:04.331084Z","time spent":"1.285310783s","remote":"127.0.0.1:43436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:10:05.616303Z","caller":"traceutil/trace.go:171","msg":"trace[505811403] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"663.365391ms","start":"2026-04-10T01:10:04.952895Z","end":"2026-04-10T01:10:05.616261Z","steps":["trace[505811403] 'read index received' (duration: 662.05263ms)","trace[505811403] 'applied index is now lower than readState.Index' (duration: 1.31149ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:05.617396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.697182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:05.617446Z","caller":"traceutil/trace.go:171","msg":"trace[226765895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"559.780654ms","start":"2026-04-10T01:10:05.057652Z","end":"2026-04-10T01:10:05.617433Z","steps":["trace[226765895] 'agreement among raft nodes before linearized reading' (duration: 559.697272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.617482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:05.057633Z","time spent":"559.843275ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:10:05.617914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.274479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:05.617952Z","caller":"traceutil/trace.go:171","msg":"trace[74636207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:614; }","duration":"103.321ms","start":"2026-04-10T01:10:05.51462Z","end":"2026-04-10T01:10:05.617941Z","steps":["trace[74636207] 'agreement among raft nodes before linearized reading' (duration: 103.269699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.618142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.485101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-10T01:10:05.618155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.533026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:05.618178Z","caller":"traceutil/trace.go:171","msg":"trace[151978901] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:614; }","duration":"367.558543ms","start":"2026-04-10T01:10:05.25061Z","end":"2026-04-10T01:10:05.618169Z","steps":["trace[151978901] 'agreement among raft nodes before linearized reading' (duration: 367.494891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.618227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:05.250589Z","time spent":"367.631275ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T01:10:05.618279Z","caller":"traceutil/trace.go:171","msg":"trace[921928928] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:614; }","duration":"103.571907ms","start":"2026-04-10T01:10:05.514609Z","end":"2026-04-10T01:10:05.618181Z","steps":["trace[921928928] 'agreement among raft nodes before linearized reading' (duration: 103.511105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.618266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.677057ms","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-04-10T01:10:05.618396Z","caller":"traceutil/trace.go:171","msg":"trace[1567473474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"373.858322ms","start":"2026-04-10T01:10:05.244528Z","end":"2026-04-10T01:10:05.618386Z","steps":["trace[1567473474] 'agreement among raft nodes before linearized reading' (duration: 373.669307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.618468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:05.24451Z","time spent":"373.929343ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T01:10:05.618454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.60687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T01:10:05.618524Z","caller":"traceutil/trace.go:171","msg":"trace[455144264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:614; }","duration":"366.720642ms","start":"2026-04-10T01:10:05.251781Z","end":"2026-04-10T01:10:05.618501Z","steps":["trace[455144264] 'agreement among raft nodes before linearized reading' (duration: 366.531478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:05.618565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:05.251754Z","time spent":"366.802615ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-10T01:10:06.857117Z","caller":"traceutil/trace.go:171","msg":"trace[423195615] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"213.622196ms","start":"2026-04-10T01:10:06.643433Z","end":"2026-04-10T01:10:06.857055Z","steps":["trace[423195615] 'read index received' (duration: 211.320042ms)","trace[423195615] 'applied index is now lower than readState.Index' (duration: 2.280254ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:06.861662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.143383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:06.861659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.166583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:06.861737Z","caller":"traceutil/trace.go:171","msg":"trace[730870777] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"218.252406ms","start":"2026-04-10T01:10:06.643462Z","end":"2026-04-10T01:10:06.861715Z","steps":["trace[730870777] 'agreement among raft nodes before linearized reading' (duration: 218.086442ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:06.861776Z","caller":"traceutil/trace.go:171","msg":"trace[357373641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"218.317437ms","start":"2026-04-10T01:10:06.64341Z","end":"2026-04-10T01:10:06.861728Z","steps":["trace[357373641] 'agreement among raft nodes before linearized reading' (duration: 218.091322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:06.86183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.367287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:06.861893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.158199ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:06.861938Z","caller":"traceutil/trace.go:171","msg":"trace[812894316] 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:626; }","duration":"203.227371ms","start":"2026-04-10T01:10:06.65869Z","end":"2026-04-10T01:10:06.861917Z","steps":["trace[812894316] 'agreement among raft nodes before linearized reading' (duration: 203.045527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:06.861916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.530772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:06.862007Z","caller":"traceutil/trace.go:171","msg":"trace[1143461122] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"165.561271ms","start":"2026-04-10T01:10:06.696403Z","end":"2026-04-10T01:10:06.861964Z","steps":["trace[1143461122] 'agreement among raft nodes before linearized reading' (duration: 165.328715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:06.861992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.729619ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:06.862097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.672221ms","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-04-10T01:10:06.862122Z","caller":"traceutil/trace.go:171","msg":"trace[785756488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"182.698556ms","start":"2026-04-10T01:10:06.679328Z","end":"2026-04-10T01:10:06.862027Z","steps":["trace[785756488] 'agreement among raft nodes before linearized reading' (duration: 182.401609ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:06.862123Z","caller":"traceutil/trace.go:171","msg":"trace[1813686488] 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:626; }","duration":"202.901453ms","start":"2026-04-10T01:10:06.65918Z","end":"2026-04-10T01:10:06.862081Z","steps":["trace[1813686488] 'agreement among raft nodes before linearized reading' (duration: 202.702118ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:06.86216Z","caller":"traceutil/trace.go:171","msg":"trace[1016015208] 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:626; }","duration":"203.732893ms","start":"2026-04-10T01:10:06.658398Z","end":"2026-04-10T01:10:06.862131Z","steps":["trace[1016015208] 'agreement among raft nodes before linearized reading' (duration: 203.633471ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:06.862219Z","caller":"traceutil/trace.go:171","msg":"trace[1067805247] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"237.557702ms","start":"2026-04-10T01:10:06.624643Z","end":"2026-04-10T01:10:06.8622Z","steps":["trace[1067805247] 'process raft request' (duration: 230.358642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:06.861841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.470965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:06.862345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.968741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:06.862376Z","caller":"traceutil/trace.go:171","msg":"trace[2055892770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"166.014291ms","start":"2026-04-10T01:10:06.696354Z","end":"2026-04-10T01:10:06.862368Z","steps":["trace[2055892770] 'agreement among raft nodes before linearized reading' (duration: 165.95764ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:06.862339Z","caller":"traceutil/trace.go:171","msg":"trace[1764948344] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"165.034308ms","start":"2026-04-10T01:10:06.697287Z","end":"2026-04-10T01:10:06.862321Z","steps":["trace[1764948344] 'agreement among raft nodes before linearized reading' (duration: 164.462005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:06.862568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.959172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:06.862598Z","caller":"traceutil/trace.go:171","msg":"trace[625591371] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"183.045865ms","start":"2026-04-10T01:10:06.679537Z","end":"2026-04-10T01:10:06.862583Z","steps":["trace[625591371] 'agreement among raft nodes before linearized reading' (duration: 183.007334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:06.862691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.43404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:06.862732Z","caller":"traceutil/trace.go:171","msg":"trace[1060307917] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"218.501392ms","start":"2026-04-10T01:10:06.644214Z","end":"2026-04-10T01:10:06.862716Z","steps":["trace[1060307917] 'agreement among raft nodes before linearized reading' (duration: 218.43162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:07.896346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.496307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:10:07.896549Z","caller":"traceutil/trace.go:171","msg":"trace[1682024249] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"342.091391ms","start":"2026-04-10T01:10:07.55442Z","end":"2026-04-10T01:10:07.896512Z","steps":["trace[1682024249] 'process raft request' (duration: 69.314578ms)","trace[1682024249] 'compare' (duration: 272.259821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:07.896632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:07.554402Z","time spent":"342.199883ms","remote":"127.0.0.1:43432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:10:07.896843Z","caller":"traceutil/trace.go:171","msg":"trace[1163316641] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"341.446455ms","start":"2026-04-10T01:10:07.555323Z","end":"2026-04-10T01:10:07.896769Z","steps":["trace[1163316641] 'process raft request' (duration: 341.140368ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:07.897032Z","caller":"traceutil/trace.go:171","msg":"trace[1404925921] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"340.494143ms","start":"2026-04-10T01:10:07.556524Z","end":"2026-04-10T01:10:07.897018Z","steps":["trace[1404925921] 'process raft request' (duration: 340.144075ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:07.897035Z","caller":"traceutil/trace.go:171","msg":"trace[558404002] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:662; }","duration":"263.248669ms","start":"2026-04-10T01:10:07.633763Z","end":"2026-04-10T01:10:07.897012Z","steps":["trace[558404002] 'read index received' (duration: 38.451µs)","trace[558404002] 'applied index is now lower than readState.Index' (duration: 263.209338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:07.897094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:07.555311Z","time spent":"341.656001ms","remote":"127.0.0.1:43432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:10:07.897126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:07.55651Z","time spent":"340.558744ms","remote":"127.0.0.1:43510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:10:07.897165Z","caller":"traceutil/trace.go:171","msg":"trace[809011847] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"340.021242ms","start":"2026-04-10T01:10:07.557117Z","end":"2026-04-10T01:10:07.897138Z","steps":["trace[809011847] 'process raft request' (duration: 339.840268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:07.897266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.476124ms","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-04-10T01:10:07.8973Z","caller":"traceutil/trace.go:171","msg":"trace[117522329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"263.567287ms","start":"2026-04-10T01:10:07.633721Z","end":"2026-04-10T01:10:07.897289Z","steps":["trace[117522329] 'agreement among raft nodes before linearized reading' (duration: 263.413343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:07.897299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:07.557099Z","time spent":"340.115995ms","remote":"127.0.0.1:43572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:10:07.897595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.279535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T01:10:07.897619Z","caller":"traceutil/trace.go:171","msg":"trace[998538513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"259.327026ms","start":"2026-04-10T01:10:07.638286Z","end":"2026-04-10T01:10:07.897613Z","steps":["trace[998538513] 'agreement among raft nodes before linearized reading' (duration: 259.248694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:07.897676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.563847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-10T01:10:07.897658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.129245ms","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-04-10T01:10:07.899408Z","caller":"traceutil/trace.go:171","msg":"trace[2081774434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"261.870186ms","start":"2026-04-10T01:10:07.637492Z","end":"2026-04-10T01:10:07.899362Z","steps":["trace[2081774434] 'agreement among raft nodes before linearized reading' (duration: 259.995102ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:07.897753Z","caller":"traceutil/trace.go:171","msg":"trace[1253099337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"255.6692ms","start":"2026-04-10T01:10:07.64206Z","end":"2026-04-10T01:10:07.89773Z","steps":["trace[1253099337] 'agreement among raft nodes before linearized reading' (duration: 255.441225ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:11.670367Z","caller":"traceutil/trace.go:171","msg":"trace[584204148] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"155.498343ms","start":"2026-04-10T01:10:11.51484Z","end":"2026-04-10T01:10:11.670338Z","steps":["trace[584204148] 'process raft request' (duration: 155.262018ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:11.741648Z","caller":"traceutil/trace.go:171","msg":"trace[1987216597] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"207.786759ms","start":"2026-04-10T01:10:11.53383Z","end":"2026-04-10T01:10:11.741617Z","steps":["trace[1987216597] 'process raft request' (duration: 207.435871ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:11.742736Z","caller":"traceutil/trace.go:171","msg":"trace[1453628397] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"164.536557ms","start":"2026-04-10T01:10:11.57818Z","end":"2026-04-10T01:10:11.742716Z","steps":["trace[1453628397] 'process raft request' (duration: 163.475432ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:12.831264Z","caller":"traceutil/trace.go:171","msg":"trace[1399636252] linearizableReadLoop","detail":"{readStateIndex:747; appliedIndex:746; }","duration":"168.265885ms","start":"2026-04-10T01:10:12.662967Z","end":"2026-04-10T01:10:12.831233Z","steps":["trace[1399636252] 'read index received' (duration: 168.180223ms)","trace[1399636252] 'applied index is now lower than readState.Index' (duration: 84.742µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:12.831417Z","caller":"traceutil/trace.go:171","msg":"trace[1437034341] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"208.208488ms","start":"2026-04-10T01:10:12.623082Z","end":"2026-04-10T01:10:12.83129Z","steps":["trace[1437034341] 'process raft request' (duration: 207.966383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:12.831733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.750416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-04-10T01:10:12.831783Z","caller":"traceutil/trace.go:171","msg":"trace[1619803988] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:718; }","duration":"168.817888ms","start":"2026-04-10T01:10:12.66295Z","end":"2026-04-10T01:10:12.831768Z","steps":["trace[1619803988] 'agreement among raft nodes before linearized reading' (duration: 168.386947ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:13.024633Z","caller":"traceutil/trace.go:171","msg":"trace[1871338464] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"188.004991ms","start":"2026-04-10T01:10:12.836603Z","end":"2026-04-10T01:10:13.024608Z","steps":["trace[1871338464] 'process raft request' (duration: 160.103542ms)","trace[1871338464] 'compare' (duration: 27.803837ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:13.058735Z","caller":"traceutil/trace.go:171","msg":"trace[397499974] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:747; }","duration":"107.443278ms","start":"2026-04-10T01:10:12.951278Z","end":"2026-04-10T01:10:13.058721Z","steps":["trace[397499974] 'read index received' (duration: 45.433153ms)","trace[397499974] 'applied index is now lower than readState.Index' (duration: 62.009295ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:13.058801Z","caller":"traceutil/trace.go:171","msg":"trace[1765207915] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"221.305698ms","start":"2026-04-10T01:10:12.837489Z","end":"2026-04-10T01:10:13.058794Z","steps":["trace[1765207915] 'process raft request' (duration: 221.132954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:13.05898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.682324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:13.059061Z","caller":"traceutil/trace.go:171","msg":"trace[1774947095] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:720; }","duration":"107.796337ms","start":"2026-04-10T01:10:12.95125Z","end":"2026-04-10T01:10:13.059046Z","steps":["trace[1774947095] 'agreement among raft nodes before linearized reading' (duration: 107.658014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:13.066012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.651839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:13.066058Z","caller":"traceutil/trace.go:171","msg":"trace[1786941658] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:722; }","duration":"114.73474ms","start":"2026-04-10T01:10:12.951312Z","end":"2026-04-10T01:10:13.066047Z","steps":["trace[1786941658] 'agreement among raft nodes before linearized reading' (duration: 114.669238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:13.066141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.464724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:13.066165Z","caller":"traceutil/trace.go:171","msg":"trace[41162514] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:722; }","duration":"114.512665ms","start":"2026-04-10T01:10:12.951646Z","end":"2026-04-10T01:10:13.066159Z","steps":["trace[41162514] 'agreement among raft nodes before linearized reading' (duration: 114.478794ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:18.104541Z","caller":"traceutil/trace.go:171","msg":"trace[1198202993] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"106.064846ms","start":"2026-04-10T01:10:17.998447Z","end":"2026-04-10T01:10:18.104512Z","steps":["trace[1198202993] 'process raft request' (duration: 105.896672ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:18.126137Z","caller":"traceutil/trace.go:171","msg":"trace[1768043704] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"127.389649ms","start":"2026-04-10T01:10:17.998724Z","end":"2026-04-10T01:10:18.126114Z","steps":["trace[1768043704] 'process raft request' (duration: 127.342398ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:18.126275Z","caller":"traceutil/trace.go:171","msg":"trace[1444665860] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"127.638776ms","start":"2026-04-10T01:10:17.998628Z","end":"2026-04-10T01:10:18.126267Z","steps":["trace[1444665860] 'process raft request' (duration: 127.338699ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:18.895408Z","caller":"traceutil/trace.go:171","msg":"trace[900966575] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"248.347596ms","start":"2026-04-10T01:10:18.647024Z","end":"2026-04-10T01:10:18.895371Z","steps":["trace[900966575] 'process raft request' (duration: 172.814302ms)","trace[900966575] 'compare' (duration: 75.415432ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:18.95656Z","caller":"traceutil/trace.go:171","msg":"trace[572433471] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"308.106778ms","start":"2026-04-10T01:10:18.648431Z","end":"2026-04-10T01:10:18.956538Z","steps":["trace[572433471] 'process raft request' (duration: 307.936794ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:18.956729Z","caller":"traceutil/trace.go:171","msg":"trace[318446550] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"306.982301ms","start":"2026-04-10T01:10:18.649729Z","end":"2026-04-10T01:10:18.956711Z","steps":["trace[318446550] 'process raft request' (duration: 306.753546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:18.956861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:18.649723Z","time spent":"307.066013ms","remote":"127.0.0.1:43608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1290,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:10:18.956739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:18.648416Z","time spent":"308.235361ms","remote":"127.0.0.1:43816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:10:19.293031Z","caller":"traceutil/trace.go:171","msg":"trace[1354581709] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:799; }","duration":"325.015028ms","start":"2026-04-10T01:10:18.967994Z","end":"2026-04-10T01:10:19.293009Z","steps":["trace[1354581709] 'read index received' (duration: 324.744671ms)","trace[1354581709] 'applied index is now lower than readState.Index' (duration: 269.617µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:19.293071Z","caller":"traceutil/trace.go:171","msg":"trace[1134169899] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"326.38539ms","start":"2026-04-10T01:10:18.966652Z","end":"2026-04-10T01:10:19.293038Z","steps":["trace[1134169899] 'process raft request' (duration: 326.178185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:19.293226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.207182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:19.293277Z","caller":"traceutil/trace.go:171","msg":"trace[117104990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:769; }","duration":"325.297125ms","start":"2026-04-10T01:10:18.967969Z","end":"2026-04-10T01:10:19.293266Z","steps":["trace[117104990] 'agreement among raft nodes before linearized reading' (duration: 325.172952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:19.293316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:18.96796Z","time spent":"325.348166ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:10:19.293342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:18.966635Z","time spent":"326.608095ms","remote":"127.0.0.1:43800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:10:19.293389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.232454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:19.293506Z","caller":"traceutil/trace.go:171","msg":"trace[1864592746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:769; }","duration":"237.390198ms","start":"2026-04-10T01:10:19.056103Z","end":"2026-04-10T01:10:19.293493Z","steps":["trace[1864592746] 'agreement among raft nodes before linearized reading' (duration: 237.108451ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:20.731801Z","caller":"traceutil/trace.go:171","msg":"trace[122645932] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"224.831092ms","start":"2026-04-10T01:10:20.506926Z","end":"2026-04-10T01:10:20.731757Z","steps":["trace[122645932] 'process raft request' (duration: 221.674127ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.258899Z","caller":"traceutil/trace.go:171","msg":"trace[1209066838] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"687.463651ms","start":"2026-04-10T01:10:23.571413Z","end":"2026-04-10T01:10:24.258876Z","steps":["trace[1209066838] 'process raft request' (duration: 687.258516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:24.259111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:23.571378Z","time spent":"687.635784ms","remote":"127.0.0.1:43572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:10:24.296208Z","caller":"traceutil/trace.go:171","msg":"trace[1476548030] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:822; }","duration":"275.610571ms","start":"2026-04-10T01:10:24.020573Z","end":"2026-04-10T01:10:24.296183Z","steps":["trace[1476548030] 'read index received' (duration: 238.047053ms)","trace[1476548030] 'applied index is now lower than readState.Index' (duration: 37.562448ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:24.29633Z","caller":"traceutil/trace.go:171","msg":"trace[866936120] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"562.487188ms","start":"2026-04-10T01:10:23.733834Z","end":"2026-04-10T01:10:24.296321Z","steps":["trace[866936120] 'process raft request' (duration: 562.204001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:24.296442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:23.733805Z","time spent":"562.558469ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:10:24.296498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.429699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:24.296574Z","caller":"traceutil/trace.go:171","msg":"trace[372995030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"240.534092ms","start":"2026-04-10T01:10:24.056022Z","end":"2026-04-10T01:10:24.296556Z","steps":["trace[372995030] 'agreement among raft nodes before linearized reading' (duration: 240.41705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:24.29677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.735663ms","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-04-10T01:10:24.296812Z","caller":"traceutil/trace.go:171","msg":"trace[1911576746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"170.813975ms","start":"2026-04-10T01:10:24.125985Z","end":"2026-04-10T01:10:24.296799Z","steps":["trace[1911576746] 'agreement among raft nodes before linearized reading' (duration: 170.732263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:24.296871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.943699ms","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-04-10T01:10:24.297011Z","caller":"traceutil/trace.go:171","msg":"trace[1493101307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"152.167155ms","start":"2026-04-10T01:10:24.144824Z","end":"2026-04-10T01:10:24.296991Z","steps":["trace[1493101307] 'agreement among raft nodes before linearized reading' (duration: 151.760525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:24.297186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.603924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-10T01:10:24.297449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.298197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T01:10:24.297503Z","caller":"traceutil/trace.go:171","msg":"trace[1210365128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"152.376799ms","start":"2026-04-10T01:10:24.145112Z","end":"2026-04-10T01:10:24.297489Z","steps":["trace[1210365128] 'agreement among raft nodes before linearized reading' (duration: 151.378386ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.297261Z","caller":"traceutil/trace.go:171","msg":"trace[1719775130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"276.722377ms","start":"2026-04-10T01:10:24.020523Z","end":"2026-04-10T01:10:24.297245Z","steps":["trace[1719775130] 'agreement among raft nodes before linearized reading' (duration: 276.251366ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.442255Z","caller":"traceutil/trace.go:171","msg":"trace[1871551578] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"140.662133ms","start":"2026-04-10T01:10:24.301569Z","end":"2026-04-10T01:10:24.442231Z","steps":["trace[1871551578] 'process raft request' (duration: 140.584931ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.442616Z","caller":"traceutil/trace.go:171","msg":"trace[1792307857] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"141.307998ms","start":"2026-04-10T01:10:24.301261Z","end":"2026-04-10T01:10:24.442569Z","steps":["trace[1792307857] 'process raft request' (duration: 140.721084ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.442586Z","caller":"traceutil/trace.go:171","msg":"trace[994924774] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"140.287834ms","start":"2026-04-10T01:10:24.302277Z","end":"2026-04-10T01:10:24.442564Z","steps":["trace[994924774] 'process raft request' (duration: 139.919585ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.442838Z","caller":"traceutil/trace.go:171","msg":"trace[1209991557] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"140.519809ms","start":"2026-04-10T01:10:24.302308Z","end":"2026-04-10T01:10:24.442828Z","steps":["trace[1209991557] 'process raft request' (duration: 140.16087ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:24.699452Z","caller":"traceutil/trace.go:171","msg":"trace[121418526] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"126.316944ms","start":"2026-04-10T01:10:24.573114Z","end":"2026-04-10T01:10:24.699431Z","steps":["trace[121418526] 'process raft request' (duration: 126.188521ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:27.707568Z","caller":"traceutil/trace.go:171","msg":"trace[1708704472] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"116.110403ms","start":"2026-04-10T01:10:27.591436Z","end":"2026-04-10T01:10:27.707546Z","steps":["trace[1708704472] 'process raft request' (duration: 115.863787ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:36.729337Z","caller":"traceutil/trace.go:171","msg":"trace[508428814] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"138.53047ms","start":"2026-04-10T01:10:36.590782Z","end":"2026-04-10T01:10:36.729313Z","steps":["trace[508428814] 'process raft request' (duration: 138.453999ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:36.729393Z","caller":"traceutil/trace.go:171","msg":"trace[1178147899] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"138.804776ms","start":"2026-04-10T01:10:36.590546Z","end":"2026-04-10T01:10:36.729351Z","steps":["trace[1178147899] 'process raft request' (duration: 119.984432ms)","trace[1178147899] 'compare' (duration: 18.551838ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:36.729788Z","caller":"traceutil/trace.go:171","msg":"trace[438651003] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"138.692134ms","start":"2026-04-10T01:10:36.591056Z","end":"2026-04-10T01:10:36.729749Z","steps":["trace[438651003] 'process raft request' (duration: 138.224443ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:44.644959Z","caller":"traceutil/trace.go:171","msg":"trace[1319554337] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"141.237714ms","start":"2026-04-10T01:10:44.503685Z","end":"2026-04-10T01:10:44.644923Z","steps":["trace[1319554337] 'process raft request' (duration: 140.985078ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:53.437855Z","caller":"traceutil/trace.go:171","msg":"trace[1754624706] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"159.791071ms","start":"2026-04-10T01:10:53.278041Z","end":"2026-04-10T01:10:53.437832Z","steps":["trace[1754624706] 'process raft request' (duration: 159.666048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:53.815741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.81553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T01:10:53.81583Z","caller":"traceutil/trace.go:171","msg":"trace[1418294978] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:985; }","duration":"111.959084ms","start":"2026-04-10T01:10:53.70384Z","end":"2026-04-10T01:10:53.815799Z","steps":["trace[1418294978] 'count revisions from in-memory index tree' (duration: 111.739979ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:57.146555Z","caller":"traceutil/trace.go:171","msg":"trace[1642576043] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"100.572484ms","start":"2026-04-10T01:10:57.045962Z","end":"2026-04-10T01:10:57.146535Z","steps":["trace[1642576043] 'process raft request' (duration: 100.155264ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:57.369032Z","caller":"traceutil/trace.go:171","msg":"trace[1304063781] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"213.624873ms","start":"2026-04-10T01:10:57.15538Z","end":"2026-04-10T01:10:57.369005Z","steps":["trace[1304063781] 'process raft request' (duration: 207.099459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:59.416408Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333951555,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T01:10:59.477295Z","caller":"traceutil/trace.go:171","msg":"trace[1040385824] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"561.26764ms","start":"2026-04-10T01:10:58.916006Z","end":"2026-04-10T01:10:59.477274Z","steps":["trace[1040385824] 'read index received' (duration: 561.120436ms)","trace[1040385824] 'applied index is now lower than readState.Index' (duration: 146.204µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:10:59.477347Z","caller":"traceutil/trace.go:171","msg":"trace[2075834912] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"564.027155ms","start":"2026-04-10T01:10:58.91329Z","end":"2026-04-10T01:10:59.477317Z","steps":["trace[2075834912] 'process raft request' (duration: 563.83895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:59.477478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:58.913278Z","time spent":"564.124477ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:10:59.477483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.039759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:59.477533Z","caller":"traceutil/trace.go:171","msg":"trace[1763277714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"421.121271ms","start":"2026-04-10T01:10:59.056398Z","end":"2026-04-10T01:10:59.477519Z","steps":["trace[1763277714] 'agreement among raft nodes before linearized reading' (duration: 421.04425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:59.47757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:59.056384Z","time spent":"421.177312ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:10:59.477557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.977662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T01:10:59.477654Z","caller":"traceutil/trace.go:171","msg":"trace[931242291] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1005; }","duration":"489.106226ms","start":"2026-04-10T01:10:58.988519Z","end":"2026-04-10T01:10:59.477625Z","steps":["trace[931242291] 'agreement among raft nodes before linearized reading' (duration: 488.944662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:59.477699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:58.988507Z","time spent":"489.180227ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:10:59.478121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.108209ms","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-04-10T01:10:59.478187Z","caller":"traceutil/trace.go:171","msg":"trace[1589018642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1005; }","duration":"562.183751ms","start":"2026-04-10T01:10:58.915982Z","end":"2026-04-10T01:10:59.478166Z","steps":["trace[1589018642] 'agreement among raft nodes before linearized reading' (duration: 561.379352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:59.478227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:58.915975Z","time spent":"562.240462ms","remote":"127.0.0.1:43596","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-04-10T01:10:59.478282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.649305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:10:59.478367Z","caller":"traceutil/trace.go:171","msg":"trace[1053851605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1005; }","duration":"560.775888ms","start":"2026-04-10T01:10:58.917565Z","end":"2026-04-10T01:10:59.478341Z","steps":["trace[1053851605] 'agreement among raft nodes before linearized reading' (duration: 559.851286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:59.478402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:58.917541Z","time spent":"560.85351ms","remote":"127.0.0.1:43596","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-04-10T01:11:00.672177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074422292s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:11:00.672317Z","caller":"traceutil/trace.go:171","msg":"trace[64421329] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1045; }","duration":"1.147357013s","start":"2026-04-10T01:10:59.524948Z","end":"2026-04-10T01:11:00.672305Z","steps":["trace[64421329] 'read index received' (duration: 72.973692ms)","trace[64421329] 'applied index is now lower than readState.Index' (duration: 1.074382681s)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:11:00.672378Z","caller":"traceutil/trace.go:171","msg":"trace[1618184762] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"1.190327378s","start":"2026-04-10T01:10:59.482044Z","end":"2026-04-10T01:11:00.672372Z","steps":["trace[1618184762] 'process raft request' (duration: 1.190203345s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:00.672415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:59.482025Z","time spent":"1.190368958s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:00.672416Z","caller":"traceutil/trace.go:171","msg":"trace[776115731] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"1.19046011s","start":"2026-04-10T01:10:59.481933Z","end":"2026-04-10T01:11:00.672393Z","steps":["trace[776115731] 'process raft request' (duration: 115.764052ms)","trace[776115731] 'compare' (duration: 1.074142775s)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:11:00.672521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:59.481916Z","time spent":"1.190547373s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:00.672534Z","caller":"traceutil/trace.go:171","msg":"trace[1854685676] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"1.16969319s","start":"2026-04-10T01:10:59.502835Z","end":"2026-04-10T01:11:00.672528Z","steps":["trace[1854685676] 'process raft request' (duration: 1.169445165s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:00.672569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:59.502807Z","time spent":"1.169744862s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:11:00.672631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147681061s","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-04-10T01:11:00.672647Z","caller":"traceutil/trace.go:171","msg":"trace[1734817121] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1008; }","duration":"1.147721982s","start":"2026-04-10T01:10:59.52492Z","end":"2026-04-10T01:11:00.672642Z","steps":["trace[1734817121] 'agreement among raft nodes before linearized reading' (duration: 1.147691291s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:00.672665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:59.524911Z","time spent":"1.147748843s","remote":"127.0.0.1:43824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:11:00.672882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.416713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T01:11:00.672958Z","caller":"traceutil/trace.go:171","msg":"trace[26832875] range","detail":"{range_begin:/registry/masterleases/199.204.45.102; range_end:; response_count:1; response_revision:1008; }","duration":"195.533496ms","start":"2026-04-10T01:11:00.477403Z","end":"2026-04-10T01:11:00.672936Z","steps":["trace[26832875] 'agreement among raft nodes before linearized reading' (duration: 195.332861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:02.256443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036664391s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-04-10T01:11:02.256528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:00.674196Z","time spent":"1.58232815s","remote":"127.0.0.1:43396","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-10T01:11:02.452862Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.233123938s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T01:11:02.45848Z","caller":"traceutil/trace.go:171","msg":"trace[2050816295] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"200.888052ms","start":"2026-04-10T01:11:02.257565Z","end":"2026-04-10T01:11:02.458453Z","steps":["trace[2050816295] 'process raft request' (duration: 200.837611ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:02.458551Z","caller":"traceutil/trace.go:171","msg":"trace[1887478766] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1048; }","duration":"1.727679901s","start":"2026-04-10T01:11:00.730864Z","end":"2026-04-10T01:11:02.458544Z","steps":["trace[1887478766] 'read index received' (duration: 488.89574ms)","trace[1887478766] 'applied index is now lower than readState.Index' (duration: 1.238783221s)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:11:02.45872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.727843445s","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-04-10T01:11:02.458498Z","caller":"traceutil/trace.go:171","msg":"trace[960217632] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"1.762965413s","start":"2026-04-10T01:11:00.695511Z","end":"2026-04-10T01:11:02.458476Z","steps":["trace[960217632] 'process raft request' (duration: 1.757518095s)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:02.458753Z","caller":"traceutil/trace.go:171","msg":"trace[1060213895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1010; }","duration":"1.727903145s","start":"2026-04-10T01:11:00.730832Z","end":"2026-04-10T01:11:02.458735Z","steps":["trace[1060213895] 'agreement among raft nodes before linearized reading' (duration: 1.727770942s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:02.458776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:00.73082Z","time spent":"1.727950527s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T01:11:02.458844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:00.695459Z","time spent":"1.763299101s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:11:02.458932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.692767577s","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-04-10T01:11:02.45895Z","caller":"traceutil/trace.go:171","msg":"trace[1725654026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"1.692813537s","start":"2026-04-10T01:11:00.766131Z","end":"2026-04-10T01:11:02.458945Z","steps":["trace[1725654026] 'agreement among raft nodes before linearized reading' (duration: 1.692764136s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:02.458966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:00.766087Z","time spent":"1.692875519s","remote":"127.0.0.1:43596","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":"warn","ts":"2026-04-10T01:11:02.459026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124126284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:11:02.459014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.931033ms","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-04-10T01:11:02.45904Z","caller":"traceutil/trace.go:171","msg":"trace[1432581130] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1010; }","duration":"1.124178125s","start":"2026-04-10T01:11:01.334857Z","end":"2026-04-10T01:11:02.459036Z","steps":["trace[1432581130] 'agreement among raft nodes before linearized reading' (duration: 1.124148395s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:02.459057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:01.334837Z","time spent":"1.124215776s","remote":"127.0.0.1:43650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-04-10T01:11:02.459054Z","caller":"traceutil/trace.go:171","msg":"trace[348958777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"977.999375ms","start":"2026-04-10T01:11:01.481044Z","end":"2026-04-10T01:11:02.459044Z","steps":["trace[348958777] 'agreement among raft nodes before linearized reading' (duration: 977.854651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:02.459085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:01.481036Z","time spent":"978.042136ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T01:11:02.459157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.403066128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:02.459174Z","caller":"traceutil/trace.go:171","msg":"trace[1742327911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"1.40311918s","start":"2026-04-10T01:11:01.05605Z","end":"2026-04-10T01:11:02.459169Z","steps":["trace[1742327911] 'agreement among raft nodes before linearized reading' (duration: 1.403091619s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:02.459191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:01.056029Z","time spent":"1.40315785s","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:11:02.459197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.917335ms","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-04-10T01:11:02.459229Z","caller":"traceutil/trace.go:171","msg":"trace[765167895] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1010; }","duration":"149.002657ms","start":"2026-04-10T01:11:02.310217Z","end":"2026-04-10T01:11:02.45922Z","steps":["trace[765167895] 'agreement among raft nodes before linearized reading' (duration: 148.950526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:09.083744Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333951618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:11:09.584368Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333951618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:11:10.085054Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333951618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:11:10.536339Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.829515585s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T01:11:10.536666Z","caller":"traceutil/trace.go:171","msg":"trace[374055754] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"1.969980421s","start":"2026-04-10T01:11:08.56666Z","end":"2026-04-10T01:11:10.536641Z","steps":["trace[374055754] 'process raft request' (duration: 1.969850038s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.536788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.566636Z","time spent":"1.970088013s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:10.57004Z","caller":"traceutil/trace.go:171","msg":"trace[1704670224] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1071; }","duration":"1.986747168s","start":"2026-04-10T01:11:08.583271Z","end":"2026-04-10T01:11:10.570018Z","steps":["trace[1704670224] 'read index received' (duration: 1.953261637s)","trace[1704670224] 'applied index is now lower than readState.Index' (duration: 33.484341ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:11:10.570172Z","caller":"traceutil/trace.go:171","msg":"trace[2035856283] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"1.864482501s","start":"2026-04-10T01:11:08.705678Z","end":"2026-04-10T01:11:10.570161Z","steps":["trace[2035856283] 'process raft request' (duration: 1.864216925s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.570271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.705649Z","time spent":"1.864555723s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:11:10.570412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.987124086s","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-04-10T01:11:10.570639Z","caller":"traceutil/trace.go:171","msg":"trace[1202586311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1031; }","duration":"1.987392373s","start":"2026-04-10T01:11:08.583223Z","end":"2026-04-10T01:11:10.570615Z","steps":["trace[1202586311] 'agreement among raft nodes before linearized reading' (duration: 1.986997423s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.570935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.601721688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:10.570978Z","caller":"traceutil/trace.go:171","msg":"trace[702908614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1031; }","duration":"1.601820391s","start":"2026-04-10T01:11:08.969146Z","end":"2026-04-10T01:11:10.570966Z","steps":["trace[702908614] 'agreement among raft nodes before linearized reading' (duration: 1.6017714s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.571009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.969132Z","time spent":"1.601871362s","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:11:10.571021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.583202Z","time spent":"1.987749361s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T01:11:10.571304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.861188343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:11:10.571391Z","caller":"traceutil/trace.go:171","msg":"trace[1993412905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"1.861294606s","start":"2026-04-10T01:11:08.710072Z","end":"2026-04-10T01:11:10.571367Z","steps":["trace[1993412905] 'agreement among raft nodes before linearized reading' (duration: 1.861143932s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.571429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.710052Z","time spent":"1.861368078s","remote":"127.0.0.1:43596","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-04-10T01:11:10.571444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154728687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:10.571531Z","caller":"traceutil/trace.go:171","msg":"trace[58462320] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1031; }","duration":"1.15486086s","start":"2026-04-10T01:11:09.416655Z","end":"2026-04-10T01:11:10.571516Z","steps":["trace[58462320] 'agreement among raft nodes before linearized reading' (duration: 1.154720157s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.571576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:09.416632Z","time spent":"1.154934412s","remote":"127.0.0.1:43742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:11:10.571677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.862491464s","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-04-10T01:11:10.571712Z","caller":"traceutil/trace.go:171","msg":"trace[269832204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"1.862563545s","start":"2026-04-10T01:11:08.709138Z","end":"2026-04-10T01:11:10.571702Z","steps":["trace[269832204] 'agreement among raft nodes before linearized reading' (duration: 1.862473683s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.571741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.709096Z","time spent":"1.862639417s","remote":"127.0.0.1:43596","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-04-10T01:11:10.570871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.985402386s","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-04-10T01:11:10.571901Z","caller":"traceutil/trace.go:171","msg":"trace[1168164919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1031; }","duration":"1.986463201s","start":"2026-04-10T01:11:08.585426Z","end":"2026-04-10T01:11:10.571889Z","steps":["trace[1168164919] 'agreement among raft nodes before linearized reading' (duration: 1.985334814s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.571944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:08.585407Z","time spent":"1.986526182s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T01:11:10.570899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.514283265s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:10.572096Z","caller":"traceutil/trace.go:171","msg":"trace[805418375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1031; }","duration":"1.515511334s","start":"2026-04-10T01:11:09.056574Z","end":"2026-04-10T01:11:10.572085Z","steps":["trace[805418375] 'agreement among raft nodes before linearized reading' (duration: 1.514285705s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:10.572135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:09.056556Z","time spent":"1.515570315s","remote":"127.0.0.1:43368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T01:11:15.496601Z","caller":"traceutil/trace.go:171","msg":"trace[1558383388] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"144.315715ms","start":"2026-04-10T01:11:15.352258Z","end":"2026-04-10T01:11:15.496574Z","steps":["trace[1558383388] 'process raft request' (duration: 144.10296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:22.8486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.424124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:11:22.848747Z","caller":"traceutil/trace.go:171","msg":"trace[187521159] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"144.867379ms","start":"2026-04-10T01:11:22.703839Z","end":"2026-04-10T01:11:22.848707Z","steps":["trace[187521159] 'process raft request' (duration: 32.250741ms)","trace[187521159] 'compare' (duration: 112.306461ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:11:24.847931Z","caller":"traceutil/trace.go:171","msg":"trace[327548657] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"177.246734ms","start":"2026-04-10T01:11:24.670648Z","end":"2026-04-10T01:11:24.847895Z","steps":["trace[327548657] 'process raft request' (duration: 177.028669ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:25.055759Z","caller":"traceutil/trace.go:171","msg":"trace[1215243837] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"117.787701ms","start":"2026-04-10T01:11:24.937952Z","end":"2026-04-10T01:11:25.05574Z","steps":["trace[1215243837] 'process raft request' (duration: 117.74826ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:25.055826Z","caller":"traceutil/trace.go:171","msg":"trace[1072066444] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"118.314103ms","start":"2026-04-10T01:11:24.937444Z","end":"2026-04-10T01:11:25.055758Z","steps":["trace[1072066444] 'process raft request' (duration: 103.033982ms)","trace[1072066444] 'compare' (duration: 15.107397ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:11:26.48877Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333951748,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T01:11:26.547885Z","caller":"traceutil/trace.go:171","msg":"trace[363723989] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"840.485579ms","start":"2026-04-10T01:11:25.707374Z","end":"2026-04-10T01:11:26.54786Z","steps":["trace[363723989] 'process raft request' (duration: 840.326005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:26.548108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:25.707348Z","time spent":"840.619051ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:26.910394Z","caller":"traceutil/trace.go:171","msg":"trace[269042334] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1127; }","duration":"922.593857ms","start":"2026-04-10T01:11:25.987724Z","end":"2026-04-10T01:11:26.910318Z","steps":["trace[269042334] 'read index received' (duration: 559.976067ms)","trace[269042334] 'applied index is now lower than readState.Index' (duration: 362.61586ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:11:26.91085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.081778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:26.910995Z","caller":"traceutil/trace.go:171","msg":"trace[342432463] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1083; }","duration":"923.272993ms","start":"2026-04-10T01:11:25.987667Z","end":"2026-04-10T01:11:26.91094Z","steps":["trace[342432463] 'agreement among raft nodes before linearized reading' (duration: 923.026517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:26.911076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:25.987644Z","time spent":"923.395426ms","remote":"127.0.0.1:53364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-04-10T01:11:27.022169Z","caller":"traceutil/trace.go:171","msg":"trace[1317814987] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"111.672436ms","start":"2026-04-10T01:11:26.910467Z","end":"2026-04-10T01:11:27.02214Z","steps":["trace[1317814987] 'read index received' (duration: 111.390379ms)","trace[1317814987] 'applied index is now lower than readState.Index' (duration: 281.137µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:11:27.022437Z","caller":"traceutil/trace.go:171","msg":"trace[912897589] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"120.132836ms","start":"2026-04-10T01:11:26.902291Z","end":"2026-04-10T01:11:27.022424Z","steps":["trace[912897589] 'process raft request' (duration: 119.687775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:27.022704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.95931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:11:27.022837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.476775ms","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-04-10T01:11:27.022866Z","caller":"traceutil/trace.go:171","msg":"trace[537137892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"966.153065ms","start":"2026-04-10T01:11:26.056647Z","end":"2026-04-10T01:11:27.022801Z","steps":["trace[537137892] 'agreement among raft nodes before linearized reading' (duration: 965.876028ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:27.022947Z","caller":"traceutil/trace.go:171","msg":"trace[306901453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1084; }","duration":"170.636608ms","start":"2026-04-10T01:11:26.852281Z","end":"2026-04-10T01:11:27.022918Z","steps":["trace[306901453] 'agreement among raft nodes before linearized reading' (duration: 170.30358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:27.022972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:26.056629Z","time spent":"966.330139ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T01:11:29.338909Z","caller":"traceutil/trace.go:171","msg":"trace[1850583348] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"295.548886ms","start":"2026-04-10T01:11:29.043339Z","end":"2026-04-10T01:11:29.338888Z","steps":["trace[1850583348] 'read index received' (duration: 295.397432ms)","trace[1850583348] 'applied index is now lower than readState.Index' (duration: 150.324µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:11:29.339087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.305967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:29.339056Z","caller":"traceutil/trace.go:171","msg":"trace[821219354] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"311.176145ms","start":"2026-04-10T01:11:29.027839Z","end":"2026-04-10T01:11:29.339015Z","steps":["trace[821219354] 'process raft request' (duration: 310.910069ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:29.339127Z","caller":"traceutil/trace.go:171","msg":"trace[1708379717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1090; }","duration":"283.388069ms","start":"2026-04-10T01:11:29.055726Z","end":"2026-04-10T01:11:29.339114Z","steps":["trace[1708379717] 'agreement among raft nodes before linearized reading' (duration: 283.316048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:29.339125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.776351ms","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-04-10T01:11:29.339178Z","caller":"traceutil/trace.go:171","msg":"trace[527425100] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1090; }","duration":"295.861053ms","start":"2026-04-10T01:11:29.043304Z","end":"2026-04-10T01:11:29.339165Z","steps":["trace[527425100] 'agreement among raft nodes before linearized reading' (duration: 295.71078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:29.339383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.960487ms","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-04-10T01:11:29.339416Z","caller":"traceutil/trace.go:171","msg":"trace[159211855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1090; }","duration":"166.028799ms","start":"2026-04-10T01:11:29.173379Z","end":"2026-04-10T01:11:29.339408Z","steps":["trace[159211855] 'agreement among raft nodes before linearized reading' (duration: 165.940967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:29.339432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:29.027805Z","time spent":"311.39758ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:11:29.339565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.142242ms","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-04-10T01:11:29.339608Z","caller":"traceutil/trace.go:171","msg":"trace[1354948828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"166.207924ms","start":"2026-04-10T01:11:29.173389Z","end":"2026-04-10T01:11:29.339597Z","steps":["trace[1354948828] 'agreement among raft nodes before linearized reading' (duration: 166.088091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:29.339751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.894538ms","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-04-10T01:11:29.339792Z","caller":"traceutil/trace.go:171","msg":"trace[175470024] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1090; }","duration":"260.989171ms","start":"2026-04-10T01:11:29.078794Z","end":"2026-04-10T01:11:29.339783Z","steps":["trace[175470024] 'agreement among raft nodes before linearized reading' (duration: 260.882219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:29.340192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.053782ms","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-04-10T01:11:29.340358Z","caller":"traceutil/trace.go:171","msg":"trace[1744510042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"261.247327ms","start":"2026-04-10T01:11:29.079089Z","end":"2026-04-10T01:11:29.340337Z","steps":["trace[1744510042] 'agreement among raft nodes before linearized reading' (duration: 260.276324ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:41.661896Z","caller":"traceutil/trace.go:171","msg":"trace[578972975] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"217.141632ms","start":"2026-04-10T01:11:41.444734Z","end":"2026-04-10T01:11:41.661875Z","steps":["trace[578972975] 'read index received' (duration: 216.987778ms)","trace[578972975] 'applied index is now lower than readState.Index' (duration: 152.863µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:11:41.661938Z","caller":"traceutil/trace.go:171","msg":"trace[1767584835] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"265.246702ms","start":"2026-04-10T01:11:41.396677Z","end":"2026-04-10T01:11:41.661923Z","steps":["trace[1767584835] 'process raft request' (duration: 265.079448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:41.662082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.373994ms","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-04-10T01:11:41.662113Z","caller":"traceutil/trace.go:171","msg":"trace[1649406009] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1181; }","duration":"211.441255ms","start":"2026-04-10T01:11:41.450663Z","end":"2026-04-10T01:11:41.662104Z","steps":["trace[1649406009] 'agreement among raft nodes before linearized reading' (duration: 211.316422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:41.662139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.314953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-10T01:11:41.662137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.397737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:41.662186Z","caller":"traceutil/trace.go:171","msg":"trace[56408967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1181; }","duration":"211.378274ms","start":"2026-04-10T01:11:41.4508Z","end":"2026-04-10T01:11:41.662178Z","steps":["trace[56408967] 'agreement among raft nodes before linearized reading' (duration: 211.287702ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:41.662201Z","caller":"traceutil/trace.go:171","msg":"trace[1933878733] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1181; }","duration":"181.50827ms","start":"2026-04-10T01:11:41.480683Z","end":"2026-04-10T01:11:41.662192Z","steps":["trace[1933878733] 'agreement among raft nodes before linearized reading' (duration: 181.426718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:41.662196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.414698ms","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-04-10T01:11:41.662234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.531938ms","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-04-10T01:11:41.662274Z","caller":"traceutil/trace.go:171","msg":"trace[815842595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1181; }","duration":"211.572379ms","start":"2026-04-10T01:11:41.450694Z","end":"2026-04-10T01:11:41.662267Z","steps":["trace[815842595] 'agreement among raft nodes before linearized reading' (duration: 211.497037ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:41.662278Z","caller":"traceutil/trace.go:171","msg":"trace[981498672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1181; }","duration":"217.566542ms","start":"2026-04-10T01:11:41.44469Z","end":"2026-04-10T01:11:41.662257Z","steps":["trace[981498672] 'agreement among raft nodes before linearized reading' (duration: 217.265154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:41.662083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.007995ms","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-04-10T01:11:41.662364Z","caller":"traceutil/trace.go:171","msg":"trace[1033694534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1181; }","duration":"211.303722ms","start":"2026-04-10T01:11:41.451055Z","end":"2026-04-10T01:11:41.662359Z","steps":["trace[1033694534] 'agreement among raft nodes before linearized reading' (duration: 210.973154ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:42.198729Z","caller":"traceutil/trace.go:171","msg":"trace[1637970955] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"532.343197ms","start":"2026-04-10T01:11:41.666358Z","end":"2026-04-10T01:11:42.198701Z","steps":["trace[1637970955] 'process raft request' (duration: 532.221914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:42.198852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:41.666342Z","time spent":"532.44088ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:42.227929Z","caller":"traceutil/trace.go:171","msg":"trace[229765689] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"561.460164ms","start":"2026-04-10T01:11:41.66644Z","end":"2026-04-10T01:11:42.2279Z","steps":["trace[229765689] 'process raft request' (duration: 561.355301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:42.228093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:41.666435Z","time spent":"561.572466ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:42.228283Z","caller":"traceutil/trace.go:171","msg":"trace[351869928] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"561.72161ms","start":"2026-04-10T01:11:41.666542Z","end":"2026-04-10T01:11:42.228264Z","steps":["trace[351869928] 'process raft request' (duration: 561.31288ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:42.228343Z","caller":"traceutil/trace.go:171","msg":"trace[2024724240] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"561.945096ms","start":"2026-04-10T01:11:41.666382Z","end":"2026-04-10T01:11:42.228327Z","steps":["trace[2024724240] 'process raft request' (duration: 561.234369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:42.228384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:41.666536Z","time spent":"561.799612ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:11:42.22843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:41.666363Z","time spent":"562.017647ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:42.228628Z","caller":"traceutil/trace.go:171","msg":"trace[1698311651] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1232; }","duration":"171.86436ms","start":"2026-04-10T01:11:42.056747Z","end":"2026-04-10T01:11:42.228612Z","steps":["trace[1698311651] 'read index received' (duration: 141.873422ms)","trace[1698311651] 'applied index is now lower than readState.Index' (duration: 29.989888ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:11:42.22874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.989442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:42.228792Z","caller":"traceutil/trace.go:171","msg":"trace[1216286431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1186; }","duration":"172.080785ms","start":"2026-04-10T01:11:42.056698Z","end":"2026-04-10T01:11:42.228779Z","steps":["trace[1216286431] 'agreement among raft nodes before linearized reading' (duration: 171.982232ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:42.228982Z","caller":"traceutil/trace.go:171","msg":"trace[1620544384] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"562.12847ms","start":"2026-04-10T01:11:41.666837Z","end":"2026-04-10T01:11:42.228965Z","steps":["trace[1620544384] 'process raft request' (duration: 561.348801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:42.229076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:41.666833Z","time spent":"562.197222ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:11:52.509097Z","caller":"traceutil/trace.go:171","msg":"trace[1299678266] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"205.141225ms","start":"2026-04-10T01:11:52.303929Z","end":"2026-04-10T01:11:52.50907Z","steps":["trace[1299678266] 'process raft request' (duration: 205.095744ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:52.509125Z","caller":"traceutil/trace.go:171","msg":"trace[1201353735] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"209.213782ms","start":"2026-04-10T01:11:52.299871Z","end":"2026-04-10T01:11:52.509085Z","steps":["trace[1201353735] 'process raft request' (duration: 208.954796ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:52.509278Z","caller":"traceutil/trace.go:171","msg":"trace[416458388] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"209.324235ms","start":"2026-04-10T01:11:52.299944Z","end":"2026-04-10T01:11:52.509269Z","steps":["trace[416458388] 'process raft request' (duration: 209.032868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:01.40449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.01429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:01.404584Z","caller":"traceutil/trace.go:171","msg":"trace[926593297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1281; }","duration":"348.203695ms","start":"2026-04-10T01:12:01.056362Z","end":"2026-04-10T01:12:01.404566Z","steps":["trace[926593297] 'range keys from in-memory index tree' (duration: 347.905708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:01.404628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:01.05634Z","time spent":"348.275597ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T01:12:02.053316Z","caller":"traceutil/trace.go:171","msg":"trace[426018801] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"194.878918ms","start":"2026-04-10T01:12:01.85841Z","end":"2026-04-10T01:12:02.053289Z","steps":["trace[426018801] 'process raft request' (duration: 194.747905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.295256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.872952ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:12:02.295367Z","caller":"traceutil/trace.go:171","msg":"trace[1601723620] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"413.999128ms","start":"2026-04-10T01:12:01.881336Z","end":"2026-04-10T01:12:02.295335Z","steps":["trace[1601723620] 'process raft request' (duration: 235.992732ms)","trace[1601723620] 'compare' (duration: 177.589526ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:02.295417Z","caller":"traceutil/trace.go:171","msg":"trace[630597388] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"238.518933ms","start":"2026-04-10T01:12:02.056877Z","end":"2026-04-10T01:12:02.295396Z","steps":["trace[630597388] 'process raft request' (duration: 238.457652ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.295443Z","caller":"traceutil/trace.go:171","msg":"trace[1702224630] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1338; }","duration":"397.429241ms","start":"2026-04-10T01:12:01.897988Z","end":"2026-04-10T01:12:02.295417Z","steps":["trace[1702224630] 'read index received' (duration: 155.159998ms)","trace[1702224630] 'applied index is now lower than readState.Index' (duration: 242.267363ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:12:02.295507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:01.881317Z","time spent":"414.11264ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:12:02.295732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.778329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:02.295768Z","caller":"traceutil/trace.go:171","msg":"trace[256416701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"238.83102ms","start":"2026-04-10T01:12:02.056927Z","end":"2026-04-10T01:12:02.295758Z","steps":["trace[256416701] 'agreement among raft nodes before linearized reading' (duration: 238.674896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.295731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.677727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:02.295835Z","caller":"traceutil/trace.go:171","msg":"trace[837220712] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1286; }","duration":"397.858211ms","start":"2026-04-10T01:12:01.897955Z","end":"2026-04-10T01:12:02.295813Z","steps":["trace[837220712] 'agreement among raft nodes before linearized reading' (duration: 397.566124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.295914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:01.897939Z","time spent":"397.958423ms","remote":"127.0.0.1:46964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-04-10T01:12:02.602535Z","caller":"traceutil/trace.go:171","msg":"trace[893995585] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1342; }","duration":"180.520446ms","start":"2026-04-10T01:12:02.42199Z","end":"2026-04-10T01:12:02.60251Z","steps":["trace[893995585] 'read index received' (duration: 180.335462ms)","trace[893995585] 'applied index is now lower than readState.Index' (duration: 183.864µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:02.602579Z","caller":"traceutil/trace.go:171","msg":"trace[74092116] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"300.978536ms","start":"2026-04-10T01:12:02.301573Z","end":"2026-04-10T01:12:02.602551Z","steps":["trace[74092116] 'process raft request' (duration: 300.804992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.60273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:02.301556Z","time spent":"301.088419ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:12:02.602767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.767983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:12:02.602802Z","caller":"traceutil/trace.go:171","msg":"trace[416320946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1288; }","duration":"180.821714ms","start":"2026-04-10T01:12:02.421968Z","end":"2026-04-10T01:12:02.60279Z","steps":["trace[416320946] 'agreement among raft nodes before linearized reading' (duration: 180.67563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.602813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.12068ms","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-04-10T01:12:02.602858Z","caller":"traceutil/trace.go:171","msg":"trace[146449677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1288; }","duration":"122.198632ms","start":"2026-04-10T01:12:02.480647Z","end":"2026-04-10T01:12:02.602846Z","steps":["trace[146449677] 'agreement among raft nodes before linearized reading' (duration: 122.075439ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.72703Z","caller":"traceutil/trace.go:171","msg":"trace[44790441] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"120.172543ms","start":"2026-04-10T01:12:02.606832Z","end":"2026-04-10T01:12:02.727004Z","steps":["trace[44790441] 'process raft request' (duration: 74.763138ms)","trace[44790441] 'compare' (duration: 45.235111ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:02.727298Z","caller":"traceutil/trace.go:171","msg":"trace[323331282] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"117.679224ms","start":"2026-04-10T01:12:02.609595Z","end":"2026-04-10T01:12:02.727274Z","steps":["trace[323331282] 'process raft request' (duration: 117.370056ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.72765Z","caller":"traceutil/trace.go:171","msg":"trace[2126917096] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"117.833607ms","start":"2026-04-10T01:12:02.609796Z","end":"2026-04-10T01:12:02.72763Z","steps":["trace[2126917096] 'process raft request' (duration: 117.383676ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.728213Z","caller":"traceutil/trace.go:171","msg":"trace[905395821] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"118.297548ms","start":"2026-04-10T01:12:02.609898Z","end":"2026-04-10T01:12:02.728195Z","steps":["trace[905395821] 'process raft request' (duration: 117.633312ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:03.20666Z","caller":"traceutil/trace.go:171","msg":"trace[288604313] linearizableReadLoop","detail":"{readStateIndex:1349; appliedIndex:1348; }","duration":"150.841467ms","start":"2026-04-10T01:12:03.055789Z","end":"2026-04-10T01:12:03.20663Z","steps":["trace[288604313] 'read index received' (duration: 150.588171ms)","trace[288604313] 'applied index is now lower than readState.Index' (duration: 252.126µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:12:03.206817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.0073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:03.206848Z","caller":"traceutil/trace.go:171","msg":"trace[643911156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1294; }","duration":"151.085813ms","start":"2026-04-10T01:12:03.055752Z","end":"2026-04-10T01:12:03.206838Z","steps":["trace[643911156] 'agreement among raft nodes before linearized reading' (duration: 150.99029ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:03.207218Z","caller":"traceutil/trace.go:171","msg":"trace[1049186402] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"319.775465ms","start":"2026-04-10T01:12:02.887431Z","end":"2026-04-10T01:12:03.207207Z","steps":["trace[1049186402] 'process raft request' (duration: 319.008177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:03.20741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:02.887413Z","time spent":"319.841076ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:12:03.758061Z","caller":"traceutil/trace.go:171","msg":"trace[1451073080] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"270.130938ms","start":"2026-04-10T01:12:03.487905Z","end":"2026-04-10T01:12:03.758036Z","steps":["trace[1451073080] 'process raft request' (duration: 269.977685ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:03.928138Z","caller":"traceutil/trace.go:171","msg":"trace[284750631] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"163.93727ms","start":"2026-04-10T01:12:03.764175Z","end":"2026-04-10T01:12:03.928113Z","steps":["trace[284750631] 'process raft request' (duration: 135.50674ms)","trace[284750631] 'compare' (duration: 28.330577ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:04.859085Z","caller":"traceutil/trace.go:171","msg":"trace[1506818307] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"124.942157ms","start":"2026-04-10T01:12:04.734116Z","end":"2026-04-10T01:12:04.859059Z","steps":["trace[1506818307] 'process raft request' (duration: 118.815131ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:04.860417Z","caller":"traceutil/trace.go:171","msg":"trace[1940353905] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"124.811303ms","start":"2026-04-10T01:12:04.735589Z","end":"2026-04-10T01:12:04.860401Z","steps":["trace[1940353905] 'process raft request' (duration: 124.65649ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:04.860563Z","caller":"traceutil/trace.go:171","msg":"trace[662041015] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"124.882316ms","start":"2026-04-10T01:12:04.735646Z","end":"2026-04-10T01:12:04.860529Z","steps":["trace[662041015] 'process raft request' (duration: 124.66438ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:04.860723Z","caller":"traceutil/trace.go:171","msg":"trace[335193591] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"123.747639ms","start":"2026-04-10T01:12:04.73696Z","end":"2026-04-10T01:12:04.860707Z","steps":["trace[335193591] 'process raft request' (duration: 123.38453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:12.966451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333952327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:13.466836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333952327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:13.96713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257760333952327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:14.317071Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.298993625s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T01:12:14.317627Z","caller":"traceutil/trace.go:171","msg":"trace[83538582] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1406; }","duration":"1.851812294s","start":"2026-04-10T01:12:12.465785Z","end":"2026-04-10T01:12:14.317597Z","steps":["trace[83538582] 'read index received' (duration: 1.851540648s)","trace[83538582] 'applied index is now lower than readState.Index' (duration: 268.846µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:14.317647Z","caller":"traceutil/trace.go:171","msg":"trace[285073879] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"2.299664721s","start":"2026-04-10T01:12:12.017962Z","end":"2026-04-10T01:12:14.317627Z","steps":["trace[285073879] 'process raft request' (duration: 2.299371464s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.317772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.851981448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:12:14.3178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.017941Z","time spent":"2.299769824s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:12:14.317817Z","caller":"traceutil/trace.go:171","msg":"trace[660143657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1350; }","duration":"1.8520693s","start":"2026-04-10T01:12:12.465733Z","end":"2026-04-10T01:12:14.317803Z","steps":["trace[660143657] 'agreement among raft nodes before linearized reading' (duration: 1.851984598s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.317856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.46571Z","time spent":"1.852134991s","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:12:14.320864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.70280222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-10T01:12:14.320936Z","caller":"traceutil/trace.go:171","msg":"trace[1341743638] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1351; }","duration":"1.702922813s","start":"2026-04-10T01:12:12.617993Z","end":"2026-04-10T01:12:14.320916Z","steps":["trace[1341743638] 'agreement among raft nodes before linearized reading' (duration: 1.702724479s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.320948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.835961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-10T01:12:14.320986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.617968Z","time spent":"1.703005306s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-10T01:12:14.321Z","caller":"traceutil/trace.go:171","msg":"trace[348424483] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1351; }","duration":"678.924783ms","start":"2026-04-10T01:12:13.642061Z","end":"2026-04-10T01:12:14.320985Z","steps":["trace[348424483] 'agreement among raft nodes before linearized reading' (duration: 678.78114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.32101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.920725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:14.321098Z","caller":"traceutil/trace.go:171","msg":"trace[1597956281] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1351; }","duration":"910.066759ms","start":"2026-04-10T01:12:13.411004Z","end":"2026-04-10T01:12:14.32107Z","steps":["trace[1597956281] 'agreement among raft nodes before linearized reading' (duration: 909.963117ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:14.321136Z","caller":"traceutil/trace.go:171","msg":"trace[1673316379] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"187.186775ms","start":"2026-04-10T01:12:14.133935Z","end":"2026-04-10T01:12:14.321122Z","steps":["trace[1673316379] 'process raft request' (duration: 186.688303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.321165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:13.410987Z","time spent":"910.163551ms","remote":"127.0.0.1:53288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:12:14.321318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095330298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-10T01:12:14.321392Z","caller":"traceutil/trace.go:171","msg":"trace[509785515] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1351; }","duration":"1.0954388s","start":"2026-04-10T01:12:13.225937Z","end":"2026-04-10T01:12:14.321376Z","steps":["trace[509785515] 'agreement among raft nodes before linearized reading' (duration: 1.095301727s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.321442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:13.225919Z","time spent":"1.095510723s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-10T01:12:14.320906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.264703838s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:14.321498Z","caller":"traceutil/trace.go:171","msg":"trace[1487040897] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1351; }","duration":"1.265356524s","start":"2026-04-10T01:12:13.056129Z","end":"2026-04-10T01:12:14.321486Z","steps":["trace[1487040897] 'agreement among raft nodes before linearized reading' (duration: 1.264663477s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.321545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:13.056114Z","time spent":"1.265420705s","remote":"127.0.0.1:43368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:12:14.321493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.629475878s","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-04-10T01:12:14.321725Z","caller":"traceutil/trace.go:171","msg":"trace[831845170] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1351; }","duration":"1.629757144s","start":"2026-04-10T01:12:12.691958Z","end":"2026-04-10T01:12:14.321715Z","steps":["trace[831845170] 'agreement among raft nodes before linearized reading' (duration: 1.629433057s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.321727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429482468s","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-04-10T01:12:14.321764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.691932Z","time spent":"1.629821906s","remote":"127.0.0.1:43596","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-04-10T01:12:14.32178Z","caller":"traceutil/trace.go:171","msg":"trace[1861118990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1351; }","duration":"1.4295525s","start":"2026-04-10T01:12:12.892212Z","end":"2026-04-10T01:12:14.321764Z","steps":["trace[1861118990] 'agreement among raft nodes before linearized reading' (duration: 1.429430307s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.321833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.892202Z","time spent":"1.429618301s","remote":"127.0.0.1:43596","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-04-10T01:12:14.322096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430802489s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:12:14.322136Z","caller":"traceutil/trace.go:171","msg":"trace[298329707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1351; }","duration":"1.430885311s","start":"2026-04-10T01:12:12.891241Z","end":"2026-04-10T01:12:14.322126Z","steps":["trace[298329707] 'agreement among raft nodes before linearized reading' (duration: 1.430750168s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.322168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.891217Z","time spent":"1.430944062s","remote":"127.0.0.1:43596","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-04-10T01:12:14.322213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.427360297s","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-04-10T01:12:14.322433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431705591s","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-04-10T01:12:14.322468Z","caller":"traceutil/trace.go:171","msg":"trace[1074269701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1351; }","duration":"1.432809817s","start":"2026-04-10T01:12:12.88965Z","end":"2026-04-10T01:12:14.322459Z","steps":["trace[1074269701] 'agreement among raft nodes before linearized reading' (duration: 1.43165042s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.32249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.889631Z","time spent":"1.432853278s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T01:12:14.321042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:13.642043Z","time spent":"678.985994ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-10T01:12:14.322271Z","caller":"traceutil/trace.go:171","msg":"trace[1269454174] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1351; }","duration":"1.427470349s","start":"2026-04-10T01:12:12.894787Z","end":"2026-04-10T01:12:14.322257Z","steps":["trace[1269454174] 'agreement among raft nodes before linearized reading' (duration: 1.427329306s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:14.32316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.894778Z","time spent":"1.428361721s","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-10T01:13:12.933471Z","caller":"traceutil/trace.go:171","msg":"trace[1030041309] transaction","detail":"{read_only:false; response_revision:1626; number_of_response:1; }","duration":"177.719825ms","start":"2026-04-10T01:13:12.755733Z","end":"2026-04-10T01:13:12.933453Z","steps":["trace[1030041309] 'process raft request' (duration: 177.682554ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:13:12.933525Z","caller":"traceutil/trace.go:171","msg":"trace[437920080] transaction","detail":"{read_only:false; response_revision:1625; number_of_response:1; }","duration":"177.764826ms","start":"2026-04-10T01:13:12.755723Z","end":"2026-04-10T01:13:12.933488Z","steps":["trace[437920080] 'process raft request' (duration: 177.602952ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:13:18.744545Z","caller":"traceutil/trace.go:171","msg":"trace[1912652773] transaction","detail":"{read_only:false; response_revision:1646; number_of_response:1; }","duration":"132.793347ms","start":"2026-04-10T01:13:18.611721Z","end":"2026-04-10T01:13:18.744515Z","steps":["trace[1912652773] 'process raft request' (duration: 132.590902ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:13:18.944165Z","caller":"traceutil/trace.go:171","msg":"trace[22039847] transaction","detail":"{read_only:false; response_revision:1647; number_of_response:1; }","duration":"235.992323ms","start":"2026-04-10T01:13:18.708149Z","end":"2026-04-10T01:13:18.944141Z","steps":["trace[22039847] 'process raft request' (duration: 182.372517ms)","trace[22039847] 'compare' (duration: 53.405491ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:13:18.944151Z","caller":"traceutil/trace.go:171","msg":"trace[1301421920] linearizableReadLoop","detail":"{readStateIndex:1717; appliedIndex:1715; }","duration":"212.034929ms","start":"2026-04-10T01:13:18.732078Z","end":"2026-04-10T01:13:18.944113Z","steps":["trace[1301421920] 'read index received' (duration: 12.380077ms)","trace[1301421920] 'applied index is now lower than readState.Index' (duration: 199.648631ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:13:18.944484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.387077ms","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-04-10T01:13:18.944615Z","caller":"traceutil/trace.go:171","msg":"trace[1795526899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1647; }","duration":"212.52291ms","start":"2026-04-10T01:13:18.732025Z","end":"2026-04-10T01:13:18.944548Z","steps":["trace[1795526899] 'agreement among raft nodes before linearized reading' (duration: 212.190312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:13:18.945139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.246718ms","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-04-10T01:13:18.945162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.738789ms","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-04-10T01:13:18.945209Z","caller":"traceutil/trace.go:171","msg":"trace[247171306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1647; }","duration":"173.819662ms","start":"2026-04-10T01:13:18.771377Z","end":"2026-04-10T01:13:18.945196Z","steps":["trace[247171306] 'agreement among raft nodes before linearized reading' (duration: 173.656608ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:13:18.945261Z","caller":"traceutil/trace.go:171","msg":"trace[1622493460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1647; }","duration":"128.34584ms","start":"2026-04-10T01:13:18.81684Z","end":"2026-04-10T01:13:18.945185Z","steps":["trace[1622493460] 'agreement among raft nodes before linearized reading' (duration: 128.183836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:13:18.945197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.393618ms","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-04-10T01:13:18.945507Z","caller":"traceutil/trace.go:171","msg":"trace[1226783885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1647; }","duration":"192.753556ms","start":"2026-04-10T01:13:18.752735Z","end":"2026-04-10T01:13:18.945488Z","steps":["trace[1226783885] 'agreement among raft nodes before linearized reading' (duration: 192.178332ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:14:21.629347Z","caller":"traceutil/trace.go:171","msg":"trace[1680434257] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"124.500462ms","start":"2026-04-10T01:14:21.504822Z","end":"2026-04-10T01:14:21.629322Z","steps":["trace[1680434257] 'process raft request' (duration: 73.99403ms)","trace[1680434257] 'compare' (duration: 50.345709ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:14:21.629489Z","caller":"traceutil/trace.go:171","msg":"trace[830240623] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"124.546884ms","start":"2026-04-10T01:14:21.504912Z","end":"2026-04-10T01:14:21.629459Z","steps":["trace[830240623] 'process raft request' (duration: 124.372079ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:14:43.884692Z","caller":"traceutil/trace.go:171","msg":"trace[273337853] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"131.212203ms","start":"2026-04-10T01:14:43.753459Z","end":"2026-04-10T01:14:43.884671Z","steps":["trace[273337853] 'process raft request' (duration: 98.215038ms)","trace[273337853] 'compare' (duration: 32.897062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:15:30.750209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.549028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T01:15:30.750291Z","caller":"traceutil/trace.go:171","msg":"trace[2107767874] range","detail":"{range_begin:/registry/masterleases/199.204.45.102; range_end:; response_count:1; response_revision:2283; }","duration":"253.674801ms","start":"2026-04-10T01:15:30.496597Z","end":"2026-04-10T01:15:30.750272Z","steps":["trace[2107767874] 'range keys from in-memory index tree' (duration: 253.385695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:30.750391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.166581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-10T01:15:30.750466Z","caller":"traceutil/trace.go:171","msg":"trace[905648758] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2283; }","duration":"425.282314ms","start":"2026-04-10T01:15:30.325165Z","end":"2026-04-10T01:15:30.750448Z","steps":["trace[905648758] 'range keys from in-memory index tree' (duration: 424.999998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:30.750506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.838937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:15:30.75054Z","caller":"traceutil/trace.go:171","msg":"trace[709353297] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2283; }","duration":"118.933749ms","start":"2026-04-10T01:15:30.631597Z","end":"2026-04-10T01:15:30.750531Z","steps":["trace[709353297] 'count revisions from in-memory index tree' (duration: 118.725224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:30.750544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:15:30.325149Z","time spent":"425.383877ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}