{"level":"warn","ts":"2026-06-08T15:19:30.5999Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T15:19:30.600008Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-08T15:19:30.600097Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T15:19:30.600116Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-06-08T15:19:30.600138Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-08T15:19:30.601006Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-06-08T15:19:30.601145Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-08T15:19:30.606156Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.752527ms"} {"level":"info","ts":"2026-06-08T15:19:30.622077Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-06-08T15:19:30.622168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T15:19:30.622192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-06-08T15:19:30.622199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T15:19:30.622223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-06-08T15:19:30.622271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-06-08T15:19:30.629515Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T15:19:30.630813Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T15:19:30.632432Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-08T15:19:30.634304Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T15:19:30.634812Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-08T15:19:30.634865Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-08T15:19:30.634874Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-08T15:19:30.635025Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T15:19:30.635653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-06-08T15:19:30.637879Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-06-08T15:19:30.64144Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-08T15:19:30.641507Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-06-08T15:19:30.641621Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-06-08T15:19:30.641856Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T15:19:30.641967Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T15:19:31.523345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T15:19:31.523396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T15:19:31.523423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-06-08T15:19:31.523435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-06-08T15:19:31.52344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-06-08T15:19:31.523448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-06-08T15:19:31.523455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-06-08T15:19:31.524433Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T15:19:31.524459Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T15:19:31.524543Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T15:19:31.524564Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T15:19:31.524829Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T15:19:31.524918Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T15:19:31.52596Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T15:19:31.526051Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T15:19:31.526089Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T15:19:31.526154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-06-08T15:19:31.526556Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-08T15:19:49.308652Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270831461,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:19:49.809572Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270831461,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:19:49.835781Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.073020029s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-08T15:19:50.399163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.679746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:19:50.401288Z","caller":"traceutil/trace.go:171","msg":"trace[930032246] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"1.636917043s","start":"2026-06-08T15:19:48.762673Z","end":"2026-06-08T15:19:50.39959Z","steps":["trace[930032246] 'process raft request' (duration: 1.073308665s)","trace[930032246] 'compare' (duration: 562.552233ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:19:50.401499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:48.762659Z","time spent":"1.638735972s","remote":"127.0.0.1:54614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:19:50.580138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.678814ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:19:50.580252Z","caller":"traceutil/trace.go:171","msg":"trace[1842859318] linearizableReadLoop","detail":"{readStateIndex:392; appliedIndex:390; }","duration":"1.772183078s","start":"2026-06-08T15:19:48.80805Z","end":"2026-06-08T15:19:50.580234Z","steps":["trace[1842859318] 'read index received' (duration: 1.027941997s)","trace[1842859318] 'applied index is now lower than readState.Index' (duration: 744.239601ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:19:50.580384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.77232245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:19:50.580418Z","caller":"traceutil/trace.go:171","msg":"trace[1131530342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:377; }","duration":"1.772425432s","start":"2026-06-08T15:19:48.807984Z","end":"2026-06-08T15:19:50.580409Z","steps":["trace[1131530342] 'agreement among raft nodes before linearized reading' (duration: 1.772339211s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:50.580458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:48.807965Z","time spent":"1.772485894s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:19:50.580601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26558247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-08T15:19:50.580711Z","caller":"traceutil/trace.go:171","msg":"trace[841176030] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:377; }","duration":"1.265733593s","start":"2026-06-08T15:19:49.314954Z","end":"2026-06-08T15:19:50.580687Z","steps":["trace[841176030] 'agreement among raft nodes before linearized reading' (duration: 1.265513858s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:50.5808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:49.314938Z","time spent":"1.265848696s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T15:19:50.580874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.928958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T15:19:50.580971Z","caller":"traceutil/trace.go:171","msg":"trace[1170053094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:377; }","duration":"853.051071ms","start":"2026-06-08T15:19:49.727908Z","end":"2026-06-08T15:19:50.580959Z","steps":["trace[1170053094] 'agreement among raft nodes before linearized reading' (duration: 852.927438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:50.581084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:49.727897Z","time spent":"853.176033ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T15:19:50.58123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.244655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-08T15:19:50.581265Z","caller":"traceutil/trace.go:171","msg":"trace[737764549] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:377; }","duration":"398.306007ms","start":"2026-06-08T15:19:50.18295Z","end":"2026-06-08T15:19:50.581256Z","steps":["trace[737764549] 'agreement among raft nodes before linearized reading' (duration: 398.244536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:50.581356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.513529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-08T15:19:50.581438Z","caller":"traceutil/trace.go:171","msg":"trace[38039411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:377; }","duration":"966.645522ms","start":"2026-06-08T15:19:49.614773Z","end":"2026-06-08T15:19:50.581419Z","steps":["trace[38039411] 'agreement among raft nodes before linearized reading' (duration: 966.479738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:50.581486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:49.614754Z","time spent":"966.722204ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T15:19:50.581381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:50.182934Z","time spent":"398.43739ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T15:19:51.091179Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270831466,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:19:51.391824Z","caller":"traceutil/trace.go:171","msg":"trace[311578533] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"803.86676ms","start":"2026-06-08T15:19:50.587885Z","end":"2026-06-08T15:19:51.391752Z","steps":["trace[311578533] 'process raft request' (duration: 803.596834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:51.392056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:50.587868Z","time spent":"804.062835ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:19:51.392746Z","caller":"traceutil/trace.go:171","msg":"trace[805423086] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"803.587665ms","start":"2026-06-08T15:19:50.589125Z","end":"2026-06-08T15:19:51.392713Z","steps":["trace[805423086] 'process raft request' (duration: 803.418161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:51.393197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:50.589075Z","time spent":"803.773559ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:19:51.393393Z","caller":"traceutil/trace.go:171","msg":"trace[74178741] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:392; }","duration":"802.763835ms","start":"2026-06-08T15:19:50.590615Z","end":"2026-06-08T15:19:51.393379Z","steps":["trace[74178741] 'read index received' (duration: 800.922295ms)","trace[74178741] 'applied index is now lower than readState.Index' (duration: 1.84018ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:19:51.393176Z","caller":"traceutil/trace.go:171","msg":"trace[800861441] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"803.40371ms","start":"2026-06-08T15:19:50.589734Z","end":"2026-06-08T15:19:51.393138Z","steps":["trace[800861441] 'process raft request' (duration: 802.922169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:51.393479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:50.589722Z","time spent":"803.721238ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:19:51.393593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.949619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:19:51.393633Z","caller":"traceutil/trace.go:171","msg":"trace[1980090304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:381; }","duration":"803.051362ms","start":"2026-06-08T15:19:50.590569Z","end":"2026-06-08T15:19:51.39362Z","steps":["trace[1980090304] 'agreement among raft nodes before linearized reading' (duration: 802.866248ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:19:51.393691Z","caller":"traceutil/trace.go:171","msg":"trace[570655246] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"803.174154ms","start":"2026-06-08T15:19:50.590503Z","end":"2026-06-08T15:19:51.393677Z","steps":["trace[570655246] 'process raft request' (duration: 802.53067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:19:51.393709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:50.590554Z","time spent":"803.145784ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:19:51.393758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:19:50.590491Z","time spent":"803.228416ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:20:13.87281Z","caller":"traceutil/trace.go:171","msg":"trace[652931807] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"614.192728ms","start":"2026-06-08T15:20:13.25857Z","end":"2026-06-08T15:20:13.872762Z","steps":["trace[652931807] 'process raft request' (duration: 613.911292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:13.873151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.258542Z","time spent":"614.385914ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.100588Z","caller":"traceutil/trace.go:171","msg":"trace[1639909169] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"829.282738ms","start":"2026-06-08T15:20:13.271123Z","end":"2026-06-08T15:20:14.100405Z","steps":["trace[1639909169] 'process raft request' (duration: 828.999252ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.100809Z","caller":"traceutil/trace.go:171","msg":"trace[13047921] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"823.743174ms","start":"2026-06-08T15:20:13.277056Z","end":"2026-06-08T15:20:14.100799Z","steps":["trace[13047921] 'process raft request' (duration: 823.381016ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.100837Z","caller":"traceutil/trace.go:171","msg":"trace[1024678527] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"829.494353ms","start":"2026-06-08T15:20:13.271264Z","end":"2026-06-08T15:20:14.100758Z","steps":["trace[1024678527] 'process raft request' (duration: 829.016382ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.100863Z","caller":"traceutil/trace.go:171","msg":"trace[354665342] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"819.346465ms","start":"2026-06-08T15:20:13.281441Z","end":"2026-06-08T15:20:14.100788Z","steps":["trace[354665342] 'process raft request' (duration: 819.102839ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.100903Z","caller":"traceutil/trace.go:171","msg":"trace[2069209810] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"822.750801ms","start":"2026-06-08T15:20:13.277987Z","end":"2026-06-08T15:20:14.100738Z","steps":["trace[2069209810] 'process raft request' (duration: 822.495976ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.101035Z","caller":"traceutil/trace.go:171","msg":"trace[1721084309] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"623.11249ms","start":"2026-06-08T15:20:13.477913Z","end":"2026-06-08T15:20:14.101025Z","steps":["trace[1721084309] 'process raft request' (duration: 622.881505ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.100948Z","caller":"traceutil/trace.go:171","msg":"trace[1957454438] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:511; }","duration":"602.888326ms","start":"2026-06-08T15:20:13.498034Z","end":"2026-06-08T15:20:14.100922Z","steps":["trace[1957454438] 'read index received' (duration: 374.57735ms)","trace[1957454438] 'applied index is now lower than readState.Index' (duration: 228.309725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:20:14.101062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.271231Z","time spent":"829.715308ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:20:14.101065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.281427Z","time spent":"819.531458ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.101132Z","caller":"traceutil/trace.go:171","msg":"trace[1913606090] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"806.259512ms","start":"2026-06-08T15:20:13.294859Z","end":"2026-06-08T15:20:14.101118Z","steps":["trace[1913606090] 'process raft request' (duration: 805.813962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.101194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.294763Z","time spent":"806.407835ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:20:14.101153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.271095Z","time spent":"829.79837ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.100769Z","caller":"traceutil/trace.go:171","msg":"trace[274820869] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"827.828155ms","start":"2026-06-08T15:20:13.272924Z","end":"2026-06-08T15:20:14.100752Z","steps":["trace[274820869] 'process raft request' (duration: 827.408596ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.101208Z","caller":"traceutil/trace.go:171","msg":"trace[16456402] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"771.033981ms","start":"2026-06-08T15:20:13.330123Z","end":"2026-06-08T15:20:14.101157Z","steps":["trace[16456402] 'process raft request' (duration: 770.605421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.10109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.477897Z","time spent":"623.171221ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:20:14.101268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.277967Z","time spent":"823.083139ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.101382Z","caller":"traceutil/trace.go:171","msg":"trace[1605980560] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"372.342839ms","start":"2026-06-08T15:20:13.729023Z","end":"2026-06-08T15:20:14.101366Z","steps":["trace[1605980560] 'process raft request' (duration: 371.828718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.100979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.27704Z","time spent":"823.826695ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.100668Z","caller":"traceutil/trace.go:171","msg":"trace[1520460732] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"827.574179ms","start":"2026-06-08T15:20:13.273026Z","end":"2026-06-08T15:20:14.1006Z","steps":["trace[1520460732] 'process raft request' (duration: 827.356415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.101427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.330102Z","time spent":"771.224174ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:20:14.101532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.497309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-08T15:20:14.101559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.728987Z","time spent":"372.443952ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:20:14.101566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.273004Z","time spent":"828.535081ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:20:14.101279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.272879Z","time spent":"828.369827ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.101237Z","caller":"traceutil/trace.go:171","msg":"trace[1849998478] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"822.871734ms","start":"2026-06-08T15:20:13.278141Z","end":"2026-06-08T15:20:14.101013Z","steps":["trace[1849998478] 'process raft request' (duration: 822.371903ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.101572Z","caller":"traceutil/trace.go:171","msg":"trace[55125381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"603.54172ms","start":"2026-06-08T15:20:13.498019Z","end":"2026-06-08T15:20:14.101561Z","steps":["trace[55125381] 'agreement among raft nodes before linearized reading' (duration: 603.382276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.101788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.497954Z","time spent":"603.807296ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T15:20:14.101935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.278124Z","time spent":"823.59645ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:20:14.111323Z","caller":"traceutil/trace.go:171","msg":"trace[140952318] transaction","detail":"{read_only:false; number_of_response:1; response_revision:506; }","duration":"224.810087ms","start":"2026-06-08T15:20:13.8865Z","end":"2026-06-08T15:20:14.11131Z","steps":["trace[140952318] 'process raft request' (duration: 224.695015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.11138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.313628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-08T15:20:14.11148Z","caller":"traceutil/trace.go:171","msg":"trace[219251225] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"231.085179ms","start":"2026-06-08T15:20:13.880386Z","end":"2026-06-08T15:20:14.111471Z","steps":["trace[219251225] 'process raft request' (duration: 230.023595ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.111554Z","caller":"traceutil/trace.go:171","msg":"trace[1904669683] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"226.552986ms","start":"2026-06-08T15:20:13.884994Z","end":"2026-06-08T15:20:14.111547Z","steps":["trace[1904669683] 'process raft request' (duration: 225.578775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.111781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.574608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-08T15:20:14.112058Z","caller":"traceutil/trace.go:171","msg":"trace[1985793500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:506; }","duration":"604.41724ms","start":"2026-06-08T15:20:13.50702Z","end":"2026-06-08T15:20:14.111437Z","steps":["trace[1985793500] 'agreement among raft nodes before linearized reading' (duration: 604.255296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.112141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.507012Z","time spent":"605.088484ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T15:20:14.112737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.541245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T15:20:14.112849Z","caller":"traceutil/trace.go:171","msg":"trace[77370972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:506; }","duration":"605.732869ms","start":"2026-06-08T15:20:13.507097Z","end":"2026-06-08T15:20:14.11283Z","steps":["trace[77370972] 'agreement among raft nodes before linearized reading' (duration: 604.689106ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:14.112909Z","caller":"traceutil/trace.go:171","msg":"trace[76072036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"602.622359ms","start":"2026-06-08T15:20:13.509178Z","end":"2026-06-08T15:20:14.1118Z","steps":["trace[76072036] 'agreement among raft nodes before linearized reading' (duration: 602.554367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:14.112918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.507079Z","time spent":"605.829541ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T15:20:14.112968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:13.509171Z","time spent":"603.787254ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T15:20:20.310126Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270831868,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:20:20.423847Z","caller":"traceutil/trace.go:171","msg":"trace[1968234741] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"857.684405ms","start":"2026-06-08T15:20:19.566127Z","end":"2026-06-08T15:20:20.423812Z","steps":["trace[1968234741] 'process raft request' (duration: 856.640882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:20.424071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:19.566095Z","time spent":"857.858539ms","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036233,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:20:20.439896Z","caller":"traceutil/trace.go:171","msg":"trace[813785120] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"630.314851ms","start":"2026-06-08T15:20:19.80957Z","end":"2026-06-08T15:20:20.439885Z","steps":["trace[813785120] 'read index received' (duration: 612.539882ms)","trace[813785120] 'applied index is now lower than readState.Index' (duration: 17.774049ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:20:20.440128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.557977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:20.440155Z","caller":"traceutil/trace.go:171","msg":"trace[24560463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"630.633329ms","start":"2026-06-08T15:20:19.809515Z","end":"2026-06-08T15:20:20.440148Z","steps":["trace[24560463] 'agreement among raft nodes before linearized reading' (duration: 630.522406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:20.440261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:19.809495Z","time spent":"630.675729ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:20:20.44036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.674343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-08T15:20:20.440489Z","caller":"traceutil/trace.go:171","msg":"trace[1864002302] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"281.911349ms","start":"2026-06-08T15:20:20.158547Z","end":"2026-06-08T15:20:20.440459Z","steps":["trace[1864002302] 'agreement among raft nodes before linearized reading' (duration: 281.570761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:20.440592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.682178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T15:20:20.440625Z","caller":"traceutil/trace.go:171","msg":"trace[196354665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"246.725529ms","start":"2026-06-08T15:20:20.193893Z","end":"2026-06-08T15:20:20.440619Z","steps":["trace[196354665] 'agreement among raft nodes before linearized reading' (duration: 246.633187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:20.440746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.150863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-08T15:20:20.4417Z","caller":"traceutil/trace.go:171","msg":"trace[1470711329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"270.141016ms","start":"2026-06-08T15:20:20.171548Z","end":"2026-06-08T15:20:20.441689Z","steps":["trace[1470711329] 'agreement among raft nodes before linearized reading' (duration: 269.154983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:20.440512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.403622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T15:20:20.44282Z","caller":"traceutil/trace.go:171","msg":"trace[896207723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"252.750415ms","start":"2026-06-08T15:20:20.190058Z","end":"2026-06-08T15:20:20.442809Z","steps":["trace[896207723] 'agreement among raft nodes before linearized reading' (duration: 250.416322ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:21.358988Z","caller":"traceutil/trace.go:171","msg":"trace[1811605980] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"450.828953ms","start":"2026-06-08T15:20:20.908111Z","end":"2026-06-08T15:20:21.35894Z","steps":["trace[1811605980] 'process raft request' (duration: 448.549531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:21.359186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:20.908085Z","time spent":"451.002536ms","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:20:21.746602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.985401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:20:21.746734Z","caller":"traceutil/trace.go:171","msg":"trace[1287345440] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"226.694119ms","start":"2026-06-08T15:20:21.520017Z","end":"2026-06-08T15:20:21.746711Z","steps":["trace[1287345440] 'read index received' (duration: 62.211866ms)","trace[1287345440] 'applied index is now lower than readState.Index' (duration: 164.480853ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:20:21.74692Z","caller":"traceutil/trace.go:171","msg":"trace[1740341885] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"325.302824ms","start":"2026-06-08T15:20:21.42154Z","end":"2026-06-08T15:20:21.746843Z","steps":["trace[1740341885] 'process raft request' (duration: 160.938254ms)","trace[1740341885] 'compare' (duration: 160.798019ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:20:21.746994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.964095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ctm97\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-08T15:20:21.747031Z","caller":"traceutil/trace.go:171","msg":"trace[455487369] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ctm97; range_end:; response_count:1; response_revision:602; }","duration":"227.040557ms","start":"2026-06-08T15:20:21.519981Z","end":"2026-06-08T15:20:21.747022Z","steps":["trace[455487369] 'agreement among raft nodes before linearized reading' (duration: 226.780191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:21.747164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:21.421519Z","time spent":"325.514238ms","remote":"127.0.0.1:54814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:20:22.951499Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270831892,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:20:23.45211Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270831892,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:20:23.79787Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.616987763s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T15:20:23.84563Z","caller":"traceutil/trace.go:171","msg":"trace[1130881303] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"1.39510798s","start":"2026-06-08T15:20:22.450494Z","end":"2026-06-08T15:20:23.845602Z","steps":["trace[1130881303] 'read index received' (duration: 1.347574843s)","trace[1130881303] 'applied index is now lower than readState.Index' (duration: 47.530987ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:20:23.84578Z","caller":"traceutil/trace.go:171","msg":"trace[2016892263] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.666406651s","start":"2026-06-08T15:20:22.179334Z","end":"2026-06-08T15:20:23.84574Z","steps":["trace[2016892263] 'process raft request' (duration: 1.619369085s)","trace[2016892263] 'compare' (duration: 45.575293ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:20:23.845916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395425538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-08T15:20:23.84596Z","caller":"traceutil/trace.go:171","msg":"trace[634354964] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"1.395511819s","start":"2026-06-08T15:20:22.450437Z","end":"2026-06-08T15:20:23.845948Z","steps":["trace[634354964] 'agreement among raft nodes before linearized reading' (duration: 1.395341025s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:23.845991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:22.450416Z","time spent":"1.395566821s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T15:20:23.846026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392285748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T15:20:23.846161Z","caller":"traceutil/trace.go:171","msg":"trace[1808229874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"1.392537003s","start":"2026-06-08T15:20:22.453594Z","end":"2026-06-08T15:20:23.846131Z","steps":["trace[1808229874] 'agreement among raft nodes before linearized reading' (duration: 1.392227246s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:23.846128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391313766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-08T15:20:23.846222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:22.453557Z","time spent":"1.392654046s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T15:20:23.846237Z","caller":"traceutil/trace.go:171","msg":"trace[1899147439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"1.391461979s","start":"2026-06-08T15:20:22.454752Z","end":"2026-06-08T15:20:23.846214Z","steps":["trace[1899147439] 'agreement among raft nodes before linearized reading' (duration: 1.391151402s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:23.846084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391338907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-08T15:20:23.846287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:22.454746Z","time spent":"1.391532s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T15:20:23.846276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:22.179296Z","time spent":"1.666534274s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:20:23.846237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.512856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:23.846321Z","caller":"traceutil/trace.go:171","msg":"trace[145783734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"1.391601932s","start":"2026-06-08T15:20:22.454707Z","end":"2026-06-08T15:20:23.846309Z","steps":["trace[145783734] 'agreement among raft nodes before linearized reading' (duration: 1.391269425s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:23.846369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:22.454697Z","time spent":"1.391661643s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-08T15:20:23.846404Z","caller":"traceutil/trace.go:171","msg":"trace[930977689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"973.756282ms","start":"2026-06-08T15:20:22.872602Z","end":"2026-06-08T15:20:23.846359Z","steps":["trace[930977689] 'agreement among raft nodes before linearized reading' (duration: 973.342133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:23.846485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:22.87258Z","time spent":"973.886764ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T15:20:28.930128Z","caller":"traceutil/trace.go:171","msg":"trace[2126044819] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"132.337482ms","start":"2026-06-08T15:20:28.797754Z","end":"2026-06-08T15:20:28.930092Z","steps":["trace[2126044819] 'process raft request' (duration: 132.096507ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:37.527698Z","caller":"traceutil/trace.go:171","msg":"trace[1835643510] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"203.182222ms","start":"2026-06-08T15:20:37.324486Z","end":"2026-06-08T15:20:37.527668Z","steps":["trace[1835643510] 'process raft request' (duration: 202.992077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:39.921184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.182318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qr5b4\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-08T15:20:39.921309Z","caller":"traceutil/trace.go:171","msg":"trace[282330222] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qr5b4; range_end:; response_count:1; response_revision:769; }","duration":"292.402574ms","start":"2026-06-08T15:20:39.628882Z","end":"2026-06-08T15:20:39.921284Z","steps":["trace[282330222] 'range keys from in-memory index tree' (duration: 291.983604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:39.921552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.226195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-08T15:20:39.921711Z","caller":"traceutil/trace.go:171","msg":"trace[2087240385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:769; }","duration":"388.44747ms","start":"2026-06-08T15:20:39.533239Z","end":"2026-06-08T15:20:39.921686Z","steps":["trace[2087240385] 'range keys from in-memory index tree' (duration: 388.00666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:39.921776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.53322Z","time spent":"388.542952ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T15:20:40.830487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.243678ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:20:40.830837Z","caller":"traceutil/trace.go:171","msg":"trace[1764310609] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"904.836873ms","start":"2026-06-08T15:20:39.925982Z","end":"2026-06-08T15:20:40.830818Z","steps":["trace[1764310609] 'process raft request' (duration: 904.620798ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:40.830821Z","caller":"traceutil/trace.go:171","msg":"trace[1904333873] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"1.019581299s","start":"2026-06-08T15:20:39.811217Z","end":"2026-06-08T15:20:40.830798Z","steps":["trace[1904333873] 'read index received' (duration: 74.961473ms)","trace[1904333873] 'applied index is now lower than readState.Index' (duration: 944.616976ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:20:40.83097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.925956Z","time spent":"904.932705ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:20:40.85989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048653281s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.859999Z","caller":"traceutil/trace.go:171","msg":"trace[497313620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:770; }","duration":"1.048814354s","start":"2026-06-08T15:20:39.811147Z","end":"2026-06-08T15:20:40.859961Z","steps":["trace[497313620] 'agreement among raft nodes before linearized reading' (duration: 1.019798173s)","trace[497313620] 'range keys from in-memory index tree' (duration: 28.878298ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:20:40.860039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.811118Z","time spent":"1.048911867s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:20:40.861364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.328774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.86144Z","caller":"traceutil/trace.go:171","msg":"trace[1607691636] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:771; }","duration":"129.437666ms","start":"2026-06-08T15:20:40.731982Z","end":"2026-06-08T15:20:40.861419Z","steps":["trace[1607691636] 'agreement among raft nodes before linearized reading' (duration: 129.245822ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:40.861743Z","caller":"traceutil/trace.go:171","msg":"trace[1186439831] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"931.721627ms","start":"2026-06-08T15:20:39.929998Z","end":"2026-06-08T15:20:40.86172Z","steps":["trace[1186439831] 'process raft request' (duration: 929.725292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.861985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.854397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.86204Z","caller":"traceutil/trace.go:171","msg":"trace[1240172149] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:771; }","duration":"256.915528ms","start":"2026-06-08T15:20:40.605111Z","end":"2026-06-08T15:20:40.862026Z","steps":["trace[1240172149] 'agreement among raft nodes before linearized reading' (duration: 256.804186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.862282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.170957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:20:40.862316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.888056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.862368Z","caller":"traceutil/trace.go:171","msg":"trace[210029138] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:771; }","duration":"129.977417ms","start":"2026-06-08T15:20:40.732377Z","end":"2026-06-08T15:20:40.862355Z","steps":["trace[210029138] 'agreement among raft nodes before linearized reading' (duration: 129.892106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.86252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.071182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.862547Z","caller":"traceutil/trace.go:171","msg":"trace[525638730] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:771; }","duration":"257.167543ms","start":"2026-06-08T15:20:40.605368Z","end":"2026-06-08T15:20:40.862536Z","steps":["trace[525638730] 'agreement among raft nodes before linearized reading' (duration: 257.132563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.86252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.787284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-08T15:20:40.862648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.644879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.862669Z","caller":"traceutil/trace.go:171","msg":"trace[629467521] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:771; }","duration":"157.72462ms","start":"2026-06-08T15:20:40.704939Z","end":"2026-06-08T15:20:40.862664Z","steps":["trace[629467521] 'agreement among raft nodes before linearized reading' (duration: 157.681829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.86277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.808812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.862796Z","caller":"traceutil/trace.go:171","msg":"trace[589470697] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:771; }","duration":"157.873624ms","start":"2026-06-08T15:20:40.704917Z","end":"2026-06-08T15:20:40.862791Z","steps":["trace[589470697] 'agreement among raft nodes before linearized reading' (duration: 157.837823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.863288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.74431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-08T15:20:40.863309Z","caller":"traceutil/trace.go:171","msg":"trace[144390606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:771; }","duration":"928.803841ms","start":"2026-06-08T15:20:39.934501Z","end":"2026-06-08T15:20:40.863304Z","steps":["trace[144390606] 'agreement among raft nodes before linearized reading' (duration: 928.706028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.863323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.934487Z","time spent":"928.832482ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T15:20:40.864264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.138118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.86429Z","caller":"traceutil/trace.go:171","msg":"trace[1300120137] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:771; }","duration":"259.19248ms","start":"2026-06-08T15:20:40.605091Z","end":"2026-06-08T15:20:40.864283Z","steps":["trace[1300120137] 'agreement among raft nodes before linearized reading' (duration: 259.158679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.864729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.051795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T15:20:40.864744Z","caller":"traceutil/trace.go:171","msg":"trace[1704882107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:771; }","duration":"908.162847ms","start":"2026-06-08T15:20:39.956577Z","end":"2026-06-08T15:20:40.86474Z","steps":["trace[1704882107] 'agreement among raft nodes before linearized reading' (duration: 908.114686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.86476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.956564Z","time spent":"908.192488ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T15:20:40.864331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.929968Z","time spent":"931.967922ms","remote":"127.0.0.1:54614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:20:40.86493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.769381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-08T15:20:40.864945Z","caller":"traceutil/trace.go:171","msg":"trace[1286920253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"908.844032ms","start":"2026-06-08T15:20:39.956097Z","end":"2026-06-08T15:20:40.864941Z","steps":["trace[1286920253] 'agreement among raft nodes before linearized reading' (duration: 908.789141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.864957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.956064Z","time spent":"908.890574ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T15:20:40.865475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.226081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:20:40.862329Z","caller":"traceutil/trace.go:171","msg":"trace[1169330739] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:771; }","duration":"156.235628ms","start":"2026-06-08T15:20:40.706078Z","end":"2026-06-08T15:20:40.862313Z","steps":["trace[1169330739] 'agreement among raft nodes before linearized reading' (duration: 156.171246ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:40.865583Z","caller":"traceutil/trace.go:171","msg":"trace[1513534914] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:771; }","duration":"132.910703ms","start":"2026-06-08T15:20:40.732653Z","end":"2026-06-08T15:20:40.865564Z","steps":["trace[1513534914] 'agreement among raft nodes before linearized reading' (duration: 129.144969ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:20:40.869143Z","caller":"traceutil/trace.go:171","msg":"trace[777100972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:771; }","duration":"909.968489ms","start":"2026-06-08T15:20:39.952678Z","end":"2026-06-08T15:20:40.862646Z","steps":["trace[777100972] 'agreement among raft nodes before linearized reading' (duration: 909.616371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:20:40.869323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:20:39.952665Z","time spent":"916.622978ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T15:21:17.293986Z","caller":"traceutil/trace.go:171","msg":"trace[1886602996] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"188.053012ms","start":"2026-06-08T15:21:17.105839Z","end":"2026-06-08T15:21:17.293892Z","steps":["trace[1886602996] 'read index received' (duration: 187.903469ms)","trace[1886602996] 'applied index is now lower than readState.Index' (duration: 148.413µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:21:17.294028Z","caller":"traceutil/trace.go:171","msg":"trace[196764294] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"233.410707ms","start":"2026-06-08T15:21:17.060566Z","end":"2026-06-08T15:21:17.293977Z","steps":["trace[196764294] 'process raft request' (duration: 233.166342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:17.294303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.44768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-08T15:21:17.294326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.42121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T15:21:17.294371Z","caller":"traceutil/trace.go:171","msg":"trace[1676914291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:988; }","duration":"188.598304ms","start":"2026-06-08T15:21:17.105755Z","end":"2026-06-08T15:21:17.294353Z","steps":["trace[1676914291] 'agreement among raft nodes before linearized reading' (duration: 188.373549ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:17.294411Z","caller":"traceutil/trace.go:171","msg":"trace[1388094902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:988; }","duration":"184.557373ms","start":"2026-06-08T15:21:17.109832Z","end":"2026-06-08T15:21:17.29439Z","steps":["trace[1388094902] 'agreement among raft nodes before linearized reading' (duration: 184.365919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:17.294484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.810465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T15:21:17.294547Z","caller":"traceutil/trace.go:171","msg":"trace[1559077177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:988; }","duration":"183.892687ms","start":"2026-06-08T15:21:17.110639Z","end":"2026-06-08T15:21:17.294531Z","steps":["trace[1559077177] 'agreement among raft nodes before linearized reading' (duration: 183.708743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.106928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.33118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:21:18.107043Z","caller":"traceutil/trace.go:171","msg":"trace[1323564551] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"808.808217ms","start":"2026-06-08T15:21:17.298217Z","end":"2026-06-08T15:21:18.107025Z","steps":["trace[1323564551] 'process raft request' (duration: 424.298583ms)","trace[1323564551] 'compare' (duration: 383.90956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:21:18.107102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.298195Z","time spent":"808.880109ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:21:18.774287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.40293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:21:18.77497Z","caller":"traceutil/trace.go:171","msg":"trace[1485707186] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"1.476028124s","start":"2026-06-08T15:21:17.298904Z","end":"2026-06-08T15:21:18.774932Z","steps":["trace[1485707186] 'process raft request' (duration: 1.190848646s)","trace[1485707186] 'compare' (duration: 284.059212ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:21:18.775008Z","caller":"traceutil/trace.go:171","msg":"trace[1654427092] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"1.475341319s","start":"2026-06-08T15:21:17.299643Z","end":"2026-06-08T15:21:18.774984Z","steps":["trace[1654427092] 'process raft request' (duration: 1.475178706s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.775111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.299635Z","time spent":"1.475435821s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:21:18.775319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.29889Z","time spent":"1.476172317s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:21:18.775377Z","caller":"traceutil/trace.go:171","msg":"trace[533310498] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1030; }","duration":"1.125552291s","start":"2026-06-08T15:21:17.649795Z","end":"2026-06-08T15:21:18.775347Z","steps":["trace[533310498] 'read index received' (duration: 72.697554ms)","trace[533310498] 'applied index is now lower than readState.Index' (duration: 1.052853736s)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:21:18.775529Z","caller":"traceutil/trace.go:171","msg":"trace[821264681] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"1.47539109s","start":"2026-06-08T15:21:17.300126Z","end":"2026-06-08T15:21:18.775517Z","steps":["trace[821264681] 'process raft request' (duration: 1.474815287s)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:18.775591Z","caller":"traceutil/trace.go:171","msg":"trace[904042023] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"275.211773ms","start":"2026-06-08T15:21:18.500366Z","end":"2026-06-08T15:21:18.775578Z","steps":["trace[904042023] 'process raft request' (duration: 274.897386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.775706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.30012Z","time spent":"1.475480952s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:21:18.775811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126021151s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:21:18.775861Z","caller":"traceutil/trace.go:171","msg":"trace[355560578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"1.126109333s","start":"2026-06-08T15:21:17.649738Z","end":"2026-06-08T15:21:18.775847Z","steps":["trace[355560578] 'agreement among raft nodes before linearized reading' (duration: 1.126039821s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.775899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.649718Z","time spent":"1.126174054s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T15:21:18.887988Z","caller":"traceutil/trace.go:171","msg":"trace[595340445] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1035; }","duration":"112.511924ms","start":"2026-06-08T15:21:18.775446Z","end":"2026-06-08T15:21:18.887958Z","steps":["trace[595340445] 'read index received' (duration: 111.879499ms)","trace[595340445] 'applied index is now lower than readState.Index' (duration: 631.285µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:21:18.888145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.883556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:21:18.888179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080284456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:21:18.888212Z","caller":"traceutil/trace.go:171","msg":"trace[741798683] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:994; }","duration":"849.985269ms","start":"2026-06-08T15:21:18.038206Z","end":"2026-06-08T15:21:18.888191Z","steps":["trace[741798683] 'agreement among raft nodes before linearized reading' (duration: 849.873686ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:18.888232Z","caller":"traceutil/trace.go:171","msg":"trace[1262997347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"1.080402988s","start":"2026-06-08T15:21:17.807812Z","end":"2026-06-08T15:21:18.888215Z","steps":["trace[1262997347] 'agreement among raft nodes before linearized reading' (duration: 1.080291666s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.888231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004229296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:21:18.888197Z","caller":"traceutil/trace.go:171","msg":"trace[1296355475] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"285.120387ms","start":"2026-06-08T15:21:18.603049Z","end":"2026-06-08T15:21:18.888169Z","steps":["trace[1296355475] 'process raft request' (duration: 284.35581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.888308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.807791Z","time spent":"1.08048166s","remote":"127.0.0.1:54410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:21:18.88826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:18.03819Z","time spent":"850.06066ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-06-08T15:21:18.888304Z","caller":"traceutil/trace.go:171","msg":"trace[1132168226] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:994; }","duration":"1.004348429s","start":"2026-06-08T15:21:17.883941Z","end":"2026-06-08T15:21:18.88829Z","steps":["trace[1132168226] 'agreement among raft nodes before linearized reading' (duration: 1.004242647s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.888558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:17.883922Z","time spent":"1.004619245s","remote":"127.0.0.1:54750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-08T15:21:18.88887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.007655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T15:21:18.888959Z","caller":"traceutil/trace.go:171","msg":"trace[1195830067] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:994; }","duration":"837.134298ms","start":"2026-06-08T15:21:18.051775Z","end":"2026-06-08T15:21:18.888909Z","steps":["trace[1195830067] 'agreement among raft nodes before linearized reading' (duration: 836.249298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:18.889018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:18.051762Z","time spent":"837.24037ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-06-08T15:21:48.483897Z","caller":"traceutil/trace.go:171","msg":"trace[635965358] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"129.556189ms","start":"2026-06-08T15:21:48.354301Z","end":"2026-06-08T15:21:48.483857Z","steps":["trace[635965358] 'process raft request' (duration: 128.616928ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:49.037362Z","caller":"traceutil/trace.go:171","msg":"trace[736250186] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"100.111683ms","start":"2026-06-08T15:21:48.937211Z","end":"2026-06-08T15:21:49.037323Z","steps":["trace[736250186] 'process raft request' (duration: 99.933689ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:49.045377Z","caller":"traceutil/trace.go:171","msg":"trace[1652616089] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"103.190853ms","start":"2026-06-08T15:21:48.942156Z","end":"2026-06-08T15:21:49.045347Z","steps":["trace[1652616089] 'process raft request' (duration: 103.015609ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:49.045672Z","caller":"traceutil/trace.go:171","msg":"trace[858892161] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"101.513545ms","start":"2026-06-08T15:21:48.944097Z","end":"2026-06-08T15:21:49.04561Z","steps":["trace[858892161] 'process raft request' (duration: 101.217488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:50.297802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.010368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:21:50.297905Z","caller":"traceutil/trace.go:171","msg":"trace[1778497484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1093; }","duration":"482.182322ms","start":"2026-06-08T15:21:49.815699Z","end":"2026-06-08T15:21:50.297881Z","steps":["trace[1778497484] 'range keys from in-memory index tree' (duration: 481.858315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:50.297956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:49.815634Z","time spent":"482.312005ms","remote":"127.0.0.1:54410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:21:50.301973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.428827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-08T15:21:50.302064Z","caller":"traceutil/trace.go:171","msg":"trace[1117349190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1093; }","duration":"815.596932ms","start":"2026-06-08T15:21:49.486446Z","end":"2026-06-08T15:21:50.302043Z","steps":["trace[1117349190] 'range keys from in-memory index tree' (duration: 811.202381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:50.302102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:49.486417Z","time spent":"815.677403ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T15:21:50.533022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.27192ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:21:50.535773Z","caller":"traceutil/trace.go:171","msg":"trace[1963648454] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"221.773866ms","start":"2026-06-08T15:21:50.311769Z","end":"2026-06-08T15:21:50.533542Z","steps":["trace[1963648454] 'process raft request' (duration: 221.411717ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:21:53.234813Z","caller":"traceutil/trace.go:171","msg":"trace[827846906] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1149; }","duration":"423.326942ms","start":"2026-06-08T15:21:52.811451Z","end":"2026-06-08T15:21:53.234778Z","steps":["trace[827846906] 'read index received' (duration: 423.136348ms)","trace[827846906] 'applied index is now lower than readState.Index' (duration: 188.974µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:21:53.234918Z","caller":"traceutil/trace.go:171","msg":"trace[313404631] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"616.896199ms","start":"2026-06-08T15:21:52.617997Z","end":"2026-06-08T15:21:53.234893Z","steps":["trace[313404631] 'process raft request' (duration: 616.563141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:53.235036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.566217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:21:53.235075Z","caller":"traceutil/trace.go:171","msg":"trace[2025055159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1101; }","duration":"423.67476ms","start":"2026-06-08T15:21:52.811388Z","end":"2026-06-08T15:21:53.235063Z","steps":["trace[2025055159] 'agreement among raft nodes before linearized reading' (duration: 423.563607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:53.235065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:52.617971Z","time spent":"617.008081ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:21:53.23511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:52.811367Z","time spent":"423.736411ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:21:53.425478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.725919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:21:53.425602Z","caller":"traceutil/trace.go:171","msg":"trace[1291649583] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1150; }","duration":"190.669252ms","start":"2026-06-08T15:21:53.234912Z","end":"2026-06-08T15:21:53.425581Z","steps":["trace[1291649583] 'read index received' (duration: 77.678207ms)","trace[1291649583] 'applied index is now lower than readState.Index' (duration: 112.989715ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:21:53.425729Z","caller":"traceutil/trace.go:171","msg":"trace[1608338503] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"416.12717ms","start":"2026-06-08T15:21:53.009588Z","end":"2026-06-08T15:21:53.425715Z","steps":["trace[1608338503] 'process raft request' (duration: 303.060773ms)","trace[1608338503] 'compare' (duration: 112.592236ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:21:53.425811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:21:53.009557Z","time spent":"416.213622ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:21:53.42608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.732104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T15:21:53.426117Z","caller":"traceutil/trace.go:171","msg":"trace[1916464995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1102; }","duration":"233.799926ms","start":"2026-06-08T15:21:53.192307Z","end":"2026-06-08T15:21:53.426107Z","steps":["trace[1916464995] 'agreement among raft nodes before linearized reading' (duration: 233.646033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:53.426312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.571518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-08T15:21:53.426524Z","caller":"traceutil/trace.go:171","msg":"trace[575483023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1102; }","duration":"255.828654ms","start":"2026-06-08T15:21:53.170669Z","end":"2026-06-08T15:21:53.426497Z","steps":["trace[575483023] 'agreement among raft nodes before linearized reading' (duration: 255.435245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:53.426858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.847193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-08T15:21:53.426971Z","caller":"traceutil/trace.go:171","msg":"trace[92409298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"255.009566ms","start":"2026-06-08T15:21:53.171938Z","end":"2026-06-08T15:21:53.426948Z","steps":["trace[92409298] 'agreement among raft nodes before linearized reading' (duration: 254.675078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:21:53.42724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.860113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:21:53.427311Z","caller":"traceutil/trace.go:171","msg":"trace[2085476675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1102; }","duration":"189.971256ms","start":"2026-06-08T15:21:53.237329Z","end":"2026-06-08T15:21:53.4273Z","steps":["trace[2085476675] 'agreement among raft nodes before linearized reading' (duration: 189.199258ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:07.684946Z","caller":"traceutil/trace.go:171","msg":"trace[470309260] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"132.71561ms","start":"2026-06-08T15:22:07.552196Z","end":"2026-06-08T15:22:07.684911Z","steps":["trace[470309260] 'read index received' (duration: 132.394693ms)","trace[470309260] 'applied index is now lower than readState.Index' (duration: 319.997µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:07.685083Z","caller":"traceutil/trace.go:171","msg":"trace[488160414] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"135.986984ms","start":"2026-06-08T15:22:07.549029Z","end":"2026-06-08T15:22:07.685016Z","steps":["trace[488160414] 'process raft request' (duration: 135.683288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:07.68529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.330171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-08T15:22:07.685299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.067778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-08T15:22:07.685358Z","caller":"traceutil/trace.go:171","msg":"trace[1078788423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1202; }","duration":"132.431894ms","start":"2026-06-08T15:22:07.552906Z","end":"2026-06-08T15:22:07.685338Z","steps":["trace[1078788423] 'agreement among raft nodes before linearized reading' (duration: 132.182328ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:07.685392Z","caller":"traceutil/trace.go:171","msg":"trace[1425764374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1202; }","duration":"133.203391ms","start":"2026-06-08T15:22:07.552166Z","end":"2026-06-08T15:22:07.68537Z","steps":["trace[1425764374] 'agreement among raft nodes before linearized reading' (duration: 132.910155ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:07.826992Z","caller":"traceutil/trace.go:171","msg":"trace[1442507881] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"137.487459ms","start":"2026-06-08T15:22:07.689463Z","end":"2026-06-08T15:22:07.826951Z","steps":["trace[1442507881] 'process raft request' (duration: 137.104371ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:07.827773Z","caller":"traceutil/trace.go:171","msg":"trace[2114748928] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"137.918019ms","start":"2026-06-08T15:22:07.689826Z","end":"2026-06-08T15:22:07.827744Z","steps":["trace[2114748928] 'process raft request' (duration: 137.606992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:10.825121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.878082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-08T15:22:10.825181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.605246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-08T15:22:10.825244Z","caller":"traceutil/trace.go:171","msg":"trace[1312359721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1208; }","duration":"994.076316ms","start":"2026-06-08T15:22:09.831133Z","end":"2026-06-08T15:22:10.825209Z","steps":["trace[1312359721] 'range keys from in-memory index tree' (duration: 993.623846ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:10.825287Z","caller":"traceutil/trace.go:171","msg":"trace[430760996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1208; }","duration":"993.79533ms","start":"2026-06-08T15:22:09.831465Z","end":"2026-06-08T15:22:10.82526Z","steps":["trace[430760996] 'range keys from in-memory index tree' (duration: 993.352149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:10.825306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:09.831108Z","time spent":"994.187199ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T15:22:10.825358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:09.831437Z","time spent":"993.909692ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T15:22:10.825363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134599455s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-08T15:22:10.825437Z","caller":"traceutil/trace.go:171","msg":"trace[1704275994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1208; }","duration":"1.134724368s","start":"2026-06-08T15:22:09.690696Z","end":"2026-06-08T15:22:10.82542Z","steps":["trace[1704275994] 'range keys from in-memory index tree' (duration: 1.13441474s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:10.825476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:09.690666Z","time spent":"1.134803209s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T15:22:10.825804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015052523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:10.825834Z","caller":"traceutil/trace.go:171","msg":"trace[1061760161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1208; }","duration":"1.015130285s","start":"2026-06-08T15:22:09.810696Z","end":"2026-06-08T15:22:10.825827Z","steps":["trace[1061760161] 'range keys from in-memory index tree' (duration: 1.0149204s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:10.825854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:09.81066Z","time spent":"1.015189036s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:22:10.946806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.094247ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:22:10.947148Z","caller":"traceutil/trace.go:171","msg":"trace[1570773974] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1262; }","duration":"289.129751ms","start":"2026-06-08T15:22:10.657986Z","end":"2026-06-08T15:22:10.947116Z","steps":["trace[1570773974] 'read index received' (duration: 26.99µs)","trace[1570773974] 'applied index is now lower than readState.Index' (duration: 289.101301ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:22:10.947396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.388147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-08T15:22:10.947461Z","caller":"traceutil/trace.go:171","msg":"trace[1312080142] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1208; }","duration":"289.51621ms","start":"2026-06-08T15:22:10.657929Z","end":"2026-06-08T15:22:10.947446Z","steps":["trace[1312080142] 'agreement among raft nodes before linearized reading' (duration: 289.309576ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:10.947695Z","caller":"traceutil/trace.go:171","msg":"trace[1198798536] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"117.800061ms","start":"2026-06-08T15:22:10.829866Z","end":"2026-06-08T15:22:10.947666Z","steps":["trace[1198798536] 'process raft request' (duration: 117.095174ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:10.950918Z","caller":"traceutil/trace.go:171","msg":"trace[1259471322] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"119.93279ms","start":"2026-06-08T15:22:10.83096Z","end":"2026-06-08T15:22:10.950893Z","steps":["trace[1259471322] 'process raft request' (duration: 116.688416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:10.951455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.214266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:10.951522Z","caller":"traceutil/trace.go:171","msg":"trace[1450397104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1211; }","duration":"124.296348ms","start":"2026-06-08T15:22:10.827209Z","end":"2026-06-08T15:22:10.951505Z","steps":["trace[1450397104] 'agreement among raft nodes before linearized reading' (duration: 124.140605ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:10.95268Z","caller":"traceutil/trace.go:171","msg":"trace[1806422603] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"116.569434ms","start":"2026-06-08T15:22:10.83608Z","end":"2026-06-08T15:22:10.952649Z","steps":["trace[1806422603] 'process raft request' (duration: 114.756172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.195304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.278471ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:22:27.195363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.358334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T15:22:27.195425Z","caller":"traceutil/trace.go:171","msg":"trace[1772978607] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1261; }","duration":"186.407883ms","start":"2026-06-08T15:22:27.008994Z","end":"2026-06-08T15:22:27.195402Z","steps":["trace[1772978607] 'range keys from in-memory index tree' (duration: 186.25977ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:27.195445Z","caller":"traceutil/trace.go:171","msg":"trace[329801906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1261; }","duration":"143.522978ms","start":"2026-06-08T15:22:27.051903Z","end":"2026-06-08T15:22:27.195426Z","steps":["trace[329801906] 'range keys from in-memory index tree' (duration: 143.134429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.195457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.081221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-08T15:22:27.195511Z","caller":"traceutil/trace.go:171","msg":"trace[349890745] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"148.143202ms","start":"2026-06-08T15:22:27.047345Z","end":"2026-06-08T15:22:27.195488Z","steps":["trace[349890745] 'range keys from in-memory index tree' (duration: 147.986839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.195359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.552828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-08T15:22:27.195628Z","caller":"traceutil/trace.go:171","msg":"trace[2140050514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1261; }","duration":"143.873425ms","start":"2026-06-08T15:22:27.051745Z","end":"2026-06-08T15:22:27.195618Z","steps":["trace[2140050514] 'range keys from in-memory index tree' (duration: 143.312133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.195759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.80081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-08T15:22:27.195873Z","caller":"traceutil/trace.go:171","msg":"trace[1191009924] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1261; }","duration":"142.984464ms","start":"2026-06-08T15:22:27.052863Z","end":"2026-06-08T15:22:27.195848Z","steps":["trace[1191009924] 'range keys from in-memory index tree' (duration: 142.506664ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:27.614596Z","caller":"traceutil/trace.go:171","msg":"trace[1214894938] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"488.522299ms","start":"2026-06-08T15:22:27.126041Z","end":"2026-06-08T15:22:27.614563Z","steps":["trace[1214894938] 'process raft request' (duration: 488.274624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.614879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:27.126012Z","time spent":"488.697863ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:22:27.870139Z","caller":"traceutil/trace.go:171","msg":"trace[1080252695] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1320; }","duration":"396.72669ms","start":"2026-06-08T15:22:27.473384Z","end":"2026-06-08T15:22:27.870111Z","steps":["trace[1080252695] 'read index received' (duration: 142.183887ms)","trace[1080252695] 'applied index is now lower than readState.Index' (duration: 254.541503ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:27.870144Z","caller":"traceutil/trace.go:171","msg":"trace[1863826154] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"667.963393ms","start":"2026-06-08T15:22:27.202073Z","end":"2026-06-08T15:22:27.870037Z","steps":["trace[1863826154] 'process raft request' (duration: 637.782147ms)","trace[1863826154] 'compare' (duration: 29.507631ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:27.870472Z","caller":"traceutil/trace.go:171","msg":"trace[1682905074] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"667.947383ms","start":"2026-06-08T15:22:27.20247Z","end":"2026-06-08T15:22:27.870417Z","steps":["trace[1682905074] 'process raft request' (duration: 667.585704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.870587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.1763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-08T15:22:27.870637Z","caller":"traceutil/trace.go:171","msg":"trace[1247459332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1266; }","duration":"397.302183ms","start":"2026-06-08T15:22:27.473322Z","end":"2026-06-08T15:22:27.870624Z","steps":["trace[1247459332] 'agreement among raft nodes before linearized reading' (duration: 397.130819ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:27.870667Z","caller":"traceutil/trace.go:171","msg":"trace[1507294623] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"668.502905ms","start":"2026-06-08T15:22:27.202148Z","end":"2026-06-08T15:22:27.870651Z","steps":["trace[1507294623] 'process raft request' (duration: 667.737457ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:27.870722Z","caller":"traceutil/trace.go:171","msg":"trace[184839458] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"668.490626ms","start":"2026-06-08T15:22:27.202216Z","end":"2026-06-08T15:22:27.870707Z","steps":["trace[184839458] 'process raft request' (duration: 667.790249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:27.870765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:27.202122Z","time spent":"668.599318ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:27.870668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:27.202431Z","time spent":"668.136948ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:27.870675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:27.473299Z","time spent":"397.366275ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T15:22:27.87078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:27.202166Z","time spent":"668.582618ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:27.870381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:27.202044Z","time spent":"668.22613ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:27.875087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.613592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:27.875145Z","caller":"traceutil/trace.go:171","msg":"trace[464555091] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"224.724975ms","start":"2026-06-08T15:22:27.650408Z","end":"2026-06-08T15:22:27.875133Z","steps":["trace[464555091] 'agreement among raft nodes before linearized reading' (duration: 224.618053ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:27.875463Z","caller":"traceutil/trace.go:171","msg":"trace[1578840357] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"224.50956ms","start":"2026-06-08T15:22:27.650942Z","end":"2026-06-08T15:22:27.875452Z","steps":["trace[1578840357] 'process raft request' (duration: 224.008019ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:28.039303Z","caller":"traceutil/trace.go:171","msg":"trace[1544652504] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"162.57074ms","start":"2026-06-08T15:22:27.87669Z","end":"2026-06-08T15:22:28.039261Z","steps":["trace[1544652504] 'process raft request' (duration: 103.869514ms)","trace[1544652504] 'compare' (duration: 58.554983ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:22:29.140322Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270833417,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:22:29.188547Z","caller":"traceutil/trace.go:171","msg":"trace[247044950] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"548.407323ms","start":"2026-06-08T15:22:28.640106Z","end":"2026-06-08T15:22:29.188513Z","steps":["trace[247044950] 'read index received' (duration: 548.063015ms)","trace[247044950] 'applied index is now lower than readState.Index' (duration: 343.108µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:29.188587Z","caller":"traceutil/trace.go:171","msg":"trace[722086718] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"574.169298ms","start":"2026-06-08T15:22:28.614366Z","end":"2026-06-08T15:22:29.188536Z","steps":["trace[722086718] 'process raft request' (duration: 573.927903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:29.188923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.781101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5330"} {"level":"warn","ts":"2026-06-08T15:22:29.188954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.738978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:29.188984Z","caller":"traceutil/trace.go:171","msg":"trace[520498018] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1270; }","duration":"548.924304ms","start":"2026-06-08T15:22:28.640046Z","end":"2026-06-08T15:22:29.18897Z","steps":["trace[520498018] 'agreement among raft nodes before linearized reading' (duration: 548.604537ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:29.189014Z","caller":"traceutil/trace.go:171","msg":"trace[1980609438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1270; }","duration":"378.306351ms","start":"2026-06-08T15:22:28.810691Z","end":"2026-06-08T15:22:29.188998Z","steps":["trace[1980609438] 'agreement among raft nodes before linearized reading' (duration: 378.190278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:29.189031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:28.64002Z","time spent":"549.001626ms","remote":"127.0.0.1:54612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5353,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-08T15:22:29.188954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:28.614332Z","time spent":"574.520236ms","remote":"127.0.0.1:54490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:22:29.1891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.587689ms","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-06-08T15:22:29.189139Z","caller":"traceutil/trace.go:171","msg":"trace[168664741] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1270; }","duration":"176.692672ms","start":"2026-06-08T15:22:29.012433Z","end":"2026-06-08T15:22:29.189126Z","steps":["trace[168664741] 'agreement among raft nodes before linearized reading' (duration: 176.64305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:29.189058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:28.810664Z","time spent":"378.387422ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:22:29.890072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.216375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:22:29.890216Z","caller":"traceutil/trace.go:171","msg":"trace[922238711] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1328; }","duration":"388.895582ms","start":"2026-06-08T15:22:29.501296Z","end":"2026-06-08T15:22:29.890192Z","steps":["trace[922238711] 'read index received' (duration: 74.822µs)","trace[922238711] 'applied index is now lower than readState.Index' (duration: 388.81928ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:29.890308Z","caller":"traceutil/trace.go:171","msg":"trace[1369169345] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"696.090005ms","start":"2026-06-08T15:22:29.194203Z","end":"2026-06-08T15:22:29.890293Z","steps":["trace[1369169345] 'process raft request' (duration: 246.563742ms)","trace[1369169345] 'compare' (duration: 448.515829ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:22:29.890379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:29.194188Z","time spent":"696.162656ms","remote":"127.0.0.1:54490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:22:29.890777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.483095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:29.890829Z","caller":"traceutil/trace.go:171","msg":"trace[1377173783] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1271; }","duration":"389.605348ms","start":"2026-06-08T15:22:29.501213Z","end":"2026-06-08T15:22:29.890818Z","steps":["trace[1377173783] 'agreement among raft nodes before linearized reading' (duration: 389.479186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:29.890866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:29.501182Z","time spent":"389.673199ms","remote":"127.0.0.1:54842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"warn","ts":"2026-06-08T15:22:29.943506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.667314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:29.943648Z","caller":"traceutil/trace.go:171","msg":"trace[993533425] 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:1272; }","duration":"311.891259ms","start":"2026-06-08T15:22:29.63172Z","end":"2026-06-08T15:22:29.943612Z","steps":["trace[993533425] 'agreement among raft nodes before linearized reading' (duration: 311.650514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:29.943715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:29.631699Z","time spent":"312.000482ms","remote":"127.0.0.1:44814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-08T15:22:29.944829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.444728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T15:22:29.944905Z","caller":"traceutil/trace.go:171","msg":"trace[1477673132] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1272; }","duration":"296.55224ms","start":"2026-06-08T15:22:29.648336Z","end":"2026-06-08T15:22:29.944888Z","steps":["trace[1477673132] 'agreement among raft nodes before linearized reading' (duration: 296.440467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:29.945274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.017467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:29.945397Z","caller":"traceutil/trace.go:171","msg":"trace[1820528616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"133.217451ms","start":"2026-06-08T15:22:29.81215Z","end":"2026-06-08T15:22:29.945368Z","steps":["trace[1820528616] 'agreement among raft nodes before linearized reading' (duration: 133.042207ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:30.099957Z","caller":"traceutil/trace.go:171","msg":"trace[1233459939] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"147.755992ms","start":"2026-06-08T15:22:29.952162Z","end":"2026-06-08T15:22:30.099918Z","steps":["trace[1233459939] 'process raft request' (duration: 126.976969ms)","trace[1233459939] 'compare' (duration: 20.409985ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:30.148608Z","caller":"traceutil/trace.go:171","msg":"trace[1614781111] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"193.176347ms","start":"2026-06-08T15:22:29.955383Z","end":"2026-06-08T15:22:30.14856Z","steps":["trace[1614781111] 'process raft request' (duration: 192.8913ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:30.148645Z","caller":"traceutil/trace.go:171","msg":"trace[1245484911] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1330; }","duration":"101.393508ms","start":"2026-06-08T15:22:30.047216Z","end":"2026-06-08T15:22:30.148609Z","steps":["trace[1245484911] 'read index received' (duration: 31.946847ms)","trace[1245484911] 'applied index is now lower than readState.Index' (duration: 69.445461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:22:30.148914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.673803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-08T15:22:30.148966Z","caller":"traceutil/trace.go:171","msg":"trace[1621233877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1276; }","duration":"101.824417ms","start":"2026-06-08T15:22:30.047129Z","end":"2026-06-08T15:22:30.148954Z","steps":["trace[1621233877] 'agreement among raft nodes before linearized reading' (duration: 101.603583ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:30.14908Z","caller":"traceutil/trace.go:171","msg":"trace[463163398] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"170.553742ms","start":"2026-06-08T15:22:29.978508Z","end":"2026-06-08T15:22:30.149061Z","steps":["trace[463163398] 'process raft request' (duration: 170.04119ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:30.149122Z","caller":"traceutil/trace.go:171","msg":"trace[1697786024] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"193.488824ms","start":"2026-06-08T15:22:29.955583Z","end":"2026-06-08T15:22:30.149072Z","steps":["trace[1697786024] 'process raft request' (duration: 192.895251ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:32.086546Z","caller":"traceutil/trace.go:171","msg":"trace[2143658633] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"134.913552ms","start":"2026-06-08T15:22:31.951572Z","end":"2026-06-08T15:22:32.086486Z","steps":["trace[2143658633] 'process raft request' (duration: 134.606095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:44.690584Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270833624,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:22:45.191911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219122277270833624,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:22:45.324963Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.195759447s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T15:22:45.325407Z","caller":"traceutil/trace.go:171","msg":"trace[2044535037] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1439; }","duration":"1.135627927s","start":"2026-06-08T15:22:44.189752Z","end":"2026-06-08T15:22:45.32538Z","steps":["trace[2044535037] 'read index received' (duration: 1.135365351s)","trace[2044535037] 'applied index is now lower than readState.Index' (duration: 261.546µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:22:45.325535Z","caller":"traceutil/trace.go:171","msg":"trace[1342437461] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"1.196447253s","start":"2026-06-08T15:22:44.129062Z","end":"2026-06-08T15:22:45.325509Z","steps":["trace[1342437461] 'process raft request' (duration: 1.196123385s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.325702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135949686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T15:22:45.32575Z","caller":"traceutil/trace.go:171","msg":"trace[634875958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1379; }","duration":"1.136103329s","start":"2026-06-08T15:22:44.18963Z","end":"2026-06-08T15:22:45.325734Z","steps":["trace[634875958] 'agreement among raft nodes before linearized reading' (duration: 1.135882404s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.325854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.929755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:22:45.325783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.189596Z","time spent":"1.136179501s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-08T15:22:45.325994Z","caller":"traceutil/trace.go:171","msg":"trace[680947658] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1379; }","duration":"828.17328ms","start":"2026-06-08T15:22:44.497791Z","end":"2026-06-08T15:22:45.325964Z","steps":["trace[680947658] 'agreement among raft nodes before linearized reading' (duration: 827.913554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.326002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102833071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-06-08T15:22:45.326019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.860899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-06-08T15:22:45.326051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.877279ms","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:524"} {"level":"warn","ts":"2026-06-08T15:22:45.326062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.497759Z","time spent":"828.290243ms","remote":"127.0.0.1:54842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-06-08T15:22:45.326068Z","caller":"traceutil/trace.go:171","msg":"trace[655421256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1379; }","duration":"1.102927724s","start":"2026-06-08T15:22:44.223125Z","end":"2026-06-08T15:22:45.326052Z","steps":["trace[655421256] 'agreement among raft nodes before linearized reading' (duration: 1.102688779s)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:45.326074Z","caller":"traceutil/trace.go:171","msg":"trace[943130617] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1379; }","duration":"608.969921ms","start":"2026-06-08T15:22:44.717089Z","end":"2026-06-08T15:22:45.326059Z","steps":["trace[943130617] 'agreement among raft nodes before linearized reading' (duration: 608.870659ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:45.326105Z","caller":"traceutil/trace.go:171","msg":"trace[252132834] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1379; }","duration":"264.952881ms","start":"2026-06-08T15:22:45.061134Z","end":"2026-06-08T15:22:45.326087Z","steps":["trace[252132834] 'agreement among raft nodes before linearized reading' (duration: 264.819978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.326108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.223117Z","time spent":"1.102983395s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T15:22:45.326111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.717053Z","time spent":"609.052483ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-08T15:22:45.325916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098821551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-08T15:22:45.326245Z","caller":"traceutil/trace.go:171","msg":"trace[126321901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1379; }","duration":"1.099168429s","start":"2026-06-08T15:22:44.227064Z","end":"2026-06-08T15:22:45.326232Z","steps":["trace[126321901] 'agreement among raft nodes before linearized reading' (duration: 1.098727739s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.32628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.227055Z","time spent":"1.0992142s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T15:22:45.326299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103526997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-08T15:22:45.326328Z","caller":"traceutil/trace.go:171","msg":"trace[1649436579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1379; }","duration":"1.103605399s","start":"2026-06-08T15:22:44.222712Z","end":"2026-06-08T15:22:45.326317Z","steps":["trace[1649436579] 'agreement among raft nodes before linearized reading' (duration: 1.103528477s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.326363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.222677Z","time spent":"1.103679751s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T15:22:45.325904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.92534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:45.326401Z","caller":"traceutil/trace.go:171","msg":"trace[2138292044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1379; }","duration":"515.500173ms","start":"2026-06-08T15:22:44.810895Z","end":"2026-06-08T15:22:45.326395Z","steps":["trace[2138292044] 'agreement among raft nodes before linearized reading' (duration: 514.853548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.326424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.810875Z","time spent":"515.543304ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:22:45.326434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.184199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-08T15:22:45.32647Z","caller":"traceutil/trace.go:171","msg":"trace[487468852] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:1379; }","duration":"708.263981ms","start":"2026-06-08T15:22:44.618196Z","end":"2026-06-08T15:22:45.32646Z","steps":["trace[487468852] 'agreement among raft nodes before linearized reading' (duration: 708.158179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.326498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.618175Z","time spent":"708.316492ms","remote":"127.0.0.1:54436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.35\" "} {"level":"warn","ts":"2026-06-08T15:22:45.326211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004223277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-08T15:22:45.325715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.129023Z","time spent":"1.196566716s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:22:45.326756Z","caller":"traceutil/trace.go:171","msg":"trace[1769422187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1379; }","duration":"1.00481505s","start":"2026-06-08T15:22:44.321922Z","end":"2026-06-08T15:22:45.326737Z","steps":["trace[1769422187] 'agreement among raft nodes before linearized reading' (duration: 1.003950331s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.32687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.321893Z","time spent":"1.004962814s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T15:22:45.32721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12513131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-08T15:22:45.32728Z","caller":"traceutil/trace.go:171","msg":"trace[2105694738] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1379; }","duration":"1.125202791s","start":"2026-06-08T15:22:44.20206Z","end":"2026-06-08T15:22:45.327262Z","steps":["trace[2105694738] 'agreement among raft nodes before linearized reading' (duration: 1.123563884s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.327315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:44.202014Z","time spent":"1.125293233s","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-08T15:22:45.632253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.328372Z","time spent":"303.872966ms","remote":"127.0.0.1:54436","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-08T15:22:45.63473Z","caller":"traceutil/trace.go:171","msg":"trace[432020990] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"303.106829ms","start":"2026-06-08T15:22:45.3316Z","end":"2026-06-08T15:22:45.634706Z","steps":["trace[432020990] 'process raft request' (duration: 302.905225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.634888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.331581Z","time spent":"303.202201ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:22:45.635077Z","caller":"traceutil/trace.go:171","msg":"trace[1173870430] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"303.220601ms","start":"2026-06-08T15:22:45.331835Z","end":"2026-06-08T15:22:45.635056Z","steps":["trace[1173870430] 'process raft request' (duration: 302.829413ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:45.635409Z","caller":"traceutil/trace.go:171","msg":"trace[76261130] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"303.159401ms","start":"2026-06-08T15:22:45.332225Z","end":"2026-06-08T15:22:45.635385Z","steps":["trace[76261130] 'process raft request' (duration: 302.743571ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:45.635519Z","caller":"traceutil/trace.go:171","msg":"trace[1998066053] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"302.338052ms","start":"2026-06-08T15:22:45.333155Z","end":"2026-06-08T15:22:45.635493Z","steps":["trace[1998066053] 'process raft request' (duration: 302.26329ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:45.635613Z","caller":"traceutil/trace.go:171","msg":"trace[1545970945] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"303.17763ms","start":"2026-06-08T15:22:45.332419Z","end":"2026-06-08T15:22:45.635597Z","steps":["trace[1545970945] 'process raft request' (duration: 302.960126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.635687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.333134Z","time spent":"302.463324ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:22:45.635666Z","caller":"traceutil/trace.go:171","msg":"trace[303370555] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"303.239242ms","start":"2026-06-08T15:22:45.332372Z","end":"2026-06-08T15:22:45.635611Z","steps":["trace[303370555] 'process raft request' (duration: 302.835933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.63571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.332413Z","time spent":"303.249162ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:22:45.635714Z","caller":"traceutil/trace.go:171","msg":"trace[1011220291] linearizableReadLoop","detail":"{readStateIndex:1449; appliedIndex:1440; }","duration":"284.579407ms","start":"2026-06-08T15:22:45.351103Z","end":"2026-06-08T15:22:45.635682Z","steps":["trace[1011220291] 'read index received' (duration: 278.065179ms)","trace[1011220291] 'applied index is now lower than readState.Index' (duration: 6.512938ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:22:45.635527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.332215Z","time spent":"303.248642ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:22:45.635879Z","caller":"traceutil/trace.go:171","msg":"trace[75786787] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"302.165348ms","start":"2026-06-08T15:22:45.333705Z","end":"2026-06-08T15:22:45.635871Z","steps":["trace[75786787] 'process raft request' (duration: 301.870771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.635886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.742141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:22:45.635699Z","caller":"traceutil/trace.go:171","msg":"trace[1190391755] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"302.28714ms","start":"2026-06-08T15:22:45.333399Z","end":"2026-06-08T15:22:45.635687Z","steps":["trace[1190391755] 'process raft request' (duration: 302.052035ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:22:45.635933Z","caller":"traceutil/trace.go:171","msg":"trace[157186402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1387; }","duration":"284.824303ms","start":"2026-06-08T15:22:45.351093Z","end":"2026-06-08T15:22:45.635917Z","steps":["trace[157186402] 'agreement among raft nodes before linearized reading' (duration: 284.71436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:22:45.635942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.333694Z","time spent":"302.215859ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:45.63593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.332364Z","time spent":"303.422326ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:45.635971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.333347Z","time spent":"302.584697ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:22:45.636895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T15:22:45.331825Z","time spent":"303.311414ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:25:47.074506Z","caller":"traceutil/trace.go:171","msg":"trace[1601174813] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"132.200396ms","start":"2026-06-08T15:25:46.942271Z","end":"2026-06-08T15:25:47.074472Z","steps":["trace[1601174813] 'process raft request' (duration: 132.043982ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:26:56.372541Z","caller":"traceutil/trace.go:171","msg":"trace[1179499562] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"134.209855ms","start":"2026-06-08T15:26:56.238306Z","end":"2026-06-08T15:26:56.372515Z","steps":["trace[1179499562] 'process raft request' (duration: 134.048751ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:26:56.376788Z","caller":"traceutil/trace.go:171","msg":"trace[950895267] transaction","detail":"{read_only:false; response_revision:2560; number_of_response:1; }","duration":"138.233756ms","start":"2026-06-08T15:26:56.238525Z","end":"2026-06-08T15:26:56.376759Z","steps":["trace[950895267] 'process raft request' (duration: 137.834557ms)"],"step_count":1}