{"level":"warn","ts":"2026-07-08T15:21:19.13745Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T15:21:19.137534Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.18:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.18:2380","--initial-cluster=instance=https://199.19.213.18:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.18:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.18: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-07-08T15:21:19.137597Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T15:21:19.137609Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-07-08T15:21:19.137681Z","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-07-08T15:21:19.138294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"]} {"level":"info","ts":"2026-07-08T15:21:19.138366Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.18: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-07-08T15:21:19.143475Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.905479ms"} {"level":"info","ts":"2026-07-08T15:21:19.152644Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d0358acb671c233","cluster-id":"ba212af698de913f"} {"level":"info","ts":"2026-07-08T15:21:19.152747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T15:21:19.152786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 0"} {"level":"info","ts":"2026-07-08T15:21:19.152813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d0358acb671c233 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T15:21:19.152837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 1"} {"level":"info","ts":"2026-07-08T15:21:19.152897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"warn","ts":"2026-07-08T15:21:19.164295Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T15:21:19.16581Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T15:21:19.166795Z","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-07-08T15:21:19.169237Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d0358acb671c233","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T15:21:19.169397Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d0358acb671c233","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T15:21:19.169601Z","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-07-08T15:21:19.169718Z","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-07-08T15:21:19.169762Z","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-07-08T15:21:19.173157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"info","ts":"2026-07-08T15:21:19.173552Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","added-peer-id":"6d0358acb671c233","added-peer-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-07-08T15:21:19.175687Z","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-07-08T15:21:19.175815Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-07-08T15:21:19.175855Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-07-08T15:21:19.176034Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d0358acb671c233","initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T15:21:19.176095Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T15:21:19.853246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T15:21:19.853322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T15:21:19.853378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgPreVoteResp from 6d0358acb671c233 at term 1"} {"level":"info","ts":"2026-07-08T15:21:19.853398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became candidate at term 2"} {"level":"info","ts":"2026-07-08T15:21:19.85341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgVoteResp from 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-07-08T15:21:19.853428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became leader at term 2"} {"level":"info","ts":"2026-07-08T15:21:19.853444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d0358acb671c233 elected leader 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-07-08T15:21:19.854528Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:21:19.85546Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T15:21:19.855461Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d0358acb671c233","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.18:2379]}","request-path":"/0/members/6d0358acb671c233/attributes","cluster-id":"ba212af698de913f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T15:21:19.855523Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T15:21:19.855905Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:21:19.855944Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T15:21:19.855962Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T15:21:19.856129Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:21:19.856194Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:21:19.85881Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.18:2379"} {"level":"info","ts":"2026-07-08T15:21:19.858942Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-08T15:21:42.336872Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993703574357816442,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:21:42.410306Z","caller":"traceutil/trace.go:171","msg":"trace[1672429259] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:397; }","duration":"573.432187ms","start":"2026-07-08T15:21:41.836807Z","end":"2026-07-08T15:21:42.410239Z","steps":["trace[1672429259] 'read index received' (duration: 573.194771ms)","trace[1672429259] 'applied index is now lower than readState.Index' (duration: 236.246µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:21:42.410417Z","caller":"traceutil/trace.go:171","msg":"trace[1847840420] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"591.675581ms","start":"2026-07-08T15:21:41.818686Z","end":"2026-07-08T15:21:42.410362Z","steps":["trace[1847840420] 'process raft request' (duration: 591.392903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:42.410579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.752435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T15:21:42.410724Z","caller":"traceutil/trace.go:171","msg":"trace[1518166314] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:383; }","duration":"573.904139ms","start":"2026-07-08T15:21:41.836767Z","end":"2026-07-08T15:21:42.410672Z","steps":["trace[1518166314] 'agreement among raft nodes before linearized reading' (duration: 573.729885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:42.410779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:41.836751Z","time spent":"574.012591ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:21:42.410581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.384608ms","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-07-08T15:21:42.411076Z","caller":"traceutil/trace.go:171","msg":"trace[1863081736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:383; }","duration":"564.88856ms","start":"2026-07-08T15:21:41.846132Z","end":"2026-07-08T15:21:42.41102Z","steps":["trace[1863081736] 'agreement among raft nodes before linearized reading' (duration: 564.385978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:42.41114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.02251ms","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-07-08T15:21:42.411651Z","caller":"traceutil/trace.go:171","msg":"trace[1722184140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:383; }","duration":"564.742897ms","start":"2026-07-08T15:21:41.846882Z","end":"2026-07-08T15:21:42.411625Z","steps":["trace[1722184140] 'agreement among raft nodes before linearized reading' (duration: 564.01554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:42.411333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:41.818652Z","time spent":"591.848275ms","remote":"127.0.0.1:49578","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-07-08T15:21:42.411737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:41.846862Z","time spent":"564.85623ms","remote":"127.0.0.1:49578","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-07-08T15:21:42.411604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:41.846104Z","time spent":"565.430434ms","remote":"127.0.0.1:49578","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-07-08T15:21:42.598464Z","caller":"traceutil/trace.go:171","msg":"trace[931381679] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"182.809784ms","start":"2026-07-08T15:21:42.41563Z","end":"2026-07-08T15:21:42.59844Z","steps":["trace[931381679] 'process raft request' (duration: 182.63515ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:42.662136Z","caller":"traceutil/trace.go:171","msg":"trace[675973232] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"245.981585ms","start":"2026-07-08T15:21:42.416103Z","end":"2026-07-08T15:21:42.662085Z","steps":["trace[675973232] 'process raft request' (duration: 245.921503ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:42.662174Z","caller":"traceutil/trace.go:171","msg":"trace[1520313177] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"246.064757ms","start":"2026-07-08T15:21:42.416072Z","end":"2026-07-08T15:21:42.662137Z","steps":["trace[1520313177] 'process raft request' (duration: 245.77864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:42.998937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.905352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-08T15:21:42.999005Z","caller":"traceutil/trace.go:171","msg":"trace[854430133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:386; }","duration":"177.030205ms","start":"2026-07-08T15:21:42.821961Z","end":"2026-07-08T15:21:42.998992Z","steps":["trace[854430133] 'range keys from in-memory index tree' (duration: 176.767597ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.089766Z","caller":"traceutil/trace.go:171","msg":"trace[555017222] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"412.573284ms","start":"2026-07-08T15:21:58.677168Z","end":"2026-07-08T15:21:59.089741Z","steps":["trace[555017222] 'process raft request' (duration: 412.378739ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.090245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.677138Z","time spent":"413.049496ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:21:59.089953Z","caller":"traceutil/trace.go:171","msg":"trace[898814043] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:506; }","duration":"359.473258ms","start":"2026-07-08T15:21:58.730463Z","end":"2026-07-08T15:21:59.089936Z","steps":["trace[898814043] 'read index received' (duration: 359.466408ms)","trace[898814043] 'applied index is now lower than readState.Index' (duration: 5.69µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:21:59.090125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.646342ms","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-07-08T15:21:59.09058Z","caller":"traceutil/trace.go:171","msg":"trace[1307011107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:486; }","duration":"360.113103ms","start":"2026-07-08T15:21:58.730386Z","end":"2026-07-08T15:21:59.090499Z","steps":["trace[1307011107] 'agreement among raft nodes before linearized reading' (duration: 359.639412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.090655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.730367Z","time spent":"360.263367ms","remote":"127.0.0.1:49578","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-07-08T15:21:59.278257Z","caller":"traceutil/trace.go:171","msg":"trace[2123424144] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"440.608722ms","start":"2026-07-08T15:21:58.837616Z","end":"2026-07-08T15:21:59.278225Z","steps":["trace[2123424144] 'process raft request' (duration: 440.424958ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.278278Z","caller":"traceutil/trace.go:171","msg":"trace[349089897] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"428.389446ms","start":"2026-07-08T15:21:58.849865Z","end":"2026-07-08T15:21:59.278254Z","steps":["trace[349089897] 'process raft request' (duration: 428.273703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.278381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.837584Z","time spent":"440.735686ms","remote":"127.0.0.1:49370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:21:59.278396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.849845Z","time spent":"428.495119ms","remote":"127.0.0.1:49370","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-07-08T15:21:59.278638Z","caller":"traceutil/trace.go:171","msg":"trace[1213433470] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"428.684413ms","start":"2026-07-08T15:21:58.849923Z","end":"2026-07-08T15:21:59.278607Z","steps":["trace[1213433470] 'process raft request' (duration: 428.239893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.278775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.849918Z","time spent":"428.806166ms","remote":"127.0.0.1:49370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:21:59.279135Z","caller":"traceutil/trace.go:171","msg":"trace[549190322] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"364.690494ms","start":"2026-07-08T15:21:58.914423Z","end":"2026-07-08T15:21:59.279114Z","steps":["trace[549190322] 'process raft request' (duration: 364.437127ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.279208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.914408Z","time spent":"364.766475ms","remote":"127.0.0.1:49370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:21:59.279245Z","caller":"traceutil/trace.go:171","msg":"trace[704991814] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"184.200061ms","start":"2026-07-08T15:21:59.095036Z","end":"2026-07-08T15:21:59.279236Z","steps":["trace[704991814] 'process raft request' (duration: 184.15346ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.279307Z","caller":"traceutil/trace.go:171","msg":"trace[1166125767] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"409.965809ms","start":"2026-07-08T15:21:58.869302Z","end":"2026-07-08T15:21:59.279268Z","steps":["trace[1166125767] 'process raft request' (duration: 409.432486ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.279277Z","caller":"traceutil/trace.go:171","msg":"trace[674656776] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"409.728024ms","start":"2026-07-08T15:21:58.869529Z","end":"2026-07-08T15:21:59.279257Z","steps":["trace[674656776] 'process raft request' (duration: 409.299044ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.279374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.869291Z","time spent":"410.044952ms","remote":"127.0.0.1:49370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:21:59.279383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.869524Z","time spent":"409.820286ms","remote":"127.0.0.1:49370","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-07-08T15:21:59.279401Z","caller":"traceutil/trace.go:171","msg":"trace[1807437005] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"341.820169ms","start":"2026-07-08T15:21:58.937576Z","end":"2026-07-08T15:21:59.279397Z","steps":["trace[1807437005] 'process raft request' (duration: 341.351028ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.27938Z","caller":"traceutil/trace.go:171","msg":"trace[1414737787] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"357.483369ms","start":"2026-07-08T15:21:58.921888Z","end":"2026-07-08T15:21:59.279372Z","steps":["trace[1414737787] 'process raft request' (duration: 357.004737ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.279482Z","caller":"traceutil/trace.go:171","msg":"trace[2102679750] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"226.346443ms","start":"2026-07-08T15:21:59.053127Z","end":"2026-07-08T15:21:59.279474Z","steps":["trace[2102679750] 'process raft request' (duration: 226.012755ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.279486Z","caller":"traceutil/trace.go:171","msg":"trace[1775260379] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:506; }","duration":"189.020348ms","start":"2026-07-08T15:21:59.090458Z","end":"2026-07-08T15:21:59.279479Z","steps":["trace[1775260379] 'read index received' (duration: 187.646775ms)","trace[1775260379] 'applied index is now lower than readState.Index' (duration: 1.372903ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:21:59.279506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.921864Z","time spent":"357.621301ms","remote":"127.0.0.1:49370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:21:59.279553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.478646ms","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-07-08T15:21:59.279462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.937547Z","time spent":"341.887751ms","remote":"127.0.0.1:49370","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-07-08T15:21:59.279573Z","caller":"traceutil/trace.go:171","msg":"trace[1126795701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"548.567377ms","start":"2026-07-08T15:21:58.731Z","end":"2026-07-08T15:21:59.279567Z","steps":["trace[1126795701] 'agreement among raft nodes before linearized reading' (duration: 548.503246ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.279582Z","caller":"traceutil/trace.go:171","msg":"trace[1405782117] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"339.305598ms","start":"2026-07-08T15:21:58.940269Z","end":"2026-07-08T15:21:59.279574Z","steps":["trace[1405782117] 'process raft request' (duration: 338.736835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.279593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.730974Z","time spent":"548.615859ms","remote":"127.0.0.1:49578","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-07-08T15:21:59.279625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.940242Z","time spent":"339.36225ms","remote":"127.0.0.1:49370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:21:59.27967Z","caller":"traceutil/trace.go:171","msg":"trace[324495761] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"331.156601ms","start":"2026-07-08T15:21:58.948503Z","end":"2026-07-08T15:21:59.27966Z","steps":["trace[324495761] 'process raft request' (duration: 330.552096ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.279725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.948489Z","time spent":"331.213043ms","remote":"127.0.0.1:49370","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-07-08T15:21:59.279747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.777384ms","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-07-08T15:21:59.279766Z","caller":"traceutil/trace.go:171","msg":"trace[2112106608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:499; }","duration":"193.833735ms","start":"2026-07-08T15:21:59.085927Z","end":"2026-07-08T15:21:59.27976Z","steps":["trace[2112106608] 'agreement among raft nodes before linearized reading' (duration: 193.749453ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:21:59.280198Z","caller":"traceutil/trace.go:171","msg":"trace[13686500] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"410.735718ms","start":"2026-07-08T15:21:58.869357Z","end":"2026-07-08T15:21:59.280093Z","steps":["trace[13686500] 'process raft request' (duration: 409.436297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:21:59.281464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:21:58.869354Z","time spent":"411.900447ms","remote":"127.0.0.1:49370","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-07-08T15:22:06.803421Z","caller":"traceutil/trace.go:171","msg":"trace[1239327184] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"310.319747ms","start":"2026-07-08T15:22:06.493077Z","end":"2026-07-08T15:22:06.803397Z","steps":["trace[1239327184] 'process raft request' (duration: 309.309943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:06.803699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:06.493049Z","time spent":"310.45897ms","remote":"127.0.0.1:49416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:22:07.951231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.535529ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:22:07.951346Z","caller":"traceutil/trace.go:171","msg":"trace[674049350] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"912.730419ms","start":"2026-07-08T15:22:07.038599Z","end":"2026-07-08T15:22:07.951329Z","steps":["trace[674049350] 'read index received' (duration: 83.804431ms)","trace[674049350] 'applied index is now lower than readState.Index' (duration: 828.924828ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:22:07.951429Z","caller":"traceutil/trace.go:171","msg":"trace[534730343] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.085283838s","start":"2026-07-08T15:22:06.866135Z","end":"2026-07-08T15:22:07.951419Z","steps":["trace[534730343] 'process raft request' (duration: 256.342229ms)","trace[534730343] 'compare' (duration: 828.390796ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:22:07.951475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:06.866115Z","time spent":"1.08533798s","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:22:07.951928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.329293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-49ql5\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-07-08T15:22:07.951892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.463642ms","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-07-08T15:22:07.951914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.163437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-08T15:22:07.951939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.320677ms","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-07-08T15:22:07.951967Z","caller":"traceutil/trace.go:171","msg":"trace[1343788088] range","detail":"{range_begin:/registry/pods/kube-system/cilium-49ql5; range_end:; response_count:1; response_revision:600; }","duration":"913.413765ms","start":"2026-07-08T15:22:07.038543Z","end":"2026-07-08T15:22:07.951957Z","steps":["trace[1343788088] 'agreement among raft nodes before linearized reading' (duration: 913.187679ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:07.95203Z","caller":"traceutil/trace.go:171","msg":"trace[1559160450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"829.612345ms","start":"2026-07-08T15:22:07.122359Z","end":"2026-07-08T15:22:07.951971Z","steps":["trace[1559160450] 'agreement among raft nodes before linearized reading' (duration: 829.251957ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:07.952036Z","caller":"traceutil/trace.go:171","msg":"trace[568274410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"599.4777ms","start":"2026-07-08T15:22:07.352538Z","end":"2026-07-08T15:22:07.952016Z","steps":["trace[568274410] 'agreement among raft nodes before linearized reading' (duration: 599.230344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:07.951966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.455188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:22:07.952066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.038524Z","time spent":"913.535537ms","remote":"127.0.0.1:49494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-49ql5\" "} {"level":"warn","ts":"2026-07-08T15:22:07.952083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.122337Z","time spent":"829.735738ms","remote":"127.0.0.1:49578","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-07-08T15:22:07.952087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.352506Z","time spent":"599.571583ms","remote":"127.0.0.1:49578","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-07-08T15:22:07.952115Z","caller":"traceutil/trace.go:171","msg":"trace[1584771361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"615.632442ms","start":"2026-07-08T15:22:07.336453Z","end":"2026-07-08T15:22:07.952085Z","steps":["trace[1584771361] 'agreement among raft nodes before linearized reading' (duration: 615.418677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:07.952166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.336441Z","time spent":"615.715614ms","remote":"127.0.0.1:49334","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-07-08T15:22:07.952201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.554589ms","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-07-08T15:22:07.952237Z","caller":"traceutil/trace.go:171","msg":"trace[1501572688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"634.628451ms","start":"2026-07-08T15:22:07.317599Z","end":"2026-07-08T15:22:07.952228Z","steps":["trace[1501572688] 'agreement among raft nodes before linearized reading' (duration: 634.526289ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:07.952039Z","caller":"traceutil/trace.go:171","msg":"trace[1126081350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"607.30119ms","start":"2026-07-08T15:22:07.344679Z","end":"2026-07-08T15:22:07.95198Z","steps":["trace[1126081350] 'agreement among raft nodes before linearized reading' (duration: 607.043284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:07.952292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.317573Z","time spent":"634.708514ms","remote":"127.0.0.1:49578","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-07-08T15:22:07.95235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.344666Z","time spent":"607.633178ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:22:08.459601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993703574357816867,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:22:08.859417Z","caller":"traceutil/trace.go:171","msg":"trace[1387520000] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"902.369957ms","start":"2026-07-08T15:22:07.957015Z","end":"2026-07-08T15:22:08.859385Z","steps":["trace[1387520000] 'process raft request' (duration: 818.444814ms)","trace[1387520000] 'compare' (duration: 83.579505ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:22:08.85958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.957003Z","time spent":"902.500841ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:22:09.231581Z","caller":"traceutil/trace.go:171","msg":"trace[473804045] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"1.272681047s","start":"2026-07-08T15:22:07.958859Z","end":"2026-07-08T15:22:09.23154Z","steps":["trace[473804045] 'process raft request' (duration: 1.272539913s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:09.231669Z","caller":"traceutil/trace.go:171","msg":"trace[1699183272] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.272500073s","start":"2026-07-08T15:22:07.959115Z","end":"2026-07-08T15:22:09.231615Z","steps":["trace[1699183272] 'process raft request' (duration: 1.272328418s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:09.231732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.958848Z","time spent":"1.27281093s","remote":"127.0.0.1:49578","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-07-08T15:22:09.231731Z","caller":"traceutil/trace.go:171","msg":"trace[979793786] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.268307671s","start":"2026-07-08T15:22:07.963385Z","end":"2026-07-08T15:22:09.231693Z","steps":["trace[979793786] 'process raft request' (duration: 1.268098006s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:09.231851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.959104Z","time spent":"1.272647386s","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:22:09.231886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.963356Z","time spent":"1.268447415s","remote":"127.0.0.1:49494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:22:09.231881Z","caller":"traceutil/trace.go:171","msg":"trace[513432844] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.273555509s","start":"2026-07-08T15:22:07.958314Z","end":"2026-07-08T15:22:09.231869Z","steps":["trace[513432844] 'process raft request' (duration: 1.272911763s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:09.232011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.958287Z","time spent":"1.273664982s","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:22:09.236605Z","caller":"traceutil/trace.go:171","msg":"trace[438086244] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:625; }","duration":"1.278085219s","start":"2026-07-08T15:22:07.958502Z","end":"2026-07-08T15:22:09.236587Z","steps":["trace[438086244] 'read index received' (duration: 817.056972ms)","trace[438086244] 'applied index is now lower than readState.Index' (duration: 461.027037ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:22:09.236817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.278316324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-08T15:22:09.23686Z","caller":"traceutil/trace.go:171","msg":"trace[877184947] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:605; }","duration":"1.278389176s","start":"2026-07-08T15:22:07.958461Z","end":"2026-07-08T15:22:09.23685Z","steps":["trace[877184947] 'agreement among raft nodes before linearized reading' (duration: 1.278293334s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:09.236889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:07.958447Z","time spent":"1.278435107s","remote":"127.0.0.1:49522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-07-08T15:22:26.105328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.677797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-08T15:22:26.105421Z","caller":"traceutil/trace.go:171","msg":"trace[1108353353] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:765; }","duration":"699.81618ms","start":"2026-07-08T15:22:25.405584Z","end":"2026-07-08T15:22:26.1054Z","steps":["trace[1108353353] 'range keys from in-memory index tree' (duration: 699.503743ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:26.105464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:25.405562Z","time spent":"699.889933ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:22:26.105612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.864717ms","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-07-08T15:22:26.105715Z","caller":"traceutil/trace.go:171","msg":"trace[1119713134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:765; }","duration":"699.034291ms","start":"2026-07-08T15:22:25.40665Z","end":"2026-07-08T15:22:26.105684Z","steps":["trace[1119713134] 'range keys from in-memory index tree' (duration: 698.612111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:26.105736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.99863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-08T15:22:26.105776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:25.406631Z","time spent":"699.130883ms","remote":"127.0.0.1:49578","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-07-08T15:22:26.105846Z","caller":"traceutil/trace.go:171","msg":"trace[1204734296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:765; }","duration":"699.171424ms","start":"2026-07-08T15:22:25.406649Z","end":"2026-07-08T15:22:26.10582Z","steps":["trace[1204734296] 'range keys from in-memory index tree' (duration: 698.647752ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:22:26.105895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:22:25.406623Z","time spent":"699.262527ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T15:22:26.209013Z","caller":"traceutil/trace.go:171","msg":"trace[2103738881] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"221.337681ms","start":"2026-07-08T15:22:25.98764Z","end":"2026-07-08T15:22:26.208978Z","steps":["trace[2103738881] 'process raft request' (duration: 221.121106ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:26.214132Z","caller":"traceutil/trace.go:171","msg":"trace[331207316] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"103.790053ms","start":"2026-07-08T15:22:26.110321Z","end":"2026-07-08T15:22:26.214111Z","steps":["trace[331207316] 'process raft request' (duration: 103.192029ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:26.214284Z","caller":"traceutil/trace.go:171","msg":"trace[251382070] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"103.730002ms","start":"2026-07-08T15:22:26.110542Z","end":"2026-07-08T15:22:26.214272Z","steps":["trace[251382070] 'process raft request' (duration: 103.094177ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:22:26.214535Z","caller":"traceutil/trace.go:171","msg":"trace[1566392358] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"103.105417ms","start":"2026-07-08T15:22:26.111412Z","end":"2026-07-08T15:22:26.214517Z","steps":["trace[1566392358] 'process raft request' (duration: 102.253267ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:01.588509Z","caller":"traceutil/trace.go:171","msg":"trace[1575550745] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"424.537803ms","start":"2026-07-08T15:23:01.163952Z","end":"2026-07-08T15:23:01.58849Z","steps":["trace[1575550745] 'read index received' (duration: 424.43947ms)","trace[1575550745] 'applied index is now lower than readState.Index' (duration: 97.423µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:23:01.588548Z","caller":"traceutil/trace.go:171","msg":"trace[1870433173] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"450.605678ms","start":"2026-07-08T15:23:01.137928Z","end":"2026-07-08T15:23:01.588533Z","steps":["trace[1870433173] 'process raft request' (duration: 450.428543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:01.58864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.691007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T15:23:01.588663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:01.137902Z","time spent":"450.682051ms","remote":"127.0.0.1:49578","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-07-08T15:23:01.58867Z","caller":"traceutil/trace.go:171","msg":"trace[1062476259] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:982; }","duration":"424.782849ms","start":"2026-07-08T15:23:01.163877Z","end":"2026-07-08T15:23:01.58866Z","steps":["trace[1062476259] 'agreement among raft nodes before linearized reading' (duration: 424.713798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:01.588697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:01.16385Z","time spent":"424.837781ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-07-08T15:23:01.590356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.875623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:23:01.590388Z","caller":"traceutil/trace.go:171","msg":"trace[271359792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:983; }","duration":"253.938455ms","start":"2026-07-08T15:23:01.336441Z","end":"2026-07-08T15:23:01.590379Z","steps":["trace[271359792] 'agreement among raft nodes before linearized reading' (duration: 253.872893ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:12.076624Z","caller":"traceutil/trace.go:171","msg":"trace[1992713968] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"398.130201ms","start":"2026-07-08T15:23:11.678462Z","end":"2026-07-08T15:23:12.076592Z","steps":["trace[1992713968] 'process raft request' (duration: 397.964527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:12.07685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:11.67844Z","time spent":"398.280074ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:23:32.761277Z","caller":"traceutil/trace.go:171","msg":"trace[1242013181] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"424.719117ms","start":"2026-07-08T15:23:32.336533Z","end":"2026-07-08T15:23:32.761252Z","steps":["trace[1242013181] 'read index received' (duration: 424.502252ms)","trace[1242013181] 'applied index is now lower than readState.Index' (duration: 215.925µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:23:32.761423Z","caller":"traceutil/trace.go:171","msg":"trace[977467944] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"588.740459ms","start":"2026-07-08T15:23:32.172671Z","end":"2026-07-08T15:23:32.761411Z","steps":["trace[977467944] 'process raft request' (duration: 588.37062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:32.761525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:32.172645Z","time spent":"588.80457ms","remote":"127.0.0.1:49578","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-07-08T15:23:32.761653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.193253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:23:32.761732Z","caller":"traceutil/trace.go:171","msg":"trace[1227275797] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1082; }","duration":"194.335397ms","start":"2026-07-08T15:23:32.567377Z","end":"2026-07-08T15:23:32.761713Z","steps":["trace[1227275797] 'agreement among raft nodes before linearized reading' (duration: 194.206964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:32.761792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.050907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-08T15:23:32.76182Z","caller":"traceutil/trace.go:171","msg":"trace[905597494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"140.117617ms","start":"2026-07-08T15:23:32.621693Z","end":"2026-07-08T15:23:32.761811Z","steps":["trace[905597494] 'agreement among raft nodes before linearized reading' (duration: 140.043545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:32.762003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.453374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:23:32.762104Z","caller":"traceutil/trace.go:171","msg":"trace[1228811283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"425.614458ms","start":"2026-07-08T15:23:32.336473Z","end":"2026-07-08T15:23:32.762088Z","steps":["trace[1228811283] 'agreement among raft nodes before linearized reading' (duration: 425.228939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:32.762144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:32.336449Z","time spent":"425.682041ms","remote":"127.0.0.1:49334","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-07-08T15:23:33.20559Z","caller":"traceutil/trace.go:171","msg":"trace[1427205847] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"439.674307ms","start":"2026-07-08T15:23:32.765881Z","end":"2026-07-08T15:23:33.205555Z","steps":["trace[1427205847] 'process raft request' (duration: 424.163715ms)","trace[1427205847] 'compare' (duration: 14.794655ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:23:33.205751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:32.765864Z","time spent":"439.805479ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:23:33.234572Z","caller":"traceutil/trace.go:171","msg":"trace[88366894] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1127; }","duration":"114.235708ms","start":"2026-07-08T15:23:33.120308Z","end":"2026-07-08T15:23:33.234544Z","steps":["trace[88366894] 'read index received' (duration: 69.869925ms)","trace[88366894] 'applied index is now lower than readState.Index' (duration: 44.364993ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:23:33.234612Z","caller":"traceutil/trace.go:171","msg":"trace[200035440] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"468.680321ms","start":"2026-07-08T15:23:32.765912Z","end":"2026-07-08T15:23:33.234592Z","steps":["trace[200035440] 'process raft request' (duration: 468.473996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:33.234717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:32.765896Z","time spent":"468.766393ms","remote":"127.0.0.1:49578","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-07-08T15:23:33.234692Z","caller":"traceutil/trace.go:171","msg":"trace[468438818] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"468.691331ms","start":"2026-07-08T15:23:32.765958Z","end":"2026-07-08T15:23:33.23465Z","steps":["trace[468438818] 'process raft request' (duration: 468.550798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:33.234815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.490284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-08T15:23:33.234858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:32.765952Z","time spent":"468.819764ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:23:33.235018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.936322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.18\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-08T15:23:33.235054Z","caller":"traceutil/trace.go:171","msg":"trace[65489444] range","detail":"{range_begin:/registry/masterleases/199.19.213.18; range_end:; response_count:1; response_revision:1085; }","duration":"107.008384ms","start":"2026-07-08T15:23:33.128033Z","end":"2026-07-08T15:23:33.235042Z","steps":["trace[65489444] 'agreement among raft nodes before linearized reading' (duration: 106.923982ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:33.235377Z","caller":"traceutil/trace.go:171","msg":"trace[38982150] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1085; }","duration":"114.576766ms","start":"2026-07-08T15:23:33.120264Z","end":"2026-07-08T15:23:33.234841Z","steps":["trace[38982150] 'agreement among raft nodes before linearized reading' (duration: 114.407402ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:34.724172Z","caller":"traceutil/trace.go:171","msg":"trace[861464574] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"356.684248ms","start":"2026-07-08T15:23:34.367289Z","end":"2026-07-08T15:23:34.723973Z","steps":["trace[861464574] 'process raft request' (duration: 356.388811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:34.72433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:34.367264Z","time spent":"356.983055ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:23:36.127242Z","caller":"traceutil/trace.go:171","msg":"trace[1271146441] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"184.269046ms","start":"2026-07-08T15:23:35.942949Z","end":"2026-07-08T15:23:36.127218Z","steps":["trace[1271146441] 'process raft request' (duration: 184.051281ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:37.069572Z","caller":"traceutil/trace.go:171","msg":"trace[2035861825] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"165.175929ms","start":"2026-07-08T15:23:36.904371Z","end":"2026-07-08T15:23:37.069547Z","steps":["trace[2035861825] 'process raft request' (duration: 165.027025ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:37.272789Z","caller":"traceutil/trace.go:171","msg":"trace[752618530] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"118.556402ms","start":"2026-07-08T15:23:37.15415Z","end":"2026-07-08T15:23:37.272706Z","steps":["trace[752618530] 'process raft request' (duration: 118.258515ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:51.83046Z","caller":"traceutil/trace.go:171","msg":"trace[953193608] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1244; }","duration":"480.003202ms","start":"2026-07-08T15:23:51.350424Z","end":"2026-07-08T15:23:51.830427Z","steps":["trace[953193608] 'read index received' (duration: 479.687715ms)","trace[953193608] 'applied index is now lower than readState.Index' (duration: 314.357µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:23:51.830632Z","caller":"traceutil/trace.go:171","msg":"trace[1539399816] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"480.76068ms","start":"2026-07-08T15:23:51.349837Z","end":"2026-07-08T15:23:51.830598Z","steps":["trace[1539399816] 'process raft request' (duration: 480.389821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:51.830765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:51.349821Z","time spent":"480.878103ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:23:51.830824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.363171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T15:23:51.830873Z","caller":"traceutil/trace.go:171","msg":"trace[814546860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1194; }","duration":"480.459203ms","start":"2026-07-08T15:23:51.350399Z","end":"2026-07-08T15:23:51.830858Z","steps":["trace[814546860] 'agreement among raft nodes before linearized reading' (duration: 480.243688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:51.830917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:51.350389Z","time spent":"480.519364ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:23:51.831017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.207901ms","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-07-08T15:23:51.831086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.729739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-08T15:23:51.831123Z","caller":"traceutil/trace.go:171","msg":"trace[507395642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1194; }","duration":"432.817212ms","start":"2026-07-08T15:23:51.398298Z","end":"2026-07-08T15:23:51.831115Z","steps":["trace[507395642] 'agreement among raft nodes before linearized reading' (duration: 432.725309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:51.831151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:51.398264Z","time spent":"432.882634ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T15:23:51.831176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.15627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T15:23:51.831085Z","caller":"traceutil/trace.go:171","msg":"trace[65376920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1194; }","duration":"443.316603ms","start":"2026-07-08T15:23:51.38775Z","end":"2026-07-08T15:23:51.831067Z","steps":["trace[65376920] 'agreement among raft nodes before linearized reading' (duration: 442.991246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:51.83122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:51.387725Z","time spent":"443.488759ms","remote":"127.0.0.1:49578","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-07-08T15:23:51.831216Z","caller":"traceutil/trace.go:171","msg":"trace[932437305] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1194; }","duration":"433.243822ms","start":"2026-07-08T15:23:51.39796Z","end":"2026-07-08T15:23:51.831204Z","steps":["trace[932437305] 'agreement among raft nodes before linearized reading' (duration: 433.14661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:51.831254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:51.397935Z","time spent":"433.310774ms","remote":"127.0.0.1:49672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":55,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-07-08T15:23:53.64569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993703574357818243,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:23:53.90688Z","caller":"traceutil/trace.go:171","msg":"trace[1498748476] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1249; }","duration":"761.917385ms","start":"2026-07-08T15:23:53.144937Z","end":"2026-07-08T15:23:53.906854Z","steps":["trace[1498748476] 'read index received' (duration: 761.784382ms)","trace[1498748476] 'applied index is now lower than readState.Index' (duration: 131.933µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:23:53.907033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.130329Z","time spent":"776.700799ms","remote":"127.0.0.1:49360","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-08T15:23:53.907355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.392078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T15:23:53.907411Z","caller":"traceutil/trace.go:171","msg":"trace[1797966412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1198; }","duration":"762.485871ms","start":"2026-07-08T15:23:53.144914Z","end":"2026-07-08T15:23:53.9074Z","steps":["trace[1797966412] 'agreement among raft nodes before linearized reading' (duration: 762.307477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:53.907435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.144901Z","time spent":"762.529402ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T15:23:54.411818Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993703574357818247,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:23:54.545054Z","caller":"traceutil/trace.go:171","msg":"trace[705416514] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"636.89213ms","start":"2026-07-08T15:23:53.90813Z","end":"2026-07-08T15:23:54.545022Z","steps":["trace[705416514] 'process raft request' (duration: 634.256027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.545223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.908104Z","time spent":"637.027814ms","remote":"127.0.0.1:49360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:23:54.569367Z","caller":"traceutil/trace.go:171","msg":"trace[514010147] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"658.402152ms","start":"2026-07-08T15:23:53.910931Z","end":"2026-07-08T15:23:54.569334Z","steps":["trace[514010147] 'process raft request' (duration: 658.251188ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:54.569596Z","caller":"traceutil/trace.go:171","msg":"trace[1125313328] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"657.88525ms","start":"2026-07-08T15:23:53.911704Z","end":"2026-07-08T15:23:54.569589Z","steps":["trace[1125313328] 'process raft request' (duration: 657.738167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.569641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.911695Z","time spent":"657.91375ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:23:54.569657Z","caller":"traceutil/trace.go:171","msg":"trace[1471519465] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1250; }","duration":"657.909361ms","start":"2026-07-08T15:23:53.911727Z","end":"2026-07-08T15:23:54.569637Z","steps":["trace[1471519465] 'read index received' (duration: 630.862157ms)","trace[1471519465] 'applied index is now lower than readState.Index' (duration: 27.046304ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:23:54.569752Z","caller":"traceutil/trace.go:171","msg":"trace[302604486] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"376.294607ms","start":"2026-07-08T15:23:54.193448Z","end":"2026-07-08T15:23:54.569743Z","steps":["trace[302604486] 'process raft request' (duration: 376.119943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.56981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.066584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-08T15:23:54.569832Z","caller":"traceutil/trace.go:171","msg":"trace[2133326191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1203; }","duration":"658.107846ms","start":"2026-07-08T15:23:53.911719Z","end":"2026-07-08T15:23:54.569827Z","steps":["trace[2133326191] 'agreement among raft nodes before linearized reading' (duration: 658.032034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.56983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:54.193428Z","time spent":"376.341898ms","remote":"127.0.0.1:49578","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-07-08T15:23:54.56985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.911712Z","time spent":"658.133026ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T15:23:54.570009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.6574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:23:54.570028Z","caller":"traceutil/trace.go:171","msg":"trace[1529838398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1203; }","duration":"235.70456ms","start":"2026-07-08T15:23:54.334319Z","end":"2026-07-08T15:23:54.570024Z","steps":["trace[1529838398] 'agreement among raft nodes before linearized reading' (duration: 235.67506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.570022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.29107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T15:23:54.570052Z","caller":"traceutil/trace.go:171","msg":"trace[44098644] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1203; }","duration":"658.332211ms","start":"2026-07-08T15:23:53.911711Z","end":"2026-07-08T15:23:54.570043Z","steps":["trace[44098644] 'agreement among raft nodes before linearized reading' (duration: 658.225888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.570085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.911701Z","time spent":"658.377472ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:23:54.570191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.33989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:23:54.570238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.910914Z","time spent":"658.599737ms","remote":"127.0.0.1:49578","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-07-08T15:23:54.570253Z","caller":"traceutil/trace.go:171","msg":"trace[2064006234] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1203; }","duration":"458.453222ms","start":"2026-07-08T15:23:54.111787Z","end":"2026-07-08T15:23:54.57024Z","steps":["trace[2064006234] 'agreement among raft nodes before linearized reading' (duration: 458.35795ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:23:54.569476Z","caller":"traceutil/trace.go:171","msg":"trace[6219685] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"658.108985ms","start":"2026-07-08T15:23:53.911361Z","end":"2026-07-08T15:23:54.56947Z","steps":["trace[6219685] 'process raft request' (duration: 657.946311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:23:54.570282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:54.111766Z","time spent":"458.509663ms","remote":"127.0.0.1:49582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-07-08T15:23:54.570302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:23:53.911351Z","time spent":"658.936884ms","remote":"127.0.0.1:49578","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-07-08T15:24:08.800612Z","caller":"traceutil/trace.go:171","msg":"trace[1872414494] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"137.735408ms","start":"2026-07-08T15:24:08.662855Z","end":"2026-07-08T15:24:08.800591Z","steps":["trace[1872414494] 'process raft request' (duration: 137.685477ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:08.800847Z","caller":"traceutil/trace.go:171","msg":"trace[644914664] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"138.169978ms","start":"2026-07-08T15:24:08.662667Z","end":"2026-07-08T15:24:08.800837Z","steps":["trace[644914664] 'process raft request' (duration: 135.918174ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:12.28681Z","caller":"traceutil/trace.go:171","msg":"trace[1466728504] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"180.265702ms","start":"2026-07-08T15:24:12.106507Z","end":"2026-07-08T15:24:12.286773Z","steps":["trace[1466728504] 'process raft request' (duration: 180.118508ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:12.409559Z","caller":"traceutil/trace.go:171","msg":"trace[8850528] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"116.596264ms","start":"2026-07-08T15:24:12.29294Z","end":"2026-07-08T15:24:12.409536Z","steps":["trace[8850528] 'process raft request' (duration: 83.563419ms)","trace[8850528] 'compare' (duration: 32.683877ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:24:13.144691Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993703574357818420,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:24:13.228994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.774723Z","time spent":"454.262333ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-08T15:24:13.229523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.893209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-85tgq\" ","response":"range_response_count:1 size:11057"} {"level":"info","ts":"2026-07-08T15:24:13.229582Z","caller":"traceutil/trace.go:171","msg":"trace[966608956] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-85tgq; range_end:; response_count:1; response_revision:1274; }","duration":"696.988051ms","start":"2026-07-08T15:24:12.532575Z","end":"2026-07-08T15:24:13.229563Z","steps":["trace[966608956] 'range keys from in-memory index tree' (duration: 696.700044ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.229623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.532562Z","time spent":"697.052523ms","remote":"127.0.0.1:49494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11080,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-85tgq\" "} {"level":"info","ts":"2026-07-08T15:24:13.230398Z","caller":"traceutil/trace.go:171","msg":"trace[67865635] linearizableReadLoop","detail":"{readStateIndex:1330; appliedIndex:1329; }","duration":"586.628364ms","start":"2026-07-08T15:24:12.643754Z","end":"2026-07-08T15:24:13.230383Z","steps":["trace[67865635] 'read index received' (duration: 539.00203ms)","trace[67865635] 'applied index is now lower than readState.Index' (duration: 47.625234ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:13.230625Z","caller":"traceutil/trace.go:171","msg":"trace[1834350437] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"605.244457ms","start":"2026-07-08T15:24:12.625362Z","end":"2026-07-08T15:24:13.230606Z","steps":["trace[1834350437] 'process raft request' (duration: 557.417868ms)","trace[1834350437] 'compare' (duration: 46.206511ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:24:13.231062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.137043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T15:24:13.231113Z","caller":"traceutil/trace.go:171","msg":"trace[447213434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1275; }","duration":"586.201865ms","start":"2026-07-08T15:24:12.6449Z","end":"2026-07-08T15:24:13.231102Z","steps":["trace[447213434] 'agreement among raft nodes before linearized reading' (duration: 586.065381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.231151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.644894Z","time spent":"586.248876ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:24:13.231203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.625335Z","time spent":"605.34117ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:24:13.231316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.805485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.18\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-08T15:24:13.231348Z","caller":"traceutil/trace.go:171","msg":"trace[297817370] range","detail":"{range_begin:/registry/masterleases/199.19.213.18; range_end:; response_count:1; response_revision:1275; }","duration":"101.864125ms","start":"2026-07-08T15:24:13.129474Z","end":"2026-07-08T15:24:13.231338Z","steps":["trace[297817370] 'agreement among raft nodes before linearized reading' (duration: 101.768873ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.231377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.023907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-08T15:24:13.231404Z","caller":"traceutil/trace.go:171","msg":"trace[185736219] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1275; }","duration":"417.075629ms","start":"2026-07-08T15:24:12.814322Z","end":"2026-07-08T15:24:13.231398Z","steps":["trace[185736219] 'agreement among raft nodes before linearized reading' (duration: 416.970826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.231425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.814308Z","time spent":"417.113439ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T15:24:13.231575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.844701ms","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-07-08T15:24:13.231617Z","caller":"traceutil/trace.go:171","msg":"trace[814335856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"560.920912ms","start":"2026-07-08T15:24:12.670687Z","end":"2026-07-08T15:24:13.231608Z","steps":["trace[814335856] 'agreement among raft nodes before linearized reading' (duration: 560.808209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.231643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.670667Z","time spent":"560.970493ms","remote":"127.0.0.1:49578","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-07-08T15:24:13.231595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.510755ms","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-07-08T15:24:13.231719Z","caller":"traceutil/trace.go:171","msg":"trace[742847336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"416.660949ms","start":"2026-07-08T15:24:12.81505Z","end":"2026-07-08T15:24:13.231711Z","steps":["trace[742847336] 'agreement among raft nodes before linearized reading' (duration: 416.501885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.231765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.815035Z","time spent":"416.72276ms","remote":"127.0.0.1:49578","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-07-08T15:24:13.231987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.227332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-08T15:24:13.232048Z","caller":"traceutil/trace.go:171","msg":"trace[698492862] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1275; }","duration":"588.308825ms","start":"2026-07-08T15:24:12.643729Z","end":"2026-07-08T15:24:13.232038Z","steps":["trace[698492862] 'agreement among raft nodes before linearized reading' (duration: 586.825619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.232079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:12.643721Z","time spent":"588.352765ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-08T15:24:13.465859Z","caller":"traceutil/trace.go:171","msg":"trace[274530957] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"227.199668ms","start":"2026-07-08T15:24:13.238645Z","end":"2026-07-08T15:24:13.465845Z","steps":["trace[274530957] 'process raft request' (duration: 227.105376ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.46587Z","caller":"traceutil/trace.go:171","msg":"trace[414517622] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"227.696189ms","start":"2026-07-08T15:24:13.238149Z","end":"2026-07-08T15:24:13.465845Z","steps":["trace[414517622] 'process raft request' (duration: 227.562686ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.465884Z","caller":"traceutil/trace.go:171","msg":"trace[23931220] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"227.649049ms","start":"2026-07-08T15:24:13.238166Z","end":"2026-07-08T15:24:13.465815Z","steps":["trace[23931220] 'process raft request' (duration: 227.491835ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.466015Z","caller":"traceutil/trace.go:171","msg":"trace[401055582] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"227.941695ms","start":"2026-07-08T15:24:13.238067Z","end":"2026-07-08T15:24:13.466008Z","steps":["trace[401055582] 'process raft request' (duration: 213.885081ms)","trace[401055582] 'compare' (duration: 13.541282ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:13.46603Z","caller":"traceutil/trace.go:171","msg":"trace[1505594068] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"227.505135ms","start":"2026-07-08T15:24:13.238331Z","end":"2026-07-08T15:24:13.465836Z","steps":["trace[1505594068] 'process raft request' (duration: 227.402053ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.466287Z","caller":"traceutil/trace.go:171","msg":"trace[786364608] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"221.755849ms","start":"2026-07-08T15:24:13.244055Z","end":"2026-07-08T15:24:13.465811Z","steps":["trace[786364608] 'process raft request' (duration: 221.718068ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.560391Z","caller":"traceutil/trace.go:171","msg":"trace[1202762442] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"235.851353ms","start":"2026-07-08T15:24:13.324509Z","end":"2026-07-08T15:24:13.560361Z","steps":["trace[1202762442] 'process raft request' (duration: 235.681539ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.743076Z","caller":"traceutil/trace.go:171","msg":"trace[1967071081] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1338; }","duration":"180.563587ms","start":"2026-07-08T15:24:13.562494Z","end":"2026-07-08T15:24:13.743057Z","steps":["trace[1967071081] 'read index received' (duration: 119.615377ms)","trace[1967071081] 'applied index is now lower than readState.Index' (duration: 60.9475ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:13.74337Z","caller":"traceutil/trace.go:171","msg":"trace[39005870] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"268.332086ms","start":"2026-07-08T15:24:13.475029Z","end":"2026-07-08T15:24:13.743361Z","steps":["trace[39005870] 'process raft request' (duration: 267.904526ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:13.743481Z","caller":"traceutil/trace.go:171","msg":"trace[712206105] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"270.295383ms","start":"2026-07-08T15:24:13.473155Z","end":"2026-07-08T15:24:13.743451Z","steps":["trace[712206105] 'process raft request' (duration: 209.011916ms)","trace[712206105] 'compare' (duration: 60.389776ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:13.743668Z","caller":"traceutil/trace.go:171","msg":"trace[1486880419] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"264.810004ms","start":"2026-07-08T15:24:13.47885Z","end":"2026-07-08T15:24:13.74366Z","steps":["trace[1486880419] 'process raft request' (duration: 264.156898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:13.743858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.680271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-07-08T15:24:13.744031Z","caller":"traceutil/trace.go:171","msg":"trace[581638351] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1285; }","duration":"181.573012ms","start":"2026-07-08T15:24:13.562449Z","end":"2026-07-08T15:24:13.744022Z","steps":["trace[581638351] 'agreement among raft nodes before linearized reading' (duration: 180.67674ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:15.75499Z","caller":"traceutil/trace.go:171","msg":"trace[1119886784] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"284.066463ms","start":"2026-07-08T15:24:15.470894Z","end":"2026-07-08T15:24:15.754961Z","steps":["trace[1119886784] 'read index received' (duration: 284.047012ms)","trace[1119886784] 'applied index is now lower than readState.Index' (duration: 16.161µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:15.754993Z","caller":"traceutil/trace.go:171","msg":"trace[1957294256] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"300.314769ms","start":"2026-07-08T15:24:15.454652Z","end":"2026-07-08T15:24:15.754967Z","steps":["trace[1957294256] 'process raft request' (duration: 300.180695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:15.755189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.454621Z","time spent":"300.490563ms","remote":"127.0.0.1:49578","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-07-08T15:24:15.755289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.37367ms","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-07-08T15:24:15.755376Z","caller":"traceutil/trace.go:171","msg":"trace[1425194955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1289; }","duration":"284.494972ms","start":"2026-07-08T15:24:15.470858Z","end":"2026-07-08T15:24:15.755353Z","steps":["trace[1425194955] 'agreement among raft nodes before linearized reading' (duration: 284.207105ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.051884Z","caller":"traceutil/trace.go:171","msg":"trace[900205864] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"512.462539ms","start":"2026-07-08T15:24:15.539392Z","end":"2026-07-08T15:24:16.051855Z","steps":["trace[900205864] 'process raft request' (duration: 512.357006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.052089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.539368Z","time spent":"512.600312ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:24:16.052436Z","caller":"traceutil/trace.go:171","msg":"trace[667637375] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1347; }","duration":"297.351588ms","start":"2026-07-08T15:24:15.755061Z","end":"2026-07-08T15:24:16.052413Z","steps":["trace[667637375] 'read index received' (duration: 297.337958ms)","trace[667637375] 'applied index is now lower than readState.Index' (duration: 11.09µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:16.052517Z","caller":"traceutil/trace.go:171","msg":"trace[1204532544] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"575.667314ms","start":"2026-07-08T15:24:15.47683Z","end":"2026-07-08T15:24:16.052497Z","steps":["trace[1204532544] 'process raft request' (duration: 574.772762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.052618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.476811Z","time spent":"575.762446ms","remote":"127.0.0.1:49388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:24:16.053027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.001009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-08T15:24:16.053026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.903562ms","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-07-08T15:24:16.053091Z","caller":"traceutil/trace.go:171","msg":"trace[10562273] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1291; }","duration":"581.150243ms","start":"2026-07-08T15:24:15.471925Z","end":"2026-07-08T15:24:16.053075Z","steps":["trace[10562273] 'agreement among raft nodes before linearized reading' (duration: 580.970449ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.053102Z","caller":"traceutil/trace.go:171","msg":"trace[2078626104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1291; }","duration":"581.976704ms","start":"2026-07-08T15:24:15.471107Z","end":"2026-07-08T15:24:16.053084Z","steps":["trace[2078626104] 'agreement among raft nodes before linearized reading' (duration: 581.79676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.053148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.471077Z","time spent":"582.060095ms","remote":"127.0.0.1:49578","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-07-08T15:24:16.053162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.155088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-08T15:24:16.053183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.829396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T15:24:16.053251Z","caller":"traceutil/trace.go:171","msg":"trace[1396062298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1291; }","duration":"582.27117ms","start":"2026-07-08T15:24:15.470959Z","end":"2026-07-08T15:24:16.053231Z","steps":["trace[1396062298] 'agreement among raft nodes before linearized reading' (duration: 582.019685ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.053257Z","caller":"traceutil/trace.go:171","msg":"trace[1646079736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1291; }","duration":"580.943269ms","start":"2026-07-08T15:24:15.472294Z","end":"2026-07-08T15:24:16.053238Z","steps":["trace[1646079736] 'agreement among raft nodes before linearized reading' (duration: 580.710833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.053147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.471915Z","time spent":"581.219125ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T15:24:16.053301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.470954Z","time spent":"582.339112ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:24:16.053304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.47224Z","time spent":"581.055621ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T15:24:16.063903Z","caller":"traceutil/trace.go:171","msg":"trace[843100000] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"303.369691ms","start":"2026-07-08T15:24:15.76052Z","end":"2026-07-08T15:24:16.06389Z","steps":["trace[843100000] 'process raft request' (duration: 303.249888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.064029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.76051Z","time spent":"303.441163ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:24:16.064099Z","caller":"traceutil/trace.go:171","msg":"trace[162870140] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"303.005323ms","start":"2026-07-08T15:24:15.761074Z","end":"2026-07-08T15:24:16.064079Z","steps":["trace[162870140] 'process raft request' (duration: 302.783848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.064167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.761059Z","time spent":"303.079954ms","remote":"127.0.0.1:49388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:24:16.06421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.033661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-08T15:24:16.064297Z","caller":"traceutil/trace.go:171","msg":"trace[1821435972] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1293; }","duration":"305.126203ms","start":"2026-07-08T15:24:15.759141Z","end":"2026-07-08T15:24:16.064268Z","steps":["trace[1821435972] 'agreement among raft nodes before linearized reading' (duration: 304.918618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:16.064334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:15.759129Z","time spent":"305.194675ms","remote":"127.0.0.1:49578","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-07-08T15:24:16.290367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.23392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:24:16.290693Z","caller":"traceutil/trace.go:171","msg":"trace[339096397] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"221.726018ms","start":"2026-07-08T15:24:16.068951Z","end":"2026-07-08T15:24:16.290677Z","steps":["trace[339096397] 'process raft request' (duration: 221.690557ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.290906Z","caller":"traceutil/trace.go:171","msg":"trace[393007962] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"231.233875ms","start":"2026-07-08T15:24:16.05966Z","end":"2026-07-08T15:24:16.290894Z","steps":["trace[393007962] 'process raft request' (duration: 66.413631ms)","trace[393007962] 'compare' (duration: 164.130328ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:16.291154Z","caller":"traceutil/trace.go:171","msg":"trace[1375381791] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"231.468571ms","start":"2026-07-08T15:24:16.059676Z","end":"2026-07-08T15:24:16.291145Z","steps":["trace[1375381791] 'process raft request' (duration: 230.775454ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.291285Z","caller":"traceutil/trace.go:171","msg":"trace[828991168] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"231.525862ms","start":"2026-07-08T15:24:16.05975Z","end":"2026-07-08T15:24:16.291276Z","steps":["trace[828991168] 'process raft request' (duration: 230.771884ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.291404Z","caller":"traceutil/trace.go:171","msg":"trace[1778689547] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"231.579072ms","start":"2026-07-08T15:24:16.059816Z","end":"2026-07-08T15:24:16.291395Z","steps":["trace[1778689547] 'process raft request' (duration: 230.754733ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:16.291511Z","caller":"traceutil/trace.go:171","msg":"trace[1164725703] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"231.263774ms","start":"2026-07-08T15:24:16.060239Z","end":"2026-07-08T15:24:16.291503Z","steps":["trace[1164725703] 'process raft request' (duration: 230.364413ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:28.596974Z","caller":"traceutil/trace.go:171","msg":"trace[1410088134] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"502.665537ms","start":"2026-07-08T15:24:28.094281Z","end":"2026-07-08T15:24:28.596947Z","steps":["trace[1410088134] 'process raft request' (duration: 502.468922ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:28.597126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.350318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T15:24:28.596943Z","caller":"traceutil/trace.go:171","msg":"trace[192636788] linearizableReadLoop","detail":"{readStateIndex:1434; appliedIndex:1433; }","duration":"478.136392ms","start":"2026-07-08T15:24:28.118782Z","end":"2026-07-08T15:24:28.596918Z","steps":["trace[192636788] 'read index received' (duration: 477.988529ms)","trace[192636788] 'applied index is now lower than readState.Index' (duration: 146.923µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:28.597159Z","caller":"traceutil/trace.go:171","msg":"trace[443500263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1376; }","duration":"478.428319ms","start":"2026-07-08T15:24:28.118724Z","end":"2026-07-08T15:24:28.597152Z","steps":["trace[443500263] 'agreement among raft nodes before linearized reading' (duration: 478.281766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:28.597183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.118703Z","time spent":"478.47537ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T15:24:28.597127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.094263Z","time spent":"502.770359ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:24:29.242673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.921842ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-08T15:24:29.245386Z","caller":"traceutil/trace.go:171","msg":"trace[447262919] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1434; }","duration":"645.773609ms","start":"2026-07-08T15:24:28.597157Z","end":"2026-07-08T15:24:29.24293Z","steps":["trace[447262919] 'read index received' (duration: 60.608492ms)","trace[447262919] 'applied index is now lower than readState.Index' (duration: 585.161787ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:24:29.24733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.29079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-08T15:24:29.247443Z","caller":"traceutil/trace.go:171","msg":"trace[452093632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1378; }","duration":"869.452613ms","start":"2026-07-08T15:24:28.377958Z","end":"2026-07-08T15:24:29.24741Z","steps":["trace[452093632] 'agreement among raft nodes before linearized reading' (duration: 867.496546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:29.247357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.593039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:24:29.247668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.600067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-08T15:24:29.247676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.049861ms","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-07-08T15:24:29.247677Z","caller":"traceutil/trace.go:171","msg":"trace[1815362204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1378; }","duration":"909.962258ms","start":"2026-07-08T15:24:28.337656Z","end":"2026-07-08T15:24:29.247618Z","steps":["trace[1815362204] 'agreement among raft nodes before linearized reading' (duration: 907.768555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:29.247697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.156929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-08T15:24:29.24785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.337635Z","time spent":"910.168473ms","remote":"127.0.0.1:49334","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-07-08T15:24:29.247902Z","caller":"traceutil/trace.go:171","msg":"trace[1991893222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1378; }","duration":"875.412054ms","start":"2026-07-08T15:24:28.372451Z","end":"2026-07-08T15:24:29.247863Z","steps":["trace[1991893222] 'agreement among raft nodes before linearized reading' (duration: 874.561685ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:29.247913Z","caller":"traceutil/trace.go:171","msg":"trace[936494311] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"646.781914ms","start":"2026-07-08T15:24:28.60111Z","end":"2026-07-08T15:24:29.247892Z","steps":["trace[936494311] 'process raft request' (duration: 641.718333ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:29.248017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.372438Z","time spent":"875.537818ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:24:29.248102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.601079Z","time spent":"646.896206ms","remote":"127.0.0.1:49578","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-07-08T15:24:29.247746Z","caller":"traceutil/trace.go:171","msg":"trace[1885276579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1378; }","duration":"876.166353ms","start":"2026-07-08T15:24:28.371564Z","end":"2026-07-08T15:24:29.24773Z","steps":["trace[1885276579] 'agreement among raft nodes before linearized reading' (duration: 876.01857ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:29.248629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.371539Z","time spent":"877.071325ms","remote":"127.0.0.1:49578","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-07-08T15:24:29.247741Z","caller":"traceutil/trace.go:171","msg":"trace[980463999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1378; }","duration":"872.701451ms","start":"2026-07-08T15:24:28.375019Z","end":"2026-07-08T15:24:29.247721Z","steps":["trace[980463999] 'agreement among raft nodes before linearized reading' (duration: 870.527469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:29.248867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.374991Z","time spent":"873.859969ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:24:29.247521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:24:28.377947Z","time spent":"869.550375ms","remote":"127.0.0.1:49578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-08T15:24:29.250064Z","caller":"traceutil/trace.go:171","msg":"trace[1814675032] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"204.750363ms","start":"2026-07-08T15:24:29.045288Z","end":"2026-07-08T15:24:29.250038Z","steps":["trace[1814675032] 'process raft request' (duration: 199.552208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:24:57.713393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.075725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:24:57.713663Z","caller":"traceutil/trace.go:171","msg":"trace[670269913] transaction","detail":"{read_only:false; response_revision:1510; number_of_response:1; }","duration":"284.450102ms","start":"2026-07-08T15:24:57.429161Z","end":"2026-07-08T15:24:57.713611Z","steps":["trace[670269913] 'process raft request' (duration: 169.972998ms)","trace[670269913] 'compare' (duration: 113.824219ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:24:57.713741Z","caller":"traceutil/trace.go:171","msg":"trace[774025579] transaction","detail":"{read_only:false; response_revision:1512; number_of_response:1; }","duration":"283.003938ms","start":"2026-07-08T15:24:57.430712Z","end":"2026-07-08T15:24:57.713716Z","steps":["trace[774025579] 'process raft request' (duration: 282.868255ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:57.713898Z","caller":"traceutil/trace.go:171","msg":"trace[386504743] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"284.153026ms","start":"2026-07-08T15:24:57.429733Z","end":"2026-07-08T15:24:57.713886Z","steps":["trace[386504743] 'process raft request' (duration: 283.784387ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:24:57.713983Z","caller":"traceutil/trace.go:171","msg":"trace[848454013] linearizableReadLoop","detail":"{readStateIndex:1576; appliedIndex:1573; }","duration":"186.126208ms","start":"2026-07-08T15:24:57.527561Z","end":"2026-07-08T15:24:57.713687Z","steps":["trace[848454013] 'read index received' (duration: 71.445929ms)","trace[848454013] 'applied index is now lower than readState.Index' (duration: 114.679009ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:24:57.71431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.58595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-08T15:24:57.714382Z","caller":"traceutil/trace.go:171","msg":"trace[1314495079] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1512; }","duration":"186.916407ms","start":"2026-07-08T15:24:57.527447Z","end":"2026-07-08T15:24:57.714363Z","steps":["trace[1314495079] 'agreement among raft nodes before linearized reading' (duration: 186.533549ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:11.865586Z","caller":"traceutil/trace.go:171","msg":"trace[519128188] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"182.152359ms","start":"2026-07-08T15:27:11.683402Z","end":"2026-07-08T15:27:11.865554Z","steps":["trace[519128188] 'process raft request' (duration: 181.667118ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:18.694096Z","caller":"traceutil/trace.go:171","msg":"trace[390625730] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"124.284993ms","start":"2026-07-08T15:27:18.569774Z","end":"2026-07-08T15:27:18.694059Z","steps":["trace[390625730] 'process raft request' (duration: 58.092981ms)","trace[390625730] 'compare' (duration: 65.898455ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:27:18.759597Z","caller":"traceutil/trace.go:171","msg":"trace[552018542] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2248; }","duration":"116.239114ms","start":"2026-07-08T15:27:18.643318Z","end":"2026-07-08T15:27:18.759557Z","steps":["trace[552018542] 'read index received' (duration: 13.902896ms)","trace[552018542] 'applied index is now lower than readState.Index' (duration: 102.334858ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:27:18.759898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.568862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-08T15:27:18.759939Z","caller":"traceutil/trace.go:171","msg":"trace[1049483412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2157; }","duration":"116.665703ms","start":"2026-07-08T15:27:18.643261Z","end":"2026-07-08T15:27:18.759927Z","steps":["trace[1049483412] 'agreement among raft nodes before linearized reading' (duration: 116.456558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:18.760051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.037949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-08T15:27:18.760169Z","caller":"traceutil/trace.go:171","msg":"trace[1037239427] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2157; }","duration":"116.211243ms","start":"2026-07-08T15:27:18.64393Z","end":"2026-07-08T15:27:18.760141Z","steps":["trace[1037239427] 'agreement among raft nodes before linearized reading' (duration: 115.843485ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:18.864299Z","caller":"traceutil/trace.go:171","msg":"trace[900016658] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"100.463415ms","start":"2026-07-08T15:27:18.763797Z","end":"2026-07-08T15:27:18.86426Z","steps":["trace[900016658] 'process raft request' (duration: 98.97577ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:18.866426Z","caller":"traceutil/trace.go:171","msg":"trace[1339272625] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"100.867164ms","start":"2026-07-08T15:27:18.765533Z","end":"2026-07-08T15:27:18.8664Z","steps":["trace[1339272625] 'process raft request' (duration: 100.801493ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:24.457793Z","caller":"traceutil/trace.go:171","msg":"trace[1582323155] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"103.731821ms","start":"2026-07-08T15:27:24.354023Z","end":"2026-07-08T15:27:24.457755Z","steps":["trace[1582323155] 'process raft request' (duration: 103.528806ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:35.139076Z","caller":"traceutil/trace.go:171","msg":"trace[434556154] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"162.363905ms","start":"2026-07-08T15:27:34.976682Z","end":"2026-07-08T15:27:35.139046Z","steps":["trace[434556154] 'process raft request' (duration: 162.291094ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:35.139726Z","caller":"traceutil/trace.go:171","msg":"trace[1119180565] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"163.245175ms","start":"2026-07-08T15:27:34.975897Z","end":"2026-07-08T15:27:35.139142Z","steps":["trace[1119180565] 'process raft request' (duration: 91.680979ms)","trace[1119180565] 'compare' (duration: 71.210848ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:28:29.647911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.251109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:28:29.648048Z","caller":"traceutil/trace.go:171","msg":"trace[1701337942] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2512; }","duration":"135.482695ms","start":"2026-07-08T15:28:29.512545Z","end":"2026-07-08T15:28:29.648028Z","steps":["trace[1701337942] 'count revisions from in-memory index tree' (duration: 135.140347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:36.687003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.792945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:1 size:2025"} {"level":"info","ts":"2026-07-08T15:28:36.687103Z","caller":"traceutil/trace.go:171","msg":"trace[1206299613] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:1; response_revision:2545; }","duration":"100.963538ms","start":"2026-07-08T15:28:36.58612Z","end":"2026-07-08T15:28:36.687084Z","steps":["trace[1206299613] 'range keys from in-memory index tree' (duration: 100.652971ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:28:57.249561Z","caller":"traceutil/trace.go:171","msg":"trace[2007474318] linearizableReadLoop","detail":"{readStateIndex:2753; appliedIndex:2752; }","duration":"134.784949ms","start":"2026-07-08T15:28:57.114747Z","end":"2026-07-08T15:28:57.249532Z","steps":["trace[2007474318] 'read index received' (duration: 61.552µs)","trace[2007474318] 'applied index is now lower than readState.Index' (duration: 134.721907ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:28:57.249656Z","caller":"traceutil/trace.go:171","msg":"trace[495436050] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"134.902791ms","start":"2026-07-08T15:28:57.114723Z","end":"2026-07-08T15:28:57.249625Z","steps":["trace[495436050] 'process raft request' (duration: 134.570203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:57.249887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.112796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-07-08T15:28:57.249947Z","caller":"traceutil/trace.go:171","msg":"trace[1702240562] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:2639; }","duration":"135.203258ms","start":"2026-07-08T15:28:57.114728Z","end":"2026-07-08T15:28:57.249931Z","steps":["trace[1702240562] 'agreement among raft nodes before linearized reading' (duration: 135.006424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:57.250008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.48482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-07-08T15:28:57.250065Z","caller":"traceutil/trace.go:171","msg":"trace[1437793586] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2639; }","duration":"113.587953ms","start":"2026-07-08T15:28:57.136461Z","end":"2026-07-08T15:28:57.250049Z","steps":["trace[1437793586] 'agreement among raft nodes before linearized reading' (duration: 113.409609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:57.250728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.306009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:115 size:88921"} {"level":"info","ts":"2026-07-08T15:28:57.250793Z","caller":"traceutil/trace.go:171","msg":"trace[323049570] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:115; response_revision:2639; }","duration":"105.513935ms","start":"2026-07-08T15:28:57.145264Z","end":"2026-07-08T15:28:57.250778Z","steps":["trace[323049570] 'agreement among raft nodes before linearized reading' (duration: 104.917431ms)"],"step_count":1}