{"level":"warn","ts":"2026-05-19T19:15:12.637299Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T19:15:12.637422Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-05-19T19:15:12.6375Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T19:15:12.637527Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-05-19T19:15:12.637554Z","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-05-19T19:15:12.638286Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-05-19T19:15:12.638376Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-05-19T19:15:12.671999Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"33.407515ms"} {"level":"info","ts":"2026-05-19T19:15:12.687157Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-05-19T19:15:12.687261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T19:15:12.687288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-05-19T19:15:12.687316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T19:15:12.687337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-05-19T19:15:12.687379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-05-19T19:15:12.745357Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T19:15:12.749935Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T19:15:12.751374Z","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-05-19T19:15:12.755314Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T19:15:12.758705Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T19:15:12.758854Z","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-05-19T19:15:12.758889Z","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-05-19T19:15:12.758906Z","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-05-19T19:15:12.76147Z","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-05-19T19:15:12.761692Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T19:15:12.761728Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T19:15:12.761823Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-05-19T19:15:12.76184Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-05-19T19:15:12.762002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-05-19T19:15:12.76326Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-05-19T19:15:13.18807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T19:15:13.188142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T19:15:13.188166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-05-19T19:15:13.188186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-05-19T19:15:13.188197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-05-19T19:15:13.188213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-05-19T19:15:13.188226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-05-19T19:15:13.209898Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:15:13.211324Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T19:15:13.21133Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T19:15:13.21138Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T19:15:13.211833Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T19:15:13.211884Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T19:15:13.213351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T19:15:13.213679Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:15:13.213798Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:15:13.213836Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:15:13.220824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-05-19T19:15:17.734314Z","caller":"traceutil/trace.go:171","msg":"trace[586301792] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"455.923172ms","start":"2026-05-19T19:15:17.278363Z","end":"2026-05-19T19:15:17.734286Z","steps":["trace[586301792] 'process raft request' (duration: 455.782069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:17.735479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:17.278335Z","time spent":"456.60674ms","remote":"127.0.0.1:40902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:18.285879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.557812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:15:18.286006Z","caller":"traceutil/trace.go:171","msg":"trace[294494699] linearizableReadLoop","detail":"{readStateIndex:271; appliedIndex:269; }","duration":"824.735996ms","start":"2026-05-19T19:15:17.461253Z","end":"2026-05-19T19:15:18.285989Z","steps":["trace[294494699] 'read index received' (duration: 272.791448ms)","trace[294494699] 'applied index is now lower than readState.Index' (duration: 551.943438ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:15:18.286053Z","caller":"traceutil/trace.go:171","msg":"trace[1443568153] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"969.437901ms","start":"2026-05-19T19:15:17.316567Z","end":"2026-05-19T19:15:18.286005Z","steps":["trace[1443568153] 'process raft request' (duration: 464.540771ms)","trace[1443568153] 'compare' (duration: 504.424968ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:15:18.286235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:17.316546Z","time spent":"969.601095ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:18.286348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.906675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:15:18.286423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.158107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:18.286559Z","caller":"traceutil/trace.go:171","msg":"trace[1715642907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:266; }","duration":"825.327062ms","start":"2026-05-19T19:15:17.461216Z","end":"2026-05-19T19:15:18.286543Z","steps":["trace[1715642907] 'agreement among raft nodes before linearized reading' (duration: 824.848109ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:18.286436Z","caller":"traceutil/trace.go:171","msg":"trace[728301689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:266; }","duration":"763.053869ms","start":"2026-05-19T19:15:17.523363Z","end":"2026-05-19T19:15:18.286417Z","steps":["trace[728301689] 'agreement among raft nodes before linearized reading' (duration: 762.872214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:18.286506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.082047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3708"} {"level":"info","ts":"2026-05-19T19:15:18.286734Z","caller":"traceutil/trace.go:171","msg":"trace[841863937] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:266; }","duration":"610.316983ms","start":"2026-05-19T19:15:17.676374Z","end":"2026-05-19T19:15:18.286691Z","steps":["trace[841863937] 'agreement among raft nodes before linearized reading' (duration: 610.088277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:18.286675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:17.461204Z","time spent":"825.458915ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:15:18.286778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:17.676353Z","time spent":"610.414015ms","remote":"127.0.0.1:40888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3732,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-19T19:15:18.286713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:17.52334Z","time spent":"763.353548ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T19:15:18.627199Z","caller":"traceutil/trace.go:171","msg":"trace[1573965215] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"335.887481ms","start":"2026-05-19T19:15:18.291283Z","end":"2026-05-19T19:15:18.62717Z","steps":["trace[1573965215] 'process raft request' (duration: 253.611094ms)","trace[1573965215] 'compare' (duration: 82.025721ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:15:18.627324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:18.291268Z","time spent":"336.001444ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:18.633166Z","caller":"traceutil/trace.go:171","msg":"trace[1231308871] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"339.991315ms","start":"2026-05-19T19:15:18.293144Z","end":"2026-05-19T19:15:18.633135Z","steps":["trace[1231308871] 'process raft request' (duration: 339.79394ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:18.633279Z","caller":"traceutil/trace.go:171","msg":"trace[1323613601] linearizableReadLoop","detail":"{readStateIndex:273; appliedIndex:271; }","duration":"340.377904ms","start":"2026-05-19T19:15:18.292875Z","end":"2026-05-19T19:15:18.633253Z","steps":["trace[1323613601] 'read index received' (duration: 252.033894ms)","trace[1323613601] 'applied index is now lower than readState.Index' (duration: 88.34239ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:15:18.633332Z","caller":"traceutil/trace.go:171","msg":"trace[2000177874] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"174.6639ms","start":"2026-05-19T19:15:18.458646Z","end":"2026-05-19T19:15:18.63331Z","steps":["trace[2000177874] 'process raft request' (duration: 174.419764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:18.633446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.561399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-19T19:15:18.633487Z","caller":"traceutil/trace.go:171","msg":"trace[359383474] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:270; }","duration":"340.663351ms","start":"2026-05-19T19:15:18.292813Z","end":"2026-05-19T19:15:18.633476Z","steps":["trace[359383474] 'agreement among raft nodes before linearized reading' (duration: 340.553599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:18.633527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:18.292803Z","time spent":"340.717403ms","remote":"127.0.0.1:40836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T19:15:18.639959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:18.293127Z","time spent":"340.19385ms","remote":"127.0.0.1:40888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:18.633729Z","caller":"traceutil/trace.go:171","msg":"trace[2114834237] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"341.519464ms","start":"2026-05-19T19:15:18.291814Z","end":"2026-05-19T19:15:18.633334Z","steps":["trace[2114834237] 'process raft request' (duration: 340.998671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:18.640894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:18.291798Z","time spent":"349.048064ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.75186Z","caller":"traceutil/trace.go:171","msg":"trace[1971306976] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"295.999995ms","start":"2026-05-19T19:15:42.455834Z","end":"2026-05-19T19:15:42.751834Z","steps":["trace[1971306976] 'process raft request' (duration: 295.80981ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:42.839665Z","caller":"traceutil/trace.go:171","msg":"trace[1290081679] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"373.267925ms","start":"2026-05-19T19:15:42.466364Z","end":"2026-05-19T19:15:42.839632Z","steps":["trace[1290081679] 'process raft request' (duration: 373.102061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.839805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.466344Z","time spent":"373.399919ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.839816Z","caller":"traceutil/trace.go:171","msg":"trace[1925181530] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"369.396199ms","start":"2026-05-19T19:15:42.470385Z","end":"2026-05-19T19:15:42.839782Z","steps":["trace[1925181530] 'process raft request' (duration: 369.192584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.839996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.470375Z","time spent":"369.538482ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.83998Z","caller":"traceutil/trace.go:171","msg":"trace[373242545] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"369.495911ms","start":"2026-05-19T19:15:42.470431Z","end":"2026-05-19T19:15:42.839927Z","steps":["trace[373242545] 'process raft request' (duration: 369.187253ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:42.840118Z","caller":"traceutil/trace.go:171","msg":"trace[1706155603] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"365.51834ms","start":"2026-05-19T19:15:42.474587Z","end":"2026-05-19T19:15:42.840106Z","steps":["trace[1706155603] 'process raft request' (duration: 365.177812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.840186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.47457Z","time spent":"365.584881ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.840274Z","caller":"traceutil/trace.go:171","msg":"trace[1059412832] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"369.783788ms","start":"2026-05-19T19:15:42.470481Z","end":"2026-05-19T19:15:42.840265Z","steps":["trace[1059412832] 'process raft request' (duration: 369.226344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.84032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.470478Z","time spent":"369.821929ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:42.840286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.470426Z","time spent":"369.713837ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.840456Z","caller":"traceutil/trace.go:171","msg":"trace[2118589029] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"362.211926ms","start":"2026-05-19T19:15:42.478227Z","end":"2026-05-19T19:15:42.840439Z","steps":["trace[2118589029] 'process raft request' (duration: 361.812306ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:42.840474Z","caller":"traceutil/trace.go:171","msg":"trace[1858940567] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"365.717105ms","start":"2026-05-19T19:15:42.474717Z","end":"2026-05-19T19:15:42.840434Z","steps":["trace[1858940567] 'process raft request' (duration: 365.271024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.840543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.478196Z","time spent":"362.309659ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.840489Z","caller":"traceutil/trace.go:171","msg":"trace[1044340768] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"365.638412ms","start":"2026-05-19T19:15:42.474648Z","end":"2026-05-19T19:15:42.840286Z","steps":["trace[1044340768] 'process raft request' (duration: 365.226362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.840636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.474713Z","time spent":"365.85918ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.840733Z","caller":"traceutil/trace.go:171","msg":"trace[1050873415] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"356.36235ms","start":"2026-05-19T19:15:42.484354Z","end":"2026-05-19T19:15:42.840716Z","steps":["trace[1050873415] 'process raft request' (duration: 355.794605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.840878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.484348Z","time spent":"356.453462ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.840924Z","caller":"traceutil/trace.go:171","msg":"trace[1911984042] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"342.351326ms","start":"2026-05-19T19:15:42.498554Z","end":"2026-05-19T19:15:42.840906Z","steps":["trace[1911984042] 'process raft request' (duration: 341.866473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.841037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.498536Z","time spent":"342.463319ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:42.841195Z","caller":"traceutil/trace.go:171","msg":"trace[1307023712] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"212.356993ms","start":"2026-05-19T19:15:42.628823Z","end":"2026-05-19T19:15:42.84118Z","steps":["trace[1307023712] 'process raft request' (duration: 212.146198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:42.841069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.474645Z","time spent":"366.157526ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:43.341983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278927083615075,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T19:15:43.432451Z","caller":"traceutil/trace.go:171","msg":"trace[1454124297] transaction","detail":"{read_only:false; number_of_response:1; response_revision:520; }","duration":"672.996024ms","start":"2026-05-19T19:15:42.759434Z","end":"2026-05-19T19:15:43.43243Z","steps":["trace[1454124297] 'process raft request' (duration: 672.955313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.432594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.759416Z","time spent":"673.102187ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6938,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:43.432724Z","caller":"traceutil/trace.go:171","msg":"trace[1861750134] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"675.351964ms","start":"2026-05-19T19:15:42.757329Z","end":"2026-05-19T19:15:43.432681Z","steps":["trace[1861750134] 'process raft request' (duration: 672.846981ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:43.432729Z","caller":"traceutil/trace.go:171","msg":"trace[2146933620] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"673.769974ms","start":"2026-05-19T19:15:42.75892Z","end":"2026-05-19T19:15:43.43269Z","steps":["trace[2146933620] 'process raft request' (duration: 673.378025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.432858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.757311Z","time spent":"675.484627ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:43.432903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.758904Z","time spent":"673.900998ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:43.438217Z","caller":"traceutil/trace.go:171","msg":"trace[2037679245] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"589.043524ms","start":"2026-05-19T19:15:42.849153Z","end":"2026-05-19T19:15:43.438197Z","steps":["trace[2037679245] 'process raft request' (duration: 588.833179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.438325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.84913Z","time spent":"589.135307ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:43.43838Z","caller":"traceutil/trace.go:171","msg":"trace[1490735261] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"587.528267ms","start":"2026-05-19T19:15:42.850832Z","end":"2026-05-19T19:15:43.43836Z","steps":["trace[1490735261] 'process raft request' (duration: 587.300961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.438453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.850822Z","time spent":"587.601439ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:43.438696Z","caller":"traceutil/trace.go:171","msg":"trace[1099371831] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"586.440509ms","start":"2026-05-19T19:15:42.852244Z","end":"2026-05-19T19:15:43.438684Z","steps":["trace[1099371831] 'process raft request' (duration: 586.339586ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:43.438741Z","caller":"traceutil/trace.go:171","msg":"trace[1191913239] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"583.881884ms","start":"2026-05-19T19:15:42.854841Z","end":"2026-05-19T19:15:43.438723Z","steps":["trace[1191913239] 'process raft request' (duration: 583.791151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.438758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.852234Z","time spent":"586.5018ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:43.438838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.854823Z","time spent":"583.969366ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:43.438979Z","caller":"traceutil/trace.go:171","msg":"trace[2100531538] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:536; }","duration":"597.683673ms","start":"2026-05-19T19:15:42.841283Z","end":"2026-05-19T19:15:43.438967Z","steps":["trace[2100531538] 'read index received' (duration: 588.84267ms)","trace[2100531538] 'applied index is now lower than readState.Index' (duration: 8.840223ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:15:43.439075Z","caller":"traceutil/trace.go:171","msg":"trace[489225641] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"575.232065ms","start":"2026-05-19T19:15:42.863832Z","end":"2026-05-19T19:15:43.439064Z","steps":["trace[489225641] 'process raft request' (duration: 575.04846ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:43.43912Z","caller":"traceutil/trace.go:171","msg":"trace[426311421] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"536.304082ms","start":"2026-05-19T19:15:42.902806Z","end":"2026-05-19T19:15:43.43911Z","steps":["trace[426311421] 'process raft request' (duration: 536.121478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.439141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.863825Z","time spent":"575.283047ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:43.439174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.902778Z","time spent":"536.369924ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:43.439228Z","caller":"traceutil/trace.go:171","msg":"trace[433592949] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"582.714585ms","start":"2026-05-19T19:15:42.856505Z","end":"2026-05-19T19:15:43.43922Z","steps":["trace[433592949] 'process raft request' (duration: 582.165081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.439271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.856496Z","time spent":"582.756206ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:15:43.43928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.404392ms","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-05-19T19:15:43.439311Z","caller":"traceutil/trace.go:171","msg":"trace[123278865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"661.457843ms","start":"2026-05-19T19:15:42.777845Z","end":"2026-05-19T19:15:43.439302Z","steps":["trace[123278865] 'agreement among raft nodes before linearized reading' (duration: 661.402812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.439345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.777833Z","time spent":"661.502575ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T19:15:43.439384Z","caller":"traceutil/trace.go:171","msg":"trace[1596967556] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"582.835308ms","start":"2026-05-19T19:15:42.85654Z","end":"2026-05-19T19:15:43.439375Z","steps":["trace[1596967556] 'process raft request' (duration: 582.164861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.43943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.856535Z","time spent":"582.876189ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:43.439483Z","caller":"traceutil/trace.go:171","msg":"trace[376433149] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"579.626287ms","start":"2026-05-19T19:15:42.859837Z","end":"2026-05-19T19:15:43.439463Z","steps":["trace[376433149] 'process raft request' (duration: 578.982831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.439583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.859829Z","time spent":"579.701999ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:43.439688Z","caller":"traceutil/trace.go:171","msg":"trace[1130941770] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"580.368625ms","start":"2026-05-19T19:15:42.859309Z","end":"2026-05-19T19:15:43.439678Z","steps":["trace[1130941770] 'process raft request' (duration: 579.434222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.439751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.859287Z","time spent":"580.434867ms","remote":"127.0.0.1:40788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:43.439823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.490387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:15:43.439871Z","caller":"traceutil/trace.go:171","msg":"trace[1973699165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"534.570498ms","start":"2026-05-19T19:15:42.90529Z","end":"2026-05-19T19:15:43.43986Z","steps":["trace[1973699165] 'agreement among raft nodes before linearized reading' (duration: 534.470555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.439907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.905273Z","time spent":"534.62719ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:15:43.439959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.482601ms","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-05-19T19:15:43.439996Z","caller":"traceutil/trace.go:171","msg":"trace[1565940095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:530; }","duration":"493.561003ms","start":"2026-05-19T19:15:42.946426Z","end":"2026-05-19T19:15:43.439987Z","steps":["trace[1565940095] 'agreement among raft nodes before linearized reading' (duration: 493.417829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:43.440028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:42.946405Z","time spent":"493.616915ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-19T19:15:44.292057Z","caller":"traceutil/trace.go:171","msg":"trace[1010294800] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"227.991908ms","start":"2026-05-19T19:15:44.064047Z","end":"2026-05-19T19:15:44.292039Z","steps":["trace[1010294800] 'process raft request' (duration: 219.793371ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:49.652971Z","caller":"traceutil/trace.go:171","msg":"trace[1832151416] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"454.531297ms","start":"2026-05-19T19:15:49.198398Z","end":"2026-05-19T19:15:49.652929Z","steps":["trace[1832151416] 'process raft request' (duration: 453.85235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:49.65312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.198382Z","time spent":"454.664671ms","remote":"127.0.0.1:40902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:50.170998Z","caller":"traceutil/trace.go:171","msg":"trace[1225999713] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:634; }","duration":"708.740727ms","start":"2026-05-19T19:15:49.462213Z","end":"2026-05-19T19:15:50.170954Z","steps":["trace[1225999713] 'read index received' (duration: 190.131071ms)","trace[1225999713] 'applied index is now lower than readState.Index' (duration: 518.608156ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:15:50.171106Z","caller":"traceutil/trace.go:171","msg":"trace[1779126244] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"549.049465ms","start":"2026-05-19T19:15:49.622013Z","end":"2026-05-19T19:15:50.171063Z","steps":["trace[1779126244] 'process raft request' (duration: 548.738527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.17121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.984524ms","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-05-19T19:15:50.171252Z","caller":"traceutil/trace.go:171","msg":"trace[716040056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"709.063015ms","start":"2026-05-19T19:15:49.462177Z","end":"2026-05-19T19:15:50.17124Z","steps":["trace[716040056] 'agreement among raft nodes before linearized reading' (duration: 708.922042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.17127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.621983Z","time spent":"549.206279ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:50.171284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.462159Z","time spent":"709.117267ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T19:15:50.170876Z","caller":"traceutil/trace.go:171","msg":"trace[1061458384] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"837.94195ms","start":"2026-05-19T19:15:49.332879Z","end":"2026-05-19T19:15:50.170821Z","steps":["trace[1061458384] 'process raft request' (duration: 837.315264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.171551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.332847Z","time spent":"838.600286ms","remote":"127.0.0.1:40822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:50.257592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.258309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:15:50.257662Z","caller":"traceutil/trace.go:171","msg":"trace[1526191249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"766.375162ms","start":"2026-05-19T19:15:49.491271Z","end":"2026-05-19T19:15:50.257647Z","steps":["trace[1526191249] 'agreement among raft nodes before linearized reading' (duration: 766.188437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.257698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.491252Z","time spent":"766.438154ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:15:50.257681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.544522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:50.257724Z","caller":"traceutil/trace.go:171","msg":"trace[1983622763] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"319.443696ms","start":"2026-05-19T19:15:49.938253Z","end":"2026-05-19T19:15:50.257696Z","steps":["trace[1983622763] 'process raft request' (duration: 318.925953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.257868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.938231Z","time spent":"319.5657ms","remote":"127.0.0.1:40888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:50.257807Z","caller":"traceutil/trace.go:171","msg":"trace[1823922961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"609.710566ms","start":"2026-05-19T19:15:49.648063Z","end":"2026-05-19T19:15:50.257773Z","steps":["trace[1823922961] 'agreement among raft nodes before linearized reading' (duration: 609.516941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.258015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.282995ms","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-05-19T19:15:50.258256Z","caller":"traceutil/trace.go:171","msg":"trace[618827256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"765.570602ms","start":"2026-05-19T19:15:49.492612Z","end":"2026-05-19T19:15:50.258183Z","steps":["trace[618827256] 'agreement among raft nodes before linearized reading' (duration: 765.102461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.258089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.648044Z","time spent":"609.999813ms","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:15:50.258297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.935826ms","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-05-19T19:15:50.258301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.492604Z","time spent":"765.687695ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-19T19:15:50.258346Z","caller":"traceutil/trace.go:171","msg":"trace[700814658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"726.999838ms","start":"2026-05-19T19:15:49.531332Z","end":"2026-05-19T19:15:50.258332Z","steps":["trace[700814658] 'agreement among raft nodes before linearized reading' (duration: 726.828564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:50.258403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:49.531321Z","time spent":"727.07483ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:15:51.204257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.734411ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:15:51.204456Z","caller":"traceutil/trace.go:171","msg":"trace[29827303] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"978.400807ms","start":"2026-05-19T19:15:50.22604Z","end":"2026-05-19T19:15:51.20444Z","steps":["trace[29827303] 'process raft request' (duration: 978.301265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.204576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.226019Z","time spent":"978.504039ms","remote":"127.0.0.1:41218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T19:15:51.205757Z","caller":"traceutil/trace.go:171","msg":"trace[1468113034] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.0295741s","start":"2026-05-19T19:15:50.176135Z","end":"2026-05-19T19:15:51.205709Z","steps":["trace[1468113034] 'process raft request' (duration: 775.313089ms)","trace[1468113034] 'compare' (duration: 252.463485ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:15:51.205994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.176114Z","time spent":"1.029716284s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:51.21072Z","caller":"traceutil/trace.go:171","msg":"trace[1130277465] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"947.032635ms","start":"2026-05-19T19:15:50.263668Z","end":"2026-05-19T19:15:51.2107Z","steps":["trace[1130277465] 'process raft request' (duration: 946.764158ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:51.210963Z","caller":"traceutil/trace.go:171","msg":"trace[2137218207] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"946.85353ms","start":"2026-05-19T19:15:50.264092Z","end":"2026-05-19T19:15:51.210946Z","steps":["trace[2137218207] 'process raft request' (duration: 946.571533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.21107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.264069Z","time spent":"946.951253ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:15:51.211304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.263644Z","time spent":"947.247741ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:51.211299Z","caller":"traceutil/trace.go:171","msg":"trace[1230692958] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"946.923762ms","start":"2026-05-19T19:15:50.264335Z","end":"2026-05-19T19:15:51.211259Z","steps":["trace[1230692958] 'process raft request' (duration: 946.650034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.211459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.264325Z","time spent":"947.057646ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:15:51.211567Z","caller":"traceutil/trace.go:171","msg":"trace[778349019] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:638; }","duration":"563.704475ms","start":"2026-05-19T19:15:50.647811Z","end":"2026-05-19T19:15:51.211516Z","steps":["trace[778349019] 'read index received' (duration: 303.650708ms)","trace[778349019] 'applied index is now lower than readState.Index' (duration: 260.052377ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:15:51.212474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.65934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:51.212538Z","caller":"traceutil/trace.go:171","msg":"trace[1924484425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"564.757732ms","start":"2026-05-19T19:15:50.647767Z","end":"2026-05-19T19:15:51.212525Z","steps":["trace[1924484425] 'agreement among raft nodes before linearized reading' (duration: 564.66318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:51.212576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:50.647751Z","time spent":"564.818074ms","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:15:52.833217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.585103ms","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-05-19T19:15:52.833235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.733584ms","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-05-19T19:15:52.833313Z","caller":"traceutil/trace.go:171","msg":"trace[1940639484] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"148.731157ms","start":"2026-05-19T19:15:52.684561Z","end":"2026-05-19T19:15:52.833292Z","steps":["trace[1940639484] 'range keys from in-memory index tree' (duration: 148.49117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.627676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.833445Z","caller":"traceutil/trace.go:171","msg":"trace[1748458671] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"335.736378ms","start":"2026-05-19T19:15:52.497695Z","end":"2026-05-19T19:15:52.833431Z","steps":["trace[1748458671] 'range keys from in-memory index tree' (duration: 335.596215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.27533ms","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":"warn","ts":"2026-05-19T19:15:52.833536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.25897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.833543Z","caller":"traceutil/trace.go:171","msg":"trace[2084398575] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"166.397623ms","start":"2026-05-19T19:15:52.667128Z","end":"2026-05-19T19:15:52.833525Z","steps":["trace[2084398575] 'count revisions from in-memory index tree' (duration: 166.199558ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:52.833572Z","caller":"traceutil/trace.go:171","msg":"trace[1406171370] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"486.318851ms","start":"2026-05-19T19:15:52.347244Z","end":"2026-05-19T19:15:52.833562Z","steps":["trace[1406171370] 'range keys from in-memory index tree' (duration: 486.203999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.90327ms","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":"warn","ts":"2026-05-19T19:15:52.833637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.962445ms","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":"warn","ts":"2026-05-19T19:15:52.83365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.27525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.833328Z","caller":"traceutil/trace.go:171","msg":"trace[1390948567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"239.854247ms","start":"2026-05-19T19:15:52.593452Z","end":"2026-05-19T19:15:52.833307Z","steps":["trace[1390948567] 'count revisions from in-memory index tree' (duration: 239.705324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.547944ms","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":"warn","ts":"2026-05-19T19:15:52.833756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.713832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:15:52.833789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.001338ms","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-05-19T19:15:52.833832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.879085ms","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-05-19T19:15:52.833825Z","caller":"traceutil/trace.go:171","msg":"trace[1115648157] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:633; }","duration":"278.830112ms","start":"2026-05-19T19:15:52.554946Z","end":"2026-05-19T19:15:52.833776Z","steps":["trace[1115648157] 'range keys from in-memory index tree' (duration: 278.516084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.812009ms","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-05-19T19:15:52.834053Z","caller":"traceutil/trace.go:171","msg":"trace[563839300] 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:633; }","duration":"189.611958ms","start":"2026-05-19T19:15:52.644424Z","end":"2026-05-19T19:15:52.834036Z","steps":["trace[563839300] 'count revisions from in-memory index tree' (duration: 188.724567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.396463ms","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":"info","ts":"2026-05-19T19:15:52.834241Z","caller":"traceutil/trace.go:171","msg":"trace[1914397809] 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:633; }","duration":"189.936207ms","start":"2026-05-19T19:15:52.644286Z","end":"2026-05-19T19:15:52.834222Z","steps":["trace[1914397809] 'range keys from in-memory index tree' (duration: 189.348882ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:52.833677Z","caller":"traceutil/trace.go:171","msg":"trace[1933640489] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:633; }","duration":"279.028656ms","start":"2026-05-19T19:15:52.554636Z","end":"2026-05-19T19:15:52.833665Z","steps":["trace[1933640489] 'range keys from in-memory index tree' (duration: 278.846232ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:52.83385Z","caller":"traceutil/trace.go:171","msg":"trace[579561275] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"167.083309ms","start":"2026-05-19T19:15:52.666751Z","end":"2026-05-19T19:15:52.833834Z","steps":["trace[579561275] 'range keys from in-memory index tree' (duration: 166.930776ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:15:52.833796Z","caller":"traceutil/trace.go:171","msg":"trace[1314298329] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"336.798705ms","start":"2026-05-19T19:15:52.496987Z","end":"2026-05-19T19:15:52.833786Z","steps":["trace[1314298329] 'range keys from in-memory index tree' (duration: 336.671271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.834562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:52.49693Z","time spent":"337.613465ms","remote":"127.0.0.1:48826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T19:15:52.833613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.866343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.834749Z","caller":"traceutil/trace.go:171","msg":"trace[810389227] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:633; }","duration":"280.001221ms","start":"2026-05-19T19:15:52.554737Z","end":"2026-05-19T19:15:52.834738Z","steps":["trace[810389227] 'count revisions from in-memory index tree' (duration: 278.836562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:52.347226Z","time spent":"486.377883ms","remote":"127.0.0.1:48814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-19T19:15:52.833687Z","caller":"traceutil/trace.go:171","msg":"trace[212805171] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"486.30945ms","start":"2026-05-19T19:15:52.347363Z","end":"2026-05-19T19:15:52.833673Z","steps":["trace[212805171] 'count revisions from in-memory index tree' (duration: 486.192488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.834925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:52.347293Z","time spent":"487.614413ms","remote":"127.0.0.1:48814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:15:52.833665Z","caller":"traceutil/trace.go:171","msg":"trace[844428465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"206.022273ms","start":"2026-05-19T19:15:52.627623Z","end":"2026-05-19T19:15:52.833645Z","steps":["trace[844428465] 'count revisions from in-memory index tree' (duration: 205.822378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.718932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.835149Z","caller":"traceutil/trace.go:171","msg":"trace[935248926] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"338.166289ms","start":"2026-05-19T19:15:52.49697Z","end":"2026-05-19T19:15:52.835136Z","steps":["trace[935248926] 'count revisions from in-memory index tree' (duration: 336.645691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.835195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:52.496953Z","time spent":"338.22703ms","remote":"127.0.0.1:48826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:15:52.833735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.314481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.835284Z","caller":"traceutil/trace.go:171","msg":"trace[1522160921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"188.884669ms","start":"2026-05-19T19:15:52.64639Z","end":"2026-05-19T19:15:52.835275Z","steps":["trace[1522160921] 'range keys from in-memory index tree' (duration: 187.260919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:15:52.49769Z","time spent":"335.78783ms","remote":"127.0.0.1:48814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-05-19T19:15:52.833862Z","caller":"traceutil/trace.go:171","msg":"trace[1828505600] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"149.929107ms","start":"2026-05-19T19:15:52.683924Z","end":"2026-05-19T19:15:52.833853Z","steps":["trace[1828505600] 'range keys from in-memory index tree' (duration: 149.834734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.586598ms","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-05-19T19:15:52.835742Z","caller":"traceutil/trace.go:171","msg":"trace[533748285] 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:633; }","duration":"191.506475ms","start":"2026-05-19T19:15:52.644217Z","end":"2026-05-19T19:15:52.835724Z","steps":["trace[533748285] 'range keys from in-memory index tree' (duration: 189.459335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.661878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.836011Z","caller":"traceutil/trace.go:171","msg":"trace[333244078] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"242.74679ms","start":"2026-05-19T19:15:52.593251Z","end":"2026-05-19T19:15:52.835998Z","steps":["trace[333244078] 'range keys from in-memory index tree' (duration: 240.638547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.221038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.836263Z","caller":"traceutil/trace.go:171","msg":"trace[1784488672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"208.595438ms","start":"2026-05-19T19:15:52.627655Z","end":"2026-05-19T19:15:52.83625Z","steps":["trace[1784488672] 'range keys from in-memory index tree' (duration: 206.177577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.4838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:15:52.836439Z","caller":"traceutil/trace.go:171","msg":"trace[290931753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"208.437354ms","start":"2026-05-19T19:15:52.627981Z","end":"2026-05-19T19:15:52.836418Z","steps":["trace[290931753] 'range keys from in-memory index tree' (duration: 205.401888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:15:52.833923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.878655ms","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-05-19T19:15:52.836712Z","caller":"traceutil/trace.go:171","msg":"trace[1328939124] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"152.695556ms","start":"2026-05-19T19:15:52.683998Z","end":"2026-05-19T19:15:52.836693Z","steps":["trace[1328939124] 'count revisions from in-memory index tree' (duration: 149.800084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:07.561692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.739285ms","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-05-19T19:16:07.561772Z","caller":"traceutil/trace.go:171","msg":"trace[229342010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:779; }","duration":"262.854009ms","start":"2026-05-19T19:16:07.298901Z","end":"2026-05-19T19:16:07.561755Z","steps":["trace[229342010] 'range keys from in-memory index tree' (duration: 262.567201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:07.561855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.397528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4tbmb\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-19T19:16:07.561897Z","caller":"traceutil/trace.go:171","msg":"trace[340589060] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4tbmb; range_end:; response_count:1; response_revision:779; }","duration":"270.47995ms","start":"2026-05-19T19:16:07.291407Z","end":"2026-05-19T19:16:07.561887Z","steps":["trace[340589060] 'range keys from in-memory index tree' (duration: 270.271685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:07.561895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.28889ms","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-05-19T19:16:07.561937Z","caller":"traceutil/trace.go:171","msg":"trace[1940574732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:779; }","duration":"507.370742ms","start":"2026-05-19T19:16:07.054555Z","end":"2026-05-19T19:16:07.561926Z","steps":["trace[1940574732] 'range keys from in-memory index tree' (duration: 507.080715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:07.561978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:07.054535Z","time spent":"507.434844ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T19:16:07.561997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.824856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:16:07.562019Z","caller":"traceutil/trace.go:171","msg":"trace[459827347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:779; }","duration":"258.860437ms","start":"2026-05-19T19:16:07.303151Z","end":"2026-05-19T19:16:07.562011Z","steps":["trace[459827347] 'range keys from in-memory index tree' (duration: 258.762684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:07.561937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.883627ms","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-05-19T19:16:07.562154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.804587ms","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-05-19T19:16:07.562236Z","caller":"traceutil/trace.go:171","msg":"trace[1702912256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:779; }","duration":"263.147285ms","start":"2026-05-19T19:16:07.299071Z","end":"2026-05-19T19:16:07.562218Z","steps":["trace[1702912256] 'range keys from in-memory index tree' (duration: 262.657163ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:07.562203Z","caller":"traceutil/trace.go:171","msg":"trace[783552977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:779; }","duration":"259.181294ms","start":"2026-05-19T19:16:07.303009Z","end":"2026-05-19T19:16:07.56219Z","steps":["trace[783552977] 'range keys from in-memory index tree' (duration: 258.791025ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:15.693576Z","caller":"traceutil/trace.go:171","msg":"trace[1484464164] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"171.361707ms","start":"2026-05-19T19:16:15.522196Z","end":"2026-05-19T19:16:15.693557Z","steps":["trace[1484464164] 'process raft request' (duration: 171.189582ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:36.386216Z","caller":"traceutil/trace.go:171","msg":"trace[1555043263] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"143.249561ms","start":"2026-05-19T19:16:36.242884Z","end":"2026-05-19T19:16:36.386134Z","steps":["trace[1555043263] 'process raft request' (duration: 57.10059ms)","trace[1555043263] 'compare' (duration: 85.980525ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:37.461246Z","caller":"traceutil/trace.go:171","msg":"trace[1181621493] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"740.264334ms","start":"2026-05-19T19:16:36.720954Z","end":"2026-05-19T19:16:37.461218Z","steps":["trace[1181621493] 'process raft request' (duration: 740.147911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:37.461366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:36.720933Z","time spent":"740.372386ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:42.36476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.144838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:16:42.36482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.127332ms","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-05-19T19:16:42.364852Z","caller":"traceutil/trace.go:171","msg":"trace[179113264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"110.275421ms","start":"2026-05-19T19:16:42.254556Z","end":"2026-05-19T19:16:42.364831Z","steps":["trace[179113264] 'range keys from in-memory index tree' (duration: 110.074836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:42.364896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.021413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T19:16:42.364952Z","caller":"traceutil/trace.go:171","msg":"trace[1691903868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:996; }","duration":"382.125946ms","start":"2026-05-19T19:16:41.982813Z","end":"2026-05-19T19:16:42.364939Z","steps":["trace[1691903868] 'range keys from in-memory index tree' (duration: 381.86236ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:42.364951Z","caller":"traceutil/trace.go:171","msg":"trace[1167493904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:996; }","duration":"379.295325ms","start":"2026-05-19T19:16:41.985637Z","end":"2026-05-19T19:16:42.364932Z","steps":["trace[1167493904] 'range keys from in-memory index tree' (duration: 378.977718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:42.36498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:41.98278Z","time spent":"382.193247ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T19:16:42.364999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:41.985627Z","time spent":"379.361128ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:16:42.364842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.132546ms","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-05-19T19:16:42.365115Z","caller":"traceutil/trace.go:171","msg":"trace[576157002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:996; }","duration":"380.451804ms","start":"2026-05-19T19:16:41.984655Z","end":"2026-05-19T19:16:42.365107Z","steps":["trace[576157002] 'range keys from in-memory index tree' (duration: 379.923341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:42.365136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:41.984634Z","time spent":"380.495525ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:16:42.365545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.137995ms","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-05-19T19:16:42.365584Z","caller":"traceutil/trace.go:171","msg":"trace[321471574] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:996; }","duration":"382.196417ms","start":"2026-05-19T19:16:41.983376Z","end":"2026-05-19T19:16:42.365573Z","steps":["trace[321471574] 'range keys from in-memory index tree' (duration: 382.034593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:42.365628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:41.983368Z","time spent":"382.247638ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-19T19:16:42.733999Z","caller":"traceutil/trace.go:171","msg":"trace[867839063] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"364.327943ms","start":"2026-05-19T19:16:42.369649Z","end":"2026-05-19T19:16:42.733977Z","steps":["trace[867839063] 'process raft request' (duration: 364.19351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:42.734187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:42.369623Z","time spent":"364.446087ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:43.244086Z","caller":"traceutil/trace.go:171","msg":"trace[1903520647] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"874.175662ms","start":"2026-05-19T19:16:42.369889Z","end":"2026-05-19T19:16:43.244064Z","steps":["trace[1903520647] 'process raft request' (duration: 873.971826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:43.244239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:42.369879Z","time spent":"874.287014ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:43.244511Z","caller":"traceutil/trace.go:171","msg":"trace[1471430482] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"874.017269ms","start":"2026-05-19T19:16:42.370483Z","end":"2026-05-19T19:16:43.2445Z","steps":["trace[1471430482] 'process raft request' (duration: 873.540377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:43.24457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:42.370461Z","time spent":"874.08033ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:16:43.244839Z","caller":"traceutil/trace.go:171","msg":"trace[6235819] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"873.486666ms","start":"2026-05-19T19:16:42.371341Z","end":"2026-05-19T19:16:43.244828Z","steps":["trace[6235819] 'process raft request' (duration: 873.091766ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:43.244835Z","caller":"traceutil/trace.go:171","msg":"trace[609278646] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1032; }","duration":"596.729198ms","start":"2026-05-19T19:16:42.648082Z","end":"2026-05-19T19:16:43.244811Z","steps":["trace[609278646] 'read index received' (duration: 85.874264ms)","trace[609278646] 'applied index is now lower than readState.Index' (duration: 510.853944ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:16:43.244894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:42.371328Z","time spent":"873.539017ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:16:43.245037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.932343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:16:43.245287Z","caller":"traceutil/trace.go:171","msg":"trace[1086739372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1000; }","duration":"597.22969ms","start":"2026-05-19T19:16:42.648037Z","end":"2026-05-19T19:16:43.245267Z","steps":["trace[1086739372] 'agreement among raft nodes before linearized reading' (duration: 596.887562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:16:43.245351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:16:42.648018Z","time spent":"597.310512ms","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T19:16:45.354568Z","caller":"traceutil/trace.go:171","msg":"trace[385308728] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"101.331288ms","start":"2026-05-19T19:16:45.253213Z","end":"2026-05-19T19:16:45.354544Z","steps":["trace[385308728] 'process raft request' (duration: 71.346003ms)","trace[385308728] 'compare' (duration: 29.859262ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:16:45.354862Z","caller":"traceutil/trace.go:171","msg":"trace[444222556] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"100.927649ms","start":"2026-05-19T19:16:45.253912Z","end":"2026-05-19T19:16:45.35484Z","steps":["trace[444222556] 'process raft request' (duration: 100.59613ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:16:59.581437Z","caller":"traceutil/trace.go:171","msg":"trace[1095558353] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"194.624446ms","start":"2026-05-19T19:16:59.386791Z","end":"2026-05-19T19:16:59.581416Z","steps":["trace[1095558353] 'process raft request' (duration: 194.212946ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:01.714875Z","caller":"traceutil/trace.go:171","msg":"trace[1828659630] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"109.322646ms","start":"2026-05-19T19:17:01.605512Z","end":"2026-05-19T19:17:01.714834Z","steps":["trace[1828659630] 'process raft request' (duration: 83.156086ms)","trace[1828659630] 'compare' (duration: 25.827282ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:03.846924Z","caller":"traceutil/trace.go:171","msg":"trace[1923811705] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1104; }","duration":"115.450499ms","start":"2026-05-19T19:17:03.731454Z","end":"2026-05-19T19:17:03.846905Z","steps":["trace[1923811705] 'read index received' (duration: 53.403607ms)","trace[1923811705] 'applied index is now lower than readState.Index' (duration: 62.046102ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:03.846972Z","caller":"traceutil/trace.go:171","msg":"trace[80502191] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"128.142924ms","start":"2026-05-19T19:17:03.718806Z","end":"2026-05-19T19:17:03.846949Z","steps":["trace[80502191] 'process raft request' (duration: 66.094702ms)","trace[80502191] 'compare' (duration: 61.898758ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:03.847126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.652544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T19:17:03.847152Z","caller":"traceutil/trace.go:171","msg":"trace[1952466233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"115.732946ms","start":"2026-05-19T19:17:03.731412Z","end":"2026-05-19T19:17:03.847145Z","steps":["trace[1952466233] 'agreement among raft nodes before linearized reading' (duration: 115.597523ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:06.1923Z","caller":"traceutil/trace.go:171","msg":"trace[1859969036] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1110; }","duration":"309.468269ms","start":"2026-05-19T19:17:05.882805Z","end":"2026-05-19T19:17:06.192273Z","steps":["trace[1859969036] 'read index received' (duration: 223.631037ms)","trace[1859969036] 'applied index is now lower than readState.Index' (duration: 85.836282ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:06.192335Z","caller":"traceutil/trace.go:171","msg":"trace[469956626] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"339.919977ms","start":"2026-05-19T19:17:05.852368Z","end":"2026-05-19T19:17:06.192287Z","steps":["trace[469956626] 'process raft request' (duration: 254.122015ms)","trace[469956626] 'compare' (duration: 85.665278ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:06.192513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:05.852333Z","time spent":"340.0815ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:06.192557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.586156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-19T19:17:06.192562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.758986ms","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-05-19T19:17:06.19259Z","caller":"traceutil/trace.go:171","msg":"trace[537940497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1071; }","duration":"279.683179ms","start":"2026-05-19T19:17:05.912898Z","end":"2026-05-19T19:17:06.192581Z","steps":["trace[537940497] 'agreement among raft nodes before linearized reading' (duration: 279.530445ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:06.192628Z","caller":"traceutil/trace.go:171","msg":"trace[1755889380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1071; }","duration":"309.888319ms","start":"2026-05-19T19:17:05.882722Z","end":"2026-05-19T19:17:06.19261Z","steps":["trace[1755889380] 'agreement among raft nodes before linearized reading' (duration: 309.675374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:06.192676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:05.882689Z","time spent":"309.976352ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T19:17:06.655226Z","caller":"traceutil/trace.go:171","msg":"trace[1670991192] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"458.510134ms","start":"2026-05-19T19:17:06.196688Z","end":"2026-05-19T19:17:06.655199Z","steps":["trace[1670991192] 'process raft request' (duration: 410.118371ms)","trace[1670991192] 'compare' (duration: 48.207178ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:06.65537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:06.196663Z","time spent":"458.634766ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:06.693576Z","caller":"traceutil/trace.go:171","msg":"trace[1635249643] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"496.270351ms","start":"2026-05-19T19:17:06.197251Z","end":"2026-05-19T19:17:06.693521Z","steps":["trace[1635249643] 'process raft request' (duration: 496.035676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:06.693735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:06.197227Z","time spent":"496.425025ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:06.693869Z","caller":"traceutil/trace.go:171","msg":"trace[1409544119] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"496.527258ms","start":"2026-05-19T19:17:06.19733Z","end":"2026-05-19T19:17:06.693858Z","steps":["trace[1409544119] 'process raft request' (duration: 496.139008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:06.693925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:06.197323Z","time spent":"496.573019ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:06.693811Z","caller":"traceutil/trace.go:171","msg":"trace[1438258597] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1111; }","duration":"473.641989ms","start":"2026-05-19T19:17:06.220085Z","end":"2026-05-19T19:17:06.693727Z","steps":["trace[1438258597] 'read index received' (duration: 386.606697ms)","trace[1438258597] 'applied index is now lower than readState.Index' (duration: 87.033342ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:06.694248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.109841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T19:17:06.694319Z","caller":"traceutil/trace.go:171","msg":"trace[690490743] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:1074; }","duration":"474.201674ms","start":"2026-05-19T19:17:06.220079Z","end":"2026-05-19T19:17:06.694281Z","steps":["trace[690490743] 'agreement among raft nodes before linearized reading' (duration: 473.898755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:06.694363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:06.220039Z","time spent":"474.311357ms","remote":"127.0.0.1:40778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.49\" "} {"level":"info","ts":"2026-05-19T19:17:10.372652Z","caller":"traceutil/trace.go:171","msg":"trace[1122142455] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"128.746379ms","start":"2026-05-19T19:17:10.243881Z","end":"2026-05-19T19:17:10.372627Z","steps":["trace[1122142455] 'process raft request' (duration: 128.563905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:10.995542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.643639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:10.995631Z","caller":"traceutil/trace.go:171","msg":"trace[1687153596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1085; }","duration":"347.824433ms","start":"2026-05-19T19:17:10.647786Z","end":"2026-05-19T19:17:10.99561Z","steps":["trace[1687153596] 'range keys from in-memory index tree' (duration: 347.538936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:10.995668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:10.647764Z","time spent":"347.895364ms","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:17:10.99565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.41517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T19:17:10.995773Z","caller":"traceutil/trace.go:171","msg":"trace[1625078896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1085; }","duration":"229.571825ms","start":"2026-05-19T19:17:10.766183Z","end":"2026-05-19T19:17:10.995755Z","steps":["trace[1625078896] 'range keys from in-memory index tree' (duration: 229.212686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:10.995971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.656527ms","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-05-19T19:17:10.996023Z","caller":"traceutil/trace.go:171","msg":"trace[262264896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1085; }","duration":"260.743099ms","start":"2026-05-19T19:17:10.735265Z","end":"2026-05-19T19:17:10.996009Z","steps":["trace[262264896] 'range keys from in-memory index tree' (duration: 260.436531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:10.996081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.957139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T19:17:10.996126Z","caller":"traceutil/trace.go:171","msg":"trace[1912636870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1085; }","duration":"196.046361ms","start":"2026-05-19T19:17:10.800067Z","end":"2026-05-19T19:17:10.996113Z","steps":["trace[1912636870] 'range keys from in-memory index tree' (duration: 195.769624ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:11.420418Z","caller":"traceutil/trace.go:171","msg":"trace[309476476] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"420.016377ms","start":"2026-05-19T19:17:11.000377Z","end":"2026-05-19T19:17:11.420394Z","steps":["trace[309476476] 'process raft request' (duration: 419.873463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:11.420585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.000355Z","time spent":"420.147671ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:12.149412Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278927083616322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:17:12.503735Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.083471892s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-19T19:17:12.632876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.836161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:12.633081Z","caller":"traceutil/trace.go:171","msg":"trace[714806107] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"1.632050154s","start":"2026-05-19T19:17:11.000997Z","end":"2026-05-19T19:17:12.633047Z","steps":["trace[714806107] 'process raft request' (duration: 1.502960707s)","trace[714806107] 'compare' (duration: 126.952965ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:12.63319Z","caller":"traceutil/trace.go:171","msg":"trace[1345047582] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"1.632117186s","start":"2026-05-19T19:17:11.001053Z","end":"2026-05-19T19:17:12.63317Z","steps":["trace[1345047582] 'process raft request' (duration: 1.631927161s)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:12.63321Z","caller":"traceutil/trace.go:171","msg":"trace[1829722451] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"1.631645836s","start":"2026-05-19T19:17:11.001541Z","end":"2026-05-19T19:17:12.633187Z","steps":["trace[1829722451] 'process raft request' (duration: 1.631550533s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:12.633234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.000975Z","time spent":"1.632171227s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:12.633283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.001033Z","time spent":"1.632203619s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:12.633297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.001531Z","time spent":"1.631724948s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:12.633447Z","caller":"traceutil/trace.go:171","msg":"trace[1078822183] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"1.429462592s","start":"2026-05-19T19:17:11.203972Z","end":"2026-05-19T19:17:12.633435Z","steps":["trace[1078822183] 'process raft request' (duration: 1.429172844s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:12.633501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.203947Z","time spent":"1.429531963s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:13.238235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.838929ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-19T19:17:13.23835Z","caller":"traceutil/trace.go:171","msg":"trace[210604541] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1127; }","duration":"1.589897018s","start":"2026-05-19T19:17:11.648432Z","end":"2026-05-19T19:17:13.238329Z","steps":["trace[210604541] 'read index received' (duration: 855.603281ms)","trace[210604541] 'applied index is now lower than readState.Index' (duration: 734.291997ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:13.238502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.590048761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:13.238595Z","caller":"traceutil/trace.go:171","msg":"trace[874302557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1090; }","duration":"1.590161824s","start":"2026-05-19T19:17:11.648412Z","end":"2026-05-19T19:17:13.238574Z","steps":["trace[874302557] 'agreement among raft nodes before linearized reading' (duration: 1.59000719s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.238646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.648252Z","time spent":"1.590380809s","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T19:17:13.271227Z","caller":"traceutil/trace.go:171","msg":"trace[1157075811] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"892.856316ms","start":"2026-05-19T19:17:12.378344Z","end":"2026-05-19T19:17:13.271201Z","steps":["trace[1157075811] 'process raft request' (duration: 892.5988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.27127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.367309786s","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-05-19T19:17:13.27133Z","caller":"traceutil/trace.go:171","msg":"trace[1463059278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1091; }","duration":"1.367398508s","start":"2026-05-19T19:17:11.903913Z","end":"2026-05-19T19:17:13.271312Z","steps":["trace[1463059278] 'agreement among raft nodes before linearized reading' (duration: 1.367227453s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.271247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.185053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:17:13.271375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:11.903896Z","time spent":"1.36746664s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:13.271377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:12.378312Z","time spent":"892.988069ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:13.271384Z","caller":"traceutil/trace.go:171","msg":"trace[1571217165] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1091; }","duration":"138.374448ms","start":"2026-05-19T19:17:13.132997Z","end":"2026-05-19T19:17:13.271371Z","steps":["trace[1571217165] 'agreement among raft nodes before linearized reading' (duration: 138.126242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.271355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.58434ms","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-05-19T19:17:13.271726Z","caller":"traceutil/trace.go:171","msg":"trace[1876472607] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1091; }","duration":"886.966039ms","start":"2026-05-19T19:17:12.384704Z","end":"2026-05-19T19:17:13.27167Z","steps":["trace[1876472607] 'agreement among raft nodes before linearized reading' (duration: 886.541129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.271838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:12.384688Z","time spent":"887.119753ms","remote":"127.0.0.1:41200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:17:13.672303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.051633ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:13.672434Z","caller":"traceutil/trace.go:171","msg":"trace[842811058] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1091; }","duration":"316.183306ms","start":"2026-05-19T19:17:13.356222Z","end":"2026-05-19T19:17:13.672406Z","steps":["trace[842811058] 'range keys from in-memory index tree' (duration: 316.036253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.672709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.931624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:13.672768Z","caller":"traceutil/trace.go:171","msg":"trace[75092964] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"393.455188ms","start":"2026-05-19T19:17:13.279303Z","end":"2026-05-19T19:17:13.672758Z","steps":["trace[75092964] 'read index received' (duration: 200.340159ms)","trace[75092964] 'applied index is now lower than readState.Index' (duration: 193.114019ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:13.673021Z","caller":"traceutil/trace.go:171","msg":"trace[1054869969] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"397.016516ms","start":"2026-05-19T19:17:13.27599Z","end":"2026-05-19T19:17:13.673007Z","steps":["trace[1054869969] 'process raft request' (duration: 203.730773ms)","trace[1054869969] 'compare' (duration: 192.460432ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:13.673085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:13.275975Z","time spent":"397.079787ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:13.673281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.94639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:17:13.673327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.312295ms","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-05-19T19:17:13.673493Z","caller":"traceutil/trace.go:171","msg":"trace[754687491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1092; }","duration":"249.49665ms","start":"2026-05-19T19:17:13.423951Z","end":"2026-05-19T19:17:13.673448Z","steps":["trace[754687491] 'agreement among raft nodes before linearized reading' (duration: 249.055529ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:13.673362Z","caller":"traceutil/trace.go:171","msg":"trace[1968654883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"394.059652ms","start":"2026-05-19T19:17:13.279282Z","end":"2026-05-19T19:17:13.673342Z","steps":["trace[1968654883] 'agreement among raft nodes before linearized reading' (duration: 393.894578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:13.673898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:13.279275Z","time spent":"394.603685ms","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T19:17:18.807827Z","caller":"traceutil/trace.go:171","msg":"trace[876629044] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1150; }","duration":"148.47998ms","start":"2026-05-19T19:17:18.659322Z","end":"2026-05-19T19:17:18.807802Z","steps":["trace[876629044] 'read index received' (duration: 148.338216ms)","trace[876629044] 'applied index is now lower than readState.Index' (duration: 138.334µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:18.807931Z","caller":"traceutil/trace.go:171","msg":"trace[1113242902] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"148.869449ms","start":"2026-05-19T19:17:18.659037Z","end":"2026-05-19T19:17:18.807906Z","steps":["trace[1113242902] 'process raft request' (duration: 148.605383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:18.808228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.853969ms","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-05-19T19:17:18.808363Z","caller":"traceutil/trace.go:171","msg":"trace[1664924194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1108; }","duration":"149.011982ms","start":"2026-05-19T19:17:18.65931Z","end":"2026-05-19T19:17:18.808322Z","steps":["trace[1664924194] 'agreement among raft nodes before linearized reading' (duration: 148.596602ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:18.855554Z","caller":"traceutil/trace.go:171","msg":"trace[1508809235] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"195.300923ms","start":"2026-05-19T19:17:18.660207Z","end":"2026-05-19T19:17:18.855508Z","steps":["trace[1508809235] 'process raft request' (duration: 162.747494ms)","trace[1508809235] 'compare' (duration: 32.256602ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:21.937936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.213234ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-19T19:17:21.938025Z","caller":"traceutil/trace.go:171","msg":"trace[2055717908] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"181.05068ms","start":"2026-05-19T19:17:21.756958Z","end":"2026-05-19T19:17:21.938009Z","steps":["trace[2055717908] 'read index received' (duration: 11.684862ms)","trace[2055717908] 'applied index is now lower than readState.Index' (duration: 169.364638ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:21.938228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.263535ms","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-05-19T19:17:21.938297Z","caller":"traceutil/trace.go:171","msg":"trace[1318216432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1118; }","duration":"181.342357ms","start":"2026-05-19T19:17:21.756914Z","end":"2026-05-19T19:17:21.938257Z","steps":["trace[1318216432] 'agreement among raft nodes before linearized reading' (duration: 181.139402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:29.392628Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278927083616568,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:17:29.892797Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278927083616568,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T19:17:29.993526Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.139943452s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T19:17:29.993936Z","caller":"traceutil/trace.go:171","msg":"trace[784325872] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"1.140413143s","start":"2026-05-19T19:17:28.853494Z","end":"2026-05-19T19:17:29.993907Z","steps":["trace[784325872] 'process raft request' (duration: 1.140244019s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:29.994173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:28.853473Z","time spent":"1.140559278s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:30.147311Z","caller":"traceutil/trace.go:171","msg":"trace[349509470] linearizableReadLoop","detail":"{readStateIndex:1248; appliedIndex:1246; }","duration":"1.255668009s","start":"2026-05-19T19:17:28.891625Z","end":"2026-05-19T19:17:30.147293Z","steps":["trace[349509470] 'read index received' (duration: 1.102104708s)","trace[349509470] 'applied index is now lower than readState.Index' (duration: 153.562661ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:30.147368Z","caller":"traceutil/trace.go:171","msg":"trace[1472226070] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"790.988634ms","start":"2026-05-19T19:17:29.356358Z","end":"2026-05-19T19:17:30.147347Z","steps":["trace[1472226070] 'process raft request' (duration: 784.584076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:30.147482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253165749s","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-05-19T19:17:30.1475Z","caller":"traceutil/trace.go:171","msg":"trace[944478914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1201; }","duration":"1.25323096s","start":"2026-05-19T19:17:28.894263Z","end":"2026-05-19T19:17:30.147494Z","steps":["trace[944478914] 'agreement among raft nodes before linearized reading' (duration: 1.253122948s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:30.147516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:28.894238Z","time spent":"1.253275391s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:30.147506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:29.35634Z","time spent":"791.082017ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:30.14755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.434939ms","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-05-19T19:17:30.147616Z","caller":"traceutil/trace.go:171","msg":"trace[896509955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1201; }","duration":"370.541582ms","start":"2026-05-19T19:17:29.777058Z","end":"2026-05-19T19:17:30.1476Z","steps":["trace[896509955] 'agreement among raft nodes before linearized reading' (duration: 370.368788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:30.147627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.797453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:17:30.147663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:29.777038Z","time spent":"370.614003ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:30.147695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.599111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:30.147704Z","caller":"traceutil/trace.go:171","msg":"trace[1092017115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1201; }","duration":"499.915526ms","start":"2026-05-19T19:17:29.647767Z","end":"2026-05-19T19:17:30.147683Z","steps":["trace[1092017115] 'agreement among raft nodes before linearized reading' (duration: 499.804203ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:30.147749Z","caller":"traceutil/trace.go:171","msg":"trace[912638717] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1201; }","duration":"919.680953ms","start":"2026-05-19T19:17:29.228055Z","end":"2026-05-19T19:17:30.147736Z","steps":["trace[912638717] 'agreement among raft nodes before linearized reading' (duration: 919.601111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:30.147756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:29.647742Z","time spent":"500.005348ms","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:17:30.147795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:29.228039Z","time spent":"919.744064ms","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:17:30.148222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.256581452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T19:17:30.148321Z","caller":"traceutil/trace.go:171","msg":"trace[212296048] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1201; }","duration":"1.256723806s","start":"2026-05-19T19:17:28.891571Z","end":"2026-05-19T19:17:30.148295Z","steps":["trace[212296048] 'agreement among raft nodes before linearized reading' (duration: 1.255813894s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:30.148367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:28.891549Z","time spent":"1.256807718s","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T19:17:42.299915Z","caller":"traceutil/trace.go:171","msg":"trace[696783562] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"116.964759ms","start":"2026-05-19T19:17:42.182932Z","end":"2026-05-19T19:17:42.299897Z","steps":["trace[696783562] 'process raft request' (duration: 104.195933ms)","trace[696783562] 'compare' (duration: 12.57982ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:44.501614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.140396ms","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-05-19T19:17:44.501699Z","caller":"traceutil/trace.go:171","msg":"trace[417035569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1246; }","duration":"435.276951ms","start":"2026-05-19T19:17:44.066404Z","end":"2026-05-19T19:17:44.50168Z","steps":["trace[417035569] 'range keys from in-memory index tree' (duration: 434.974342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:44.501742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.066386Z","time spent":"435.347252ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:17:44.501931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006324283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:44.502006Z","caller":"traceutil/trace.go:171","msg":"trace[1091568168] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1246; }","duration":"1.006449416s","start":"2026-05-19T19:17:43.495543Z","end":"2026-05-19T19:17:44.501992Z","steps":["trace[1091568168] 'count revisions from in-memory index tree' (duration: 1.006259171s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:44.502036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:43.495523Z","time spent":"1.006505687s","remote":"127.0.0.1:48712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:17:44.502067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.459102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:44.502186Z","caller":"traceutil/trace.go:171","msg":"trace[1401356695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1246; }","duration":"854.540943ms","start":"2026-05-19T19:17:43.647572Z","end":"2026-05-19T19:17:44.502113Z","steps":["trace[1401356695] 'range keys from in-memory index tree' (duration: 854.40756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:44.502222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:43.647562Z","time spent":"854.651557ms","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T19:17:44.542034Z","caller":"traceutil/trace.go:171","msg":"trace[843926378] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"219.284745ms","start":"2026-05-19T19:17:44.322728Z","end":"2026-05-19T19:17:44.542013Z","steps":["trace[843926378] 'read index received' (duration: 219.186392ms)","trace[843926378] 'applied index is now lower than readState.Index' (duration: 97.343µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:44.542269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.539491ms","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-05-19T19:17:44.542323Z","caller":"traceutil/trace.go:171","msg":"trace[1229621608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1247; }","duration":"219.596702ms","start":"2026-05-19T19:17:44.322712Z","end":"2026-05-19T19:17:44.542309Z","steps":["trace[1229621608] 'agreement among raft nodes before linearized reading' (duration: 219.439078ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:44.542266Z","caller":"traceutil/trace.go:171","msg":"trace[1139220225] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"237.392693ms","start":"2026-05-19T19:17:44.304663Z","end":"2026-05-19T19:17:44.542056Z","steps":["trace[1139220225] 'process raft request' (duration: 237.188678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:45.006641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.632802ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:45.006762Z","caller":"traceutil/trace.go:171","msg":"trace[621201855] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"464.624895ms","start":"2026-05-19T19:17:44.54212Z","end":"2026-05-19T19:17:45.006745Z","steps":["trace[621201855] 'read index received' (duration: 336.776307ms)","trace[621201855] 'applied index is now lower than readState.Index' (duration: 127.844818ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:45.006815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.90551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:45.006873Z","caller":"traceutil/trace.go:171","msg":"trace[1206443410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1248; }","duration":"502.988522ms","start":"2026-05-19T19:17:44.503871Z","end":"2026-05-19T19:17:45.006859Z","steps":["trace[1206443410] 'agreement among raft nodes before linearized reading' (duration: 502.875539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:45.006907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.503858Z","time spent":"503.044443ms","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:17:45.006902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.979575ms","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-05-19T19:17:45.006976Z","caller":"traceutil/trace.go:171","msg":"trace[1939892381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1248; }","duration":"653.081418ms","start":"2026-05-19T19:17:44.353878Z","end":"2026-05-19T19:17:45.006959Z","steps":["trace[1939892381] 'agreement among raft nodes before linearized reading' (duration: 652.907794ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:45.006998Z","caller":"traceutil/trace.go:171","msg":"trace[1730490118] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"499.455743ms","start":"2026-05-19T19:17:44.507518Z","end":"2026-05-19T19:17:45.006973Z","steps":["trace[1730490118] 'process raft request' (duration: 371.413611ms)","trace[1730490118] 'compare' (duration: 127.490779ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:45.00702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.353843Z","time spent":"653.16942ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T19:17:45.007123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.50749Z","time spent":"499.567657ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:45.006906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.959085ms","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-05-19T19:17:45.007224Z","caller":"traceutil/trace.go:171","msg":"trace[27077210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1248; }","duration":"653.328344ms","start":"2026-05-19T19:17:44.353886Z","end":"2026-05-19T19:17:45.007214Z","steps":["trace[27077210] 'agreement among raft nodes before linearized reading' (duration: 652.886584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:45.007254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.353868Z","time spent":"653.377065ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:45.007013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.700483ms","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-05-19T19:17:45.007336Z","caller":"traceutil/trace.go:171","msg":"trace[715773769] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1248; }","duration":"654.021711ms","start":"2026-05-19T19:17:44.3533Z","end":"2026-05-19T19:17:45.007322Z","steps":["trace[715773769] 'agreement among raft nodes before linearized reading' (duration: 653.513069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:45.007429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.353253Z","time spent":"654.164844ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T19:17:45.092386Z","caller":"traceutil/trace.go:171","msg":"trace[909781536] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"545.145582ms","start":"2026-05-19T19:17:44.54722Z","end":"2026-05-19T19:17:45.092365Z","steps":["trace[909781536] 'process raft request' (duration: 545.049259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:45.092539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.547191Z","time spent":"545.255715ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:45.092959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.542184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T19:17:45.093002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.146028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:17:45.093048Z","caller":"traceutil/trace.go:171","msg":"trace[623999508] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1249; }","duration":"162.680768ms","start":"2026-05-19T19:17:44.930343Z","end":"2026-05-19T19:17:45.093024Z","steps":["trace[623999508] 'agreement among raft nodes before linearized reading' (duration: 162.533734ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:45.093149Z","caller":"traceutil/trace.go:171","msg":"trace[696683210] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1249; }","duration":"495.21919ms","start":"2026-05-19T19:17:44.597811Z","end":"2026-05-19T19:17:45.09303Z","steps":["trace[696683210] 'agreement among raft nodes before linearized reading' (duration: 495.144858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:45.093209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:44.597782Z","time spent":"495.411374ms","remote":"127.0.0.1:41048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":17,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-05-19T19:17:45.799241Z","caller":"traceutil/trace.go:171","msg":"trace[275515329] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"150.789544ms","start":"2026-05-19T19:17:45.648429Z","end":"2026-05-19T19:17:45.799218Z","steps":["trace[275515329] 'process raft request' (duration: 118.649829ms)","trace[275515329] 'compare' (duration: 32.039402ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:46.8845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:46.223709Z","time spent":"660.786219ms","remote":"127.0.0.1:40778","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-19T19:17:47.495217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.787448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:47.495438Z","caller":"traceutil/trace.go:171","msg":"trace[321539435] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"609.980484ms","start":"2026-05-19T19:17:46.885441Z","end":"2026-05-19T19:17:47.495421Z","steps":["trace[321539435] 'process raft request' (duration: 609.877452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.495512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:46.885424Z","time spent":"610.049695ms","remote":"127.0.0.1:40778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:47.495722Z","caller":"traceutil/trace.go:171","msg":"trace[514854153] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"947.720313ms","start":"2026-05-19T19:17:46.547961Z","end":"2026-05-19T19:17:47.495682Z","steps":["trace[514854153] 'process raft request' (duration: 548.386962ms)","trace[514854153] 'compare' (duration: 398.637455ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:47.495847Z","caller":"traceutil/trace.go:171","msg":"trace[858044328] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1305; }","duration":"850.398521ms","start":"2026-05-19T19:17:46.64542Z","end":"2026-05-19T19:17:47.495818Z","steps":["trace[858044328] 'read index received' (duration: 238.874199ms)","trace[858044328] 'applied index is now lower than readState.Index' (duration: 611.522122ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:47.495955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:46.547941Z","time spent":"947.869538ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:47.49598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.550254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:47.496035Z","caller":"traceutil/trace.go:171","msg":"trace[1203020661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"850.650297ms","start":"2026-05-19T19:17:46.645371Z","end":"2026-05-19T19:17:47.496021Z","steps":["trace[1203020661] 'agreement among raft nodes before linearized reading' (duration: 850.546484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.49607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:46.645353Z","time spent":"850.708948ms","remote":"127.0.0.1:40750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T19:17:47.49619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.906732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:47.49624Z","caller":"traceutil/trace.go:171","msg":"trace[25189477] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1257; }","duration":"736.013656ms","start":"2026-05-19T19:17:46.760215Z","end":"2026-05-19T19:17:47.496228Z","steps":["trace[25189477] 'agreement among raft nodes before linearized reading' (duration: 735.908493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.496307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:46.760196Z","time spent":"736.099327ms","remote":"127.0.0.1:48658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:17:47.496496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.954152ms","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-05-19T19:17:47.496495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.800959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:17:47.496534Z","caller":"traceutil/trace.go:171","msg":"trace[1525725689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1257; }","duration":"386.030514ms","start":"2026-05-19T19:17:47.110494Z","end":"2026-05-19T19:17:47.496525Z","steps":["trace[1525725689] 'agreement among raft nodes before linearized reading' (duration: 385.901851ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.496542Z","caller":"traceutil/trace.go:171","msg":"trace[449830126] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1257; }","duration":"728.86993ms","start":"2026-05-19T19:17:46.767661Z","end":"2026-05-19T19:17:47.496531Z","steps":["trace[449830126] 'agreement among raft nodes before linearized reading' (duration: 728.769458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.49654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.043479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-19T19:17:47.496563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:47.110476Z","time spent":"386.080345ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T19:17:47.496575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:46.767649Z","time spent":"728.917882ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-05-19T19:17:47.496644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.560362ms","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-05-19T19:17:47.49667Z","caller":"traceutil/trace.go:171","msg":"trace[1687086136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1257; }","duration":"485.624293ms","start":"2026-05-19T19:17:47.011038Z","end":"2026-05-19T19:17:47.496662Z","steps":["trace[1687086136] 'agreement among raft nodes before linearized reading' (duration: 485.352227ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.496583Z","caller":"traceutil/trace.go:171","msg":"trace[677866541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"387.123151ms","start":"2026-05-19T19:17:47.109448Z","end":"2026-05-19T19:17:47.496571Z","steps":["trace[677866541] 'agreement among raft nodes before linearized reading' (duration: 386.794452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.496725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:47.011012Z","time spent":"485.703606ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T19:17:47.49676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.955195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5330"} {"level":"warn","ts":"2026-05-19T19:17:47.496778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:47.109426Z","time spent":"387.343737ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T19:17:47.496797Z","caller":"traceutil/trace.go:171","msg":"trace[1998193377] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1257; }","duration":"210.037117ms","start":"2026-05-19T19:17:47.286749Z","end":"2026-05-19T19:17:47.496786Z","steps":["trace[1998193377] 'agreement among raft nodes before linearized reading' (duration: 209.518464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.496945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.268245ms","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-05-19T19:17:47.496995Z","caller":"traceutil/trace.go:171","msg":"trace[1360100940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1257; }","duration":"387.364187ms","start":"2026-05-19T19:17:47.109619Z","end":"2026-05-19T19:17:47.496983Z","steps":["trace[1360100940] 'agreement among raft nodes before linearized reading' (duration: 386.552306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.497032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:47.109576Z","time spent":"387.444679ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T19:17:47.49697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.369713ms","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-05-19T19:17:47.49729Z","caller":"traceutil/trace.go:171","msg":"trace[1608244385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1257; }","duration":"399.776213ms","start":"2026-05-19T19:17:47.097492Z","end":"2026-05-19T19:17:47.497269Z","steps":["trace[1608244385] 'agreement among raft nodes before linearized reading' (duration: 398.726537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:47.497539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:47.097465Z","time spent":"399.962648ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T19:17:47.654803Z","caller":"traceutil/trace.go:171","msg":"trace[110006767] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1308; }","duration":"153.87353ms","start":"2026-05-19T19:17:47.50091Z","end":"2026-05-19T19:17:47.654784Z","steps":["trace[110006767] 'read index received' (duration: 110.231942ms)","trace[110006767] 'applied index is now lower than readState.Index' (duration: 43.640858ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:47.65487Z","caller":"traceutil/trace.go:171","msg":"trace[2032099003] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"153.970542ms","start":"2026-05-19T19:17:47.500871Z","end":"2026-05-19T19:17:47.654842Z","steps":["trace[2032099003] 'process raft request' (duration: 110.259402ms)","trace[2032099003] 'compare' (duration: 43.553916ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:47.655116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.185467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T19:17:47.655164Z","caller":"traceutil/trace.go:171","msg":"trace[360074782] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1258; }","duration":"154.298941ms","start":"2026-05-19T19:17:47.500857Z","end":"2026-05-19T19:17:47.655156Z","steps":["trace[360074782] 'agreement among raft nodes before linearized reading' (duration: 154.119377ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.700612Z","caller":"traceutil/trace.go:171","msg":"trace[349778630] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"199.470386ms","start":"2026-05-19T19:17:47.50112Z","end":"2026-05-19T19:17:47.70059Z","steps":["trace[349778630] 'process raft request' (duration: 198.83062ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.700834Z","caller":"traceutil/trace.go:171","msg":"trace[419796465] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"199.686032ms","start":"2026-05-19T19:17:47.501138Z","end":"2026-05-19T19:17:47.700824Z","steps":["trace[419796465] 'process raft request' (duration: 198.953984ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.700951Z","caller":"traceutil/trace.go:171","msg":"trace[978774847] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"198.559314ms","start":"2026-05-19T19:17:47.502384Z","end":"2026-05-19T19:17:47.700943Z","steps":["trace[978774847] 'process raft request' (duration: 197.756834ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.701054Z","caller":"traceutil/trace.go:171","msg":"trace[1771775624] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"198.583165ms","start":"2026-05-19T19:17:47.502461Z","end":"2026-05-19T19:17:47.701045Z","steps":["trace[1771775624] 'process raft request' (duration: 197.722423ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:47.701319Z","caller":"traceutil/trace.go:171","msg":"trace[676605219] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"196.695958ms","start":"2026-05-19T19:17:47.504613Z","end":"2026-05-19T19:17:47.701309Z","steps":["trace[676605219] 'process raft request' (duration: 195.615081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:49.033736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.385139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:49.033871Z","caller":"traceutil/trace.go:171","msg":"trace[720769602] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"290.161845ms","start":"2026-05-19T19:17:48.743685Z","end":"2026-05-19T19:17:49.033847Z","steps":["trace[720769602] 'process raft request' (duration: 142.575721ms)","trace[720769602] 'compare' (duration: 147.258266ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:49.040603Z","caller":"traceutil/trace.go:171","msg":"trace[1921325799] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"295.078648ms","start":"2026-05-19T19:17:48.745508Z","end":"2026-05-19T19:17:49.040587Z","steps":["trace[1921325799] 'process raft request' (duration: 294.835672ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:49.040621Z","caller":"traceutil/trace.go:171","msg":"trace[1023164602] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"296.694407ms","start":"2026-05-19T19:17:48.743905Z","end":"2026-05-19T19:17:49.0406Z","steps":["trace[1023164602] 'process raft request' (duration: 296.331128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:49.438212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.463748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:17:49.438273Z","caller":"traceutil/trace.go:171","msg":"trace[940083179] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1271; }","duration":"163.56737ms","start":"2026-05-19T19:17:49.274691Z","end":"2026-05-19T19:17:49.438259Z","steps":["trace[940083179] 'count revisions from in-memory index tree' (duration: 163.361215ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:57.739886Z","caller":"traceutil/trace.go:171","msg":"trace[372724872] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"213.471492ms","start":"2026-05-19T19:17:57.526389Z","end":"2026-05-19T19:17:57.73986Z","steps":["trace[372724872] 'process raft request' (duration: 213.169925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:57.972558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.648253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:57.972752Z","caller":"traceutil/trace.go:171","msg":"trace[1858873175] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"226.845873ms","start":"2026-05-19T19:17:57.745888Z","end":"2026-05-19T19:17:57.972734Z","steps":["trace[1858873175] 'process raft request' (duration: 102.943603ms)","trace[1858873175] 'compare' (duration: 123.49351ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:57.973003Z","caller":"traceutil/trace.go:171","msg":"trace[2004433042] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"226.797311ms","start":"2026-05-19T19:17:57.746185Z","end":"2026-05-19T19:17:57.972982Z","steps":["trace[2004433042] 'process raft request' (duration: 226.467313ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:57.973186Z","caller":"traceutil/trace.go:171","msg":"trace[2132044394] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1398; }","duration":"224.764571ms","start":"2026-05-19T19:17:57.748385Z","end":"2026-05-19T19:17:57.97315Z","steps":["trace[2132044394] 'read index received' (duration: 100.528103ms)","trace[2132044394] 'applied index is now lower than readState.Index' (duration: 124.233118ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:57.973592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.089989ms","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-05-19T19:17:57.973602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.187422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-19T19:17:57.973691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.674645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T19:17:57.97372Z","caller":"traceutil/trace.go:171","msg":"trace[856619208] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1348; }","duration":"121.740096ms","start":"2026-05-19T19:17:57.851971Z","end":"2026-05-19T19:17:57.973711Z","steps":["trace[856619208] 'agreement among raft nodes before linearized reading' (duration: 121.688225ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:57.973715Z","caller":"traceutil/trace.go:171","msg":"trace[487864075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1348; }","duration":"225.322875ms","start":"2026-05-19T19:17:57.74837Z","end":"2026-05-19T19:17:57.973693Z","steps":["trace[487864075] 'agreement among raft nodes before linearized reading' (duration: 224.996356ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:57.973774Z","caller":"traceutil/trace.go:171","msg":"trace[1862118111] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"225.320665ms","start":"2026-05-19T19:17:57.748416Z","end":"2026-05-19T19:17:57.973737Z","steps":["trace[1862118111] 'process raft request' (duration: 224.516115ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:57.973636Z","caller":"traceutil/trace.go:171","msg":"trace[1115923621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1348; }","duration":"225.161521ms","start":"2026-05-19T19:17:57.748462Z","end":"2026-05-19T19:17:57.973623Z","steps":["trace[1115923621] 'agreement among raft nodes before linearized reading' (duration: 224.997826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:58.324388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.055867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:17:58.324779Z","caller":"traceutil/trace.go:171","msg":"trace[1950930271] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"347.092802ms","start":"2026-05-19T19:17:57.977594Z","end":"2026-05-19T19:17:58.324687Z","steps":["trace[1950930271] 'process raft request' (duration: 151.644835ms)","trace[1950930271] 'compare' (duration: 194.834942ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:17:58.324986Z","caller":"traceutil/trace.go:171","msg":"trace[949081196] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"347.195345ms","start":"2026-05-19T19:17:57.977771Z","end":"2026-05-19T19:17:58.324967Z","steps":["trace[949081196] 'process raft request' (duration: 346.957679ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:58.325038Z","caller":"traceutil/trace.go:171","msg":"trace[690371007] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"346.996899ms","start":"2026-05-19T19:17:57.978002Z","end":"2026-05-19T19:17:58.324998Z","steps":["trace[690371007] 'process raft request' (duration: 346.827275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:58.325109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:57.977755Z","time spent":"347.310017ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:17:58.325176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:57.977987Z","time spent":"347.113853ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:58.324888Z","caller":"traceutil/trace.go:171","msg":"trace[710438049] linearizableReadLoop","detail":"{readStateIndex:1404; appliedIndex:1401; }","duration":"316.26643ms","start":"2026-05-19T19:17:58.008603Z","end":"2026-05-19T19:17:58.32487Z","steps":["trace[710438049] 'read index received' (duration: 120.760252ms)","trace[710438049] 'applied index is now lower than readState.Index' (duration: 195.505098ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:17:58.325243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.64185ms","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:536"} {"level":"warn","ts":"2026-05-19T19:17:58.325052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:57.977573Z","time spent":"347.318158ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:17:58.325428Z","caller":"traceutil/trace.go:171","msg":"trace[1073343721] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1351; }","duration":"316.765272ms","start":"2026-05-19T19:17:58.008562Z","end":"2026-05-19T19:17:58.325327Z","steps":["trace[1073343721] 'agreement among raft nodes before linearized reading' (duration: 316.492536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:58.325651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:17:58.00855Z","time spent":"317.086881ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":560,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-19T19:17:58.325748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.478594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:17:58.325852Z","caller":"traceutil/trace.go:171","msg":"trace[723311563] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1352; }","duration":"122.628467ms","start":"2026-05-19T19:17:58.203199Z","end":"2026-05-19T19:17:58.325827Z","steps":["trace[723311563] 'agreement among raft nodes before linearized reading' (duration: 122.454983ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:17:58.32632Z","caller":"traceutil/trace.go:171","msg":"trace[565041538] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"105.282159ms","start":"2026-05-19T19:17:58.221014Z","end":"2026-05-19T19:17:58.326296Z","steps":["trace[565041538] 'process raft request' (duration: 104.50388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:17:58.326352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.183923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-05-19T19:17:58.326407Z","caller":"traceutil/trace.go:171","msg":"trace[104049140] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1352; }","duration":"102.245944ms","start":"2026-05-19T19:17:58.224143Z","end":"2026-05-19T19:17:58.326389Z","steps":["trace[104049140] 'agreement among raft nodes before linearized reading' (duration: 102.06723ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:20:10.420945Z","caller":"traceutil/trace.go:171","msg":"trace[1945341680] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"112.616711ms","start":"2026-05-19T19:20:10.308291Z","end":"2026-05-19T19:20:10.420908Z","steps":["trace[1945341680] 'process raft request' (duration: 112.391936ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:21:17.495071Z","caller":"traceutil/trace.go:171","msg":"trace[723227750] transaction","detail":"{read_only:false; response_revision:2392; number_of_response:1; }","duration":"140.985159ms","start":"2026-05-19T19:21:17.354059Z","end":"2026-05-19T19:21:17.495044Z","steps":["trace[723227750] 'process raft request' (duration: 140.560819ms)"],"step_count":1}