{"level":"warn","ts":"2026-06-10T10:17:12.612173Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:17:12.612289Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.24: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.24:2380","--initial-cluster=instance=https://199.19.213.24:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.24:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.24:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-10T10:17:12.612396Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:17:12.612414Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.24:2380"]} {"level":"info","ts":"2026-06-10T10:17:12.612462Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T10:17:12.613695Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.24:2379"]} {"level":"info","ts":"2026-06-10T10:17:12.613829Z","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.24:2380"],"listen-peer-urls":["https://199.19.213.24:2380"],"advertise-client-urls":["https://199.19.213.24:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.24:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.24:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-10T10:17:12.619619Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.424291ms"} {"level":"info","ts":"2026-06-10T10:17:12.626753Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bd149264c66f18d5","cluster-id":"781da5450c4333a5"} {"level":"info","ts":"2026-06-10T10:17:12.626838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T10:17:12.626861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 became follower at term 0"} {"level":"info","ts":"2026-06-10T10:17:12.626874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bd149264c66f18d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T10:17:12.626883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 became follower at term 1"} {"level":"info","ts":"2026-06-10T10:17:12.626926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 switched to configuration voters=(13624675734226147541)"} {"level":"warn","ts":"2026-06-10T10:17:12.635229Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T10:17:12.636831Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T10:17:12.640031Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-10T10:17:12.642275Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bd149264c66f18d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T10:17:12.642524Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bd149264c66f18d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T10:17:12.64269Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:17:12.642731Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:17:12.642746Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:17:12.64487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 switched to configuration voters=(13624675734226147541)"} {"level":"info","ts":"2026-06-10T10:17:12.644984Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"781da5450c4333a5","local-member-id":"bd149264c66f18d5","added-peer-id":"bd149264c66f18d5","added-peer-peer-urls":["https://199.19.213.24:2380"]} {"level":"info","ts":"2026-06-10T10:17:12.646656Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T10:17:12.646922Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bd149264c66f18d5","initial-advertise-peer-urls":["https://199.19.213.24:2380"],"listen-peer-urls":["https://199.19.213.24:2380"],"advertise-client-urls":["https://199.19.213.24:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.24:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T10:17:12.646958Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T10:17:12.647109Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.24:2380"} {"level":"info","ts":"2026-06-10T10:17:12.647128Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.24:2380"} {"level":"info","ts":"2026-06-10T10:17:12.727559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T10:17:12.727647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T10:17:12.727888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 received MsgPreVoteResp from bd149264c66f18d5 at term 1"} {"level":"info","ts":"2026-06-10T10:17:12.727928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 became candidate at term 2"} {"level":"info","ts":"2026-06-10T10:17:12.727979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 received MsgVoteResp from bd149264c66f18d5 at term 2"} {"level":"info","ts":"2026-06-10T10:17:12.728007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bd149264c66f18d5 became leader at term 2"} {"level":"info","ts":"2026-06-10T10:17:12.728116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bd149264c66f18d5 elected leader bd149264c66f18d5 at term 2"} {"level":"info","ts":"2026-06-10T10:17:12.730614Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bd149264c66f18d5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.24:2379]}","request-path":"/0/members/bd149264c66f18d5/attributes","cluster-id":"781da5450c4333a5","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T10:17:12.730604Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:17:12.730754Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:17:12.730835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:17:12.733068Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.24:2379"} {"level":"info","ts":"2026-06-10T10:17:12.733537Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"781da5450c4333a5","local-member-id":"bd149264c66f18d5","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:17:12.733635Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:17:12.733659Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:17:12.733674Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T10:17:12.733785Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T10:17:12.734419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-10T10:17:15.87071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.1856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:17:15.870827Z","caller":"traceutil/trace.go:171","msg":"trace[1844750450] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"393.595466ms","start":"2026-06-10T10:17:15.477214Z","end":"2026-06-10T10:17:15.87081Z","steps":["trace[1844750450] 'process raft request' (duration: 291.765366ms)","trace[1844750450] 'compare' (duration: 101.069648ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:15.870971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:15.477199Z","time spent":"393.712509ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:17:20.851064Z","caller":"traceutil/trace.go:171","msg":"trace[1274268707] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"116.41326ms","start":"2026-06-10T10:17:20.734625Z","end":"2026-06-10T10:17:20.851038Z","steps":["trace[1274268707] 'read index received' (duration: 114.667422ms)","trace[1274268707] 'applied index is now lower than readState.Index' (duration: 1.744918ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:20.851249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.551192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:17:20.851357Z","caller":"traceutil/trace.go:171","msg":"trace[692057022] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:295; }","duration":"116.747386ms","start":"2026-06-10T10:17:20.734587Z","end":"2026-06-10T10:17:20.851335Z","steps":["trace[692057022] 'agreement among raft nodes before linearized reading' (duration: 116.559433ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:20.851192Z","caller":"traceutil/trace.go:171","msg":"trace[854477988] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"140.732589ms","start":"2026-06-10T10:17:20.710425Z","end":"2026-06-10T10:17:20.851157Z","steps":["trace[854477988] 'process raft request' (duration: 138.973241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:22.383259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.154073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:17:22.383449Z","caller":"traceutil/trace.go:171","msg":"trace[422486525] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"198.256638ms","start":"2026-06-10T10:17:22.185169Z","end":"2026-06-10T10:17:22.383426Z","steps":["trace[422486525] 'read index received' (duration: 75.79041ms)","trace[422486525] 'applied index is now lower than readState.Index' (duration: 122.465038ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:22.383621Z","caller":"traceutil/trace.go:171","msg":"trace[1568387369] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"240.791522ms","start":"2026-06-10T10:17:22.142784Z","end":"2026-06-10T10:17:22.383575Z","steps":["trace[1568387369] 'process raft request' (duration: 118.257112ms)","trace[1568387369] 'compare' (duration: 122.006361ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:22.383789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.575213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-06-10T10:17:22.383861Z","caller":"traceutil/trace.go:171","msg":"trace[557456786] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:305; }","duration":"198.732006ms","start":"2026-06-10T10:17:22.185117Z","end":"2026-06-10T10:17:22.383849Z","steps":["trace[557456786] 'agreement among raft nodes before linearized reading' (duration: 198.475582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:22.38386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.51146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-06-10T10:17:22.383959Z","caller":"traceutil/trace.go:171","msg":"trace[600741517] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:305; }","duration":"148.658563ms","start":"2026-06-10T10:17:22.235272Z","end":"2026-06-10T10:17:22.38393Z","steps":["trace[600741517] 'agreement among raft nodes before linearized reading' (duration: 148.392949ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.517071Z","caller":"traceutil/trace.go:171","msg":"trace[1356548591] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"128.069497ms","start":"2026-06-10T10:17:22.388976Z","end":"2026-06-10T10:17:22.517045Z","steps":["trace[1356548591] 'process raft request' (duration: 110.049112ms)","trace[1356548591] 'compare' (duration: 17.872263ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:22.517788Z","caller":"traceutil/trace.go:171","msg":"trace[562796846] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"126.336909ms","start":"2026-06-10T10:17:22.391433Z","end":"2026-06-10T10:17:22.51777Z","steps":["trace[562796846] 'process raft request' (duration: 126.131406ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.517933Z","caller":"traceutil/trace.go:171","msg":"trace[190461582] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"126.29644ms","start":"2026-06-10T10:17:22.391604Z","end":"2026-06-10T10:17:22.517901Z","steps":["trace[190461582] 'process raft request' (duration: 126.084696ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.518471Z","caller":"traceutil/trace.go:171","msg":"trace[371899284] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"126.559353ms","start":"2026-06-10T10:17:22.391898Z","end":"2026-06-10T10:17:22.518457Z","steps":["trace[371899284] 'process raft request' (duration: 125.846632ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.518767Z","caller":"traceutil/trace.go:171","msg":"trace[1824089003] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"126.665235ms","start":"2026-06-10T10:17:22.392084Z","end":"2026-06-10T10:17:22.518749Z","steps":["trace[1824089003] 'process raft request' (duration: 125.72408ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.518822Z","caller":"traceutil/trace.go:171","msg":"trace[804754855] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"126.583654ms","start":"2026-06-10T10:17:22.39221Z","end":"2026-06-10T10:17:22.518793Z","steps":["trace[804754855] 'process raft request' (duration: 125.869532ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.518478Z","caller":"traceutil/trace.go:171","msg":"trace[1973686657] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"126.095836ms","start":"2026-06-10T10:17:22.392356Z","end":"2026-06-10T10:17:22.518452Z","steps":["trace[1973686657] 'process raft request' (duration: 125.785081ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:22.519503Z","caller":"traceutil/trace.go:171","msg":"trace[1226057897] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"126.461642ms","start":"2026-06-10T10:17:22.393028Z","end":"2026-06-10T10:17:22.519489Z","steps":["trace[1226057897] 'process raft request' (duration: 125.152341ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:23.012415Z","caller":"traceutil/trace.go:171","msg":"trace[1386877246] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:348; }","duration":"292.503079ms","start":"2026-06-10T10:17:22.719886Z","end":"2026-06-10T10:17:23.012389Z","steps":["trace[1386877246] 'read index received' (duration: 253.164097ms)","trace[1386877246] 'applied index is now lower than readState.Index' (duration: 39.337982ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:23.012476Z","caller":"traceutil/trace.go:171","msg":"trace[807753511] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"308.224997ms","start":"2026-06-10T10:17:22.704191Z","end":"2026-06-10T10:17:23.012416Z","steps":["trace[807753511] 'process raft request' (duration: 308.113226ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:23.012508Z","caller":"traceutil/trace.go:171","msg":"trace[1939920063] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"309.974065ms","start":"2026-06-10T10:17:22.702505Z","end":"2026-06-10T10:17:23.012479Z","steps":["trace[1939920063] 'process raft request' (duration: 270.725225ms)","trace[1939920063] 'compare' (duration: 38.812824ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:23.012618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:22.704172Z","time spent":"308.37231ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:17:23.012604Z","caller":"traceutil/trace.go:171","msg":"trace[1777745924] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"308.573944ms","start":"2026-06-10T10:17:22.703977Z","end":"2026-06-10T10:17:23.012551Z","steps":["trace[1777745924] 'process raft request' (duration: 308.267699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:23.0128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:22.703962Z","time spent":"308.747346ms","remote":"127.0.0.1:44260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:17:23.012846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.915976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-10T10:17:23.012577Z","caller":"traceutil/trace.go:171","msg":"trace[821117613] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"303.010735ms","start":"2026-06-10T10:17:22.709554Z","end":"2026-06-10T10:17:23.012564Z","steps":["trace[821117613] 'process raft request' (duration: 302.790401ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:23.01289Z","caller":"traceutil/trace.go:171","msg":"trace[320863286] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:339; }","duration":"293.021677ms","start":"2026-06-10T10:17:22.719856Z","end":"2026-06-10T10:17:23.012878Z","steps":["trace[320863286] 'agreement among raft nodes before linearized reading' (duration: 292.817184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:23.012994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.118946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:17:23.013631Z","caller":"traceutil/trace.go:171","msg":"trace[1300049430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:339; }","duration":"157.772237ms","start":"2026-06-10T10:17:22.855817Z","end":"2026-06-10T10:17:23.013589Z","steps":["trace[1300049430] 'agreement among raft nodes before linearized reading' (duration: 156.906553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:23.012621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:22.702485Z","time spent":"310.082637ms","remote":"127.0.0.1:44260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:17:23.013487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:22.709543Z","time spent":"303.396811ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:17:23.212661Z","caller":"traceutil/trace.go:171","msg":"trace[1443321488] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"120.683861ms","start":"2026-06-10T10:17:23.091954Z","end":"2026-06-10T10:17:23.212638Z","steps":["trace[1443321488] 'process raft request' (duration: 120.517008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:23.618445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.034627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:17:23.618571Z","caller":"traceutil/trace.go:171","msg":"trace[1466849148] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:358; }","duration":"335.434114ms","start":"2026-06-10T10:17:23.283115Z","end":"2026-06-10T10:17:23.618549Z","steps":["trace[1466849148] 'read index received' (duration: 101.062002ms)","trace[1466849148] 'applied index is now lower than readState.Index' (duration: 234.369692ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:23.618761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.587547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-10T10:17:23.618912Z","caller":"traceutil/trace.go:171","msg":"trace[242587531] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"397.715806ms","start":"2026-06-10T10:17:23.221109Z","end":"2026-06-10T10:17:23.618824Z","steps":["trace[242587531] 'process raft request' (duration: 163.12449ms)","trace[242587531] 'compare' (duration: 233.736912ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:23.618807Z","caller":"traceutil/trace.go:171","msg":"trace[661028183] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:346; }","duration":"335.722399ms","start":"2026-06-10T10:17:23.28307Z","end":"2026-06-10T10:17:23.618792Z","steps":["trace[661028183] 'agreement among raft nodes before linearized reading' (duration: 335.563047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:23.619054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:23.283048Z","time spent":"335.991603ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:17:23.619046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:23.221086Z","time spent":"397.888918ms","remote":"127.0.0.1:44618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:17:23.964746Z","caller":"traceutil/trace.go:171","msg":"trace[129980291] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"341.490669ms","start":"2026-06-10T10:17:23.623224Z","end":"2026-06-10T10:17:23.964715Z","steps":["trace[129980291] 'process raft request' (duration: 322.51756ms)","trace[129980291] 'compare' (duration: 18.811637ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:23.964899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:23.623201Z","time spent":"341.621971ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:17:27.532243Z","caller":"traceutil/trace.go:171","msg":"trace[358054737] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"428.274661ms","start":"2026-06-10T10:17:27.10394Z","end":"2026-06-10T10:17:27.532215Z","steps":["trace[358054737] 'process raft request' (duration: 428.091489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:27.532414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:27.103919Z","time spent":"428.410063ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:17:28.703673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.065973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:17:28.703748Z","caller":"traceutil/trace.go:171","msg":"trace[1078780636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:367; }","duration":"118.163315ms","start":"2026-06-10T10:17:28.58557Z","end":"2026-06-10T10:17:28.703733Z","steps":["trace[1078780636] 'range keys from in-memory index tree' (duration: 118.006012ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:29.403283Z","caller":"traceutil/trace.go:171","msg":"trace[172867706] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"134.071339ms","start":"2026-06-10T10:17:29.269178Z","end":"2026-06-10T10:17:29.40325Z","steps":["trace[172867706] 'process raft request' (duration: 133.873341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:29.775563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.09547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:17:29.775948Z","caller":"traceutil/trace.go:171","msg":"trace[804659467] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"172.456156ms","start":"2026-06-10T10:17:29.603473Z","end":"2026-06-10T10:17:29.775929Z","steps":["trace[804659467] 'compare' (duration: 163.880941ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:29.802902Z","caller":"traceutil/trace.go:171","msg":"trace[2006654262] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"194.193404ms","start":"2026-06-10T10:17:29.608698Z","end":"2026-06-10T10:17:29.802891Z","steps":["trace[2006654262] 'process raft request' (duration: 194.121851ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:30.147941Z","caller":"traceutil/trace.go:171","msg":"trace[476450837] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"140.864032ms","start":"2026-06-10T10:17:30.007058Z","end":"2026-06-10T10:17:30.147922Z","steps":["trace[476450837] 'process raft request' (duration: 140.701285ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:33.266962Z","caller":"traceutil/trace.go:171","msg":"trace[68808491] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"473.195168ms","start":"2026-06-10T10:17:32.793743Z","end":"2026-06-10T10:17:33.266938Z","steps":["trace[68808491] 'process raft request' (duration: 473.042992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:33.267228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:32.793728Z","time spent":"473.394526ms","remote":"127.0.0.1:44446","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-06-10T10:17:33.32582Z","caller":"traceutil/trace.go:171","msg":"trace[450292004] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"529.693907ms","start":"2026-06-10T10:17:32.796094Z","end":"2026-06-10T10:17:33.325788Z","steps":["trace[450292004] 'process raft request' (duration: 529.544991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:33.326001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:32.796085Z","time spent":"529.823272ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:17:37.953427Z","caller":"traceutil/trace.go:171","msg":"trace[1378618859] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"140.987252ms","start":"2026-06-10T10:17:37.812407Z","end":"2026-06-10T10:17:37.953394Z","steps":["trace[1378618859] 'process raft request' (duration: 140.860357ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:39.517458Z","caller":"traceutil/trace.go:171","msg":"trace[1314883647] linearizableReadLoop","detail":"{readStateIndex:413; appliedIndex:412; }","duration":"221.844426ms","start":"2026-06-10T10:17:39.295571Z","end":"2026-06-10T10:17:39.517416Z","steps":["trace[1314883647] 'read index received' (duration: 221.607817ms)","trace[1314883647] 'applied index is now lower than readState.Index' (duration: 235.669µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:39.517586Z","caller":"traceutil/trace.go:171","msg":"trace[283317072] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"405.014878ms","start":"2026-06-10T10:17:39.11255Z","end":"2026-06-10T10:17:39.517565Z","steps":["trace[283317072] 'process raft request' (duration: 404.714456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:39.517676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.093896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T10:17:39.517729Z","caller":"traceutil/trace.go:171","msg":"trace[1840952195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:396; }","duration":"222.1887ms","start":"2026-06-10T10:17:39.295522Z","end":"2026-06-10T10:17:39.517711Z","steps":["trace[1840952195] 'agreement among raft nodes before linearized reading' (duration: 222.094586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:39.517733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:39.112516Z","time spent":"405.119572ms","remote":"127.0.0.1:44354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4360,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:17:39.517978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.612802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-10T10:17:39.51838Z","caller":"traceutil/trace.go:171","msg":"trace[1528388189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:396; }","duration":"172.075231ms","start":"2026-06-10T10:17:39.346276Z","end":"2026-06-10T10:17:39.518351Z","steps":["trace[1528388189] 'agreement among raft nodes before linearized reading' (duration: 171.450726ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:43.690441Z","caller":"traceutil/trace.go:171","msg":"trace[1671983553] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:452; }","duration":"145.258512ms","start":"2026-06-10T10:17:43.545159Z","end":"2026-06-10T10:17:43.690417Z","steps":["trace[1671983553] 'read index received' (duration: 145.129057ms)","trace[1671983553] 'applied index is now lower than readState.Index' (duration: 128.315µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:43.690837Z","caller":"traceutil/trace.go:171","msg":"trace[308507037] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"146.00816ms","start":"2026-06-10T10:17:43.544814Z","end":"2026-06-10T10:17:43.690822Z","steps":["trace[308507037] 'process raft request' (duration: 145.428248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:43.691005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.692386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:17:43.691107Z","caller":"traceutil/trace.go:171","msg":"trace[1629087143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:435; }","duration":"105.842362ms","start":"2026-06-10T10:17:43.585237Z","end":"2026-06-10T10:17:43.69108Z","steps":["trace[1629087143] 'agreement among raft nodes before linearized reading' (duration: 105.673816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:43.691236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.059292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-10T10:17:43.69129Z","caller":"traceutil/trace.go:171","msg":"trace[432817332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:435; }","duration":"146.137445ms","start":"2026-06-10T10:17:43.545137Z","end":"2026-06-10T10:17:43.691275Z","steps":["trace[432817332] 'agreement among raft nodes before linearized reading' (duration: 146.044031ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:44.309022Z","caller":"traceutil/trace.go:171","msg":"trace[916883240] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"104.00798ms","start":"2026-06-10T10:17:44.204996Z","end":"2026-06-10T10:17:44.309004Z","steps":["trace[916883240] 'process raft request' (duration: 103.910836ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:55.644248Z","caller":"traceutil/trace.go:171","msg":"trace[1433616234] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"147.59012ms","start":"2026-06-10T10:17:55.496629Z","end":"2026-06-10T10:17:55.644219Z","steps":["trace[1433616234] 'process raft request' (duration: 147.364343ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:55.644549Z","caller":"traceutil/trace.go:171","msg":"trace[1182604095] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"175.090274ms","start":"2026-06-10T10:17:55.469417Z","end":"2026-06-10T10:17:55.644508Z","steps":["trace[1182604095] 'process raft request' (duration: 123.11321ms)","trace[1182604095] 'compare' (duration: 51.204008ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:55.644708Z","caller":"traceutil/trace.go:171","msg":"trace[1744638899] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"142.963144ms","start":"2026-06-10T10:17:55.501695Z","end":"2026-06-10T10:17:55.644658Z","steps":["trace[1744638899] 'process raft request' (duration: 142.388115ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:55.644769Z","caller":"traceutil/trace.go:171","msg":"trace[1632187123] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"121.628659ms","start":"2026-06-10T10:17:55.523108Z","end":"2026-06-10T10:17:55.644737Z","steps":["trace[1632187123] 'process raft request' (duration: 121.249256ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:55.92132Z","caller":"traceutil/trace.go:171","msg":"trace[1982860649] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"133.70813ms","start":"2026-06-10T10:17:55.787582Z","end":"2026-06-10T10:17:55.92129Z","steps":["trace[1982860649] 'process raft request' (duration: 119.452126ms)","trace[1982860649] 'compare' (duration: 14.060347ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:55.92168Z","caller":"traceutil/trace.go:171","msg":"trace[1812076181] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"122.476989ms","start":"2026-06-10T10:17:55.799168Z","end":"2026-06-10T10:17:55.921645Z","steps":["trace[1812076181] 'process raft request' (duration: 122.341514ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:55.921673Z","caller":"traceutil/trace.go:171","msg":"trace[1596862286] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"125.896964ms","start":"2026-06-10T10:17:55.795706Z","end":"2026-06-10T10:17:55.921603Z","steps":["trace[1596862286] 'process raft request' (duration: 125.523002ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:55.934887Z","caller":"traceutil/trace.go:171","msg":"trace[1929955713] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"103.806095ms","start":"2026-06-10T10:17:55.831062Z","end":"2026-06-10T10:17:55.934868Z","steps":["trace[1929955713] 'process raft request' (duration: 103.67941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:56.43527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.2864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:17:56.435381Z","caller":"traceutil/trace.go:171","msg":"trace[26017565] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:576; }","duration":"388.251117ms","start":"2026-06-10T10:17:56.047113Z","end":"2026-06-10T10:17:56.435364Z","steps":["trace[26017565] 'read index received' (duration: 66.192µs)","trace[26017565] 'applied index is now lower than readState.Index' (duration: 388.183925ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:56.435447Z","caller":"traceutil/trace.go:171","msg":"trace[1044066879] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"429.89188ms","start":"2026-06-10T10:17:56.005544Z","end":"2026-06-10T10:17:56.435436Z","steps":["trace[1044066879] 'process raft request' (duration: 16.354442ms)","trace[1044066879] 'compare' (duration: 413.113004ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:56.435508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:56.00553Z","time spent":"429.949052ms","remote":"127.0.0.1:44230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:17:56.435601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.463104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-10T10:17:56.435678Z","caller":"traceutil/trace.go:171","msg":"trace[1115407407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"388.582058ms","start":"2026-06-10T10:17:56.047076Z","end":"2026-06-10T10:17:56.435658Z","steps":["trace[1115407407] 'agreement among raft nodes before linearized reading' (duration: 388.381921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:56.435719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:56.047059Z","time spent":"388.65233ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T10:17:56.450185Z","caller":"traceutil/trace.go:171","msg":"trace[2146628468] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"196.716406ms","start":"2026-06-10T10:17:56.253446Z","end":"2026-06-10T10:17:56.450163Z","steps":["trace[2146628468] 'process raft request' (duration: 196.312442ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:56.856371Z","caller":"traceutil/trace.go:171","msg":"trace[1958167835] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"274.075952ms","start":"2026-06-10T10:17:56.582272Z","end":"2026-06-10T10:17:56.856348Z","steps":["trace[1958167835] 'process raft request' (duration: 274.031231ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:56.856352Z","caller":"traceutil/trace.go:171","msg":"trace[1781223028] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"317.188044ms","start":"2026-06-10T10:17:56.539122Z","end":"2026-06-10T10:17:56.85631Z","steps":["trace[1781223028] 'process raft request' (duration: 292.72321ms)","trace[1781223028] 'compare' (duration: 24.195865ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:56.856817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:17:56.539105Z","time spent":"317.589718ms","remote":"127.0.0.1:44230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:17:56.856581Z","caller":"traceutil/trace.go:171","msg":"trace[1651614142] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"292.189102ms","start":"2026-06-10T10:17:56.564368Z","end":"2026-06-10T10:17:56.856557Z","steps":["trace[1651614142] 'process raft request' (duration: 291.841831ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:59.141909Z","caller":"traceutil/trace.go:171","msg":"trace[1361311314] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"193.313905ms","start":"2026-06-10T10:17:58.948571Z","end":"2026-06-10T10:17:59.141885Z","steps":["trace[1361311314] 'process raft request' (duration: 99.965454ms)","trace[1361311314] 'compare' (duration: 93.245238ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:18:03.835765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1789510910150883359,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:18:03.845165Z","caller":"traceutil/trace.go:171","msg":"trace[29241548] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"509.595124ms","start":"2026-06-10T10:18:03.33554Z","end":"2026-06-10T10:18:03.845135Z","steps":["trace[29241548] 'read index received' (duration: 508.816279ms)","trace[29241548] 'applied index is now lower than readState.Index' (duration: 777.505µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:03.84535Z","caller":"traceutil/trace.go:171","msg":"trace[573396496] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"682.014887ms","start":"2026-06-10T10:18:03.16331Z","end":"2026-06-10T10:18:03.845324Z","steps":["trace[573396496] 'process raft request' (duration: 681.334466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:03.846211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:03.163278Z","time spent":"682.665638ms","remote":"127.0.0.1:44270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:18:03.846221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.613667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b5wbg\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-06-10T10:18:03.846249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.03943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:03.846475Z","caller":"traceutil/trace.go:171","msg":"trace[686071586] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b5wbg; range_end:; response_count:1; response_revision:610; }","duration":"510.845114ms","start":"2026-06-10T10:18:03.335489Z","end":"2026-06-10T10:18:03.846334Z","steps":["trace[686071586] 'agreement among raft nodes before linearized reading' (duration: 509.824132ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:03.846528Z","caller":"traceutil/trace.go:171","msg":"trace[766441707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"261.133845ms","start":"2026-06-10T10:18:03.585318Z","end":"2026-06-10T10:18:03.846452Z","steps":["trace[766441707] 'agreement among raft nodes before linearized reading' (duration: 260.02631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:03.846595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:03.335449Z","time spent":"511.125983ms","remote":"127.0.0.1:44360","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-b5wbg\" "} {"level":"warn","ts":"2026-06-10T10:18:05.425482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.99106ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:05.425605Z","caller":"traceutil/trace.go:171","msg":"trace[1855125564] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:610; }","duration":"798.124354ms","start":"2026-06-10T10:18:04.627462Z","end":"2026-06-10T10:18:05.425586Z","steps":["trace[1855125564] 'range keys from in-memory index tree' (duration: 797.97614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:05.426129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.533715184s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:18:05.426364Z","caller":"traceutil/trace.go:171","msg":"trace[509313608] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.57028629s","start":"2026-06-10T10:18:03.856047Z","end":"2026-06-10T10:18:05.426333Z","steps":["trace[509313608] 'process raft request' (duration: 36.278807ms)","trace[509313608] 'compare' (duration: 1.533577579s)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:05.426416Z","caller":"traceutil/trace.go:171","msg":"trace[144931605] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.564725553s","start":"2026-06-10T10:18:03.861664Z","end":"2026-06-10T10:18:05.42639Z","steps":["trace[144931605] 'process raft request' (duration: 1.564569278s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:05.426506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:03.85603Z","time spent":"1.570397544s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:18:05.426529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:03.861638Z","time spent":"1.564828006s","remote":"127.0.0.1:44360","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-06-10T10:18:05.426553Z","caller":"traceutil/trace.go:171","msg":"trace[729398960] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:635; }","duration":"1.441151199s","start":"2026-06-10T10:18:03.985368Z","end":"2026-06-10T10:18:05.426519Z","steps":["trace[729398960] 'read index received' (duration: 55.281µs)","trace[729398960] 'applied index is now lower than readState.Index' (duration: 1.441091198s)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:05.426634Z","caller":"traceutil/trace.go:171","msg":"trace[1191991324] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.508358744s","start":"2026-06-10T10:18:03.918259Z","end":"2026-06-10T10:18:05.426617Z","steps":["trace[1191991324] 'process raft request' (duration: 1.508072765s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:05.426731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:03.91824Z","time spent":"1.508442957s","remote":"127.0.0.1:44416","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-06-10T10:18:05.426832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.441445579s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-10T10:18:05.426844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.040402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:18:05.426888Z","caller":"traceutil/trace.go:171","msg":"trace[487431915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"935.116234ms","start":"2026-06-10T10:18:04.491759Z","end":"2026-06-10T10:18:05.426875Z","steps":["trace[487431915] 'agreement among raft nodes before linearized reading' (duration: 934.99153ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:05.426887Z","caller":"traceutil/trace.go:171","msg":"trace[538361760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.441551292s","start":"2026-06-10T10:18:03.985321Z","end":"2026-06-10T10:18:05.426872Z","steps":["trace[538361760] 'agreement among raft nodes before linearized reading' (duration: 1.441335205s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:05.426912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:04.49174Z","time spent":"935.166886ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:18:05.426928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:03.985301Z","time spent":"1.441617663s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:18:05.427061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.433287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T10:18:05.427147Z","caller":"traceutil/trace.go:171","msg":"trace[357237127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"919.537601ms","start":"2026-06-10T10:18:04.507588Z","end":"2026-06-10T10:18:05.427126Z","steps":["trace[357237127] 'agreement among raft nodes before linearized reading' (duration: 919.238921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:05.427226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:04.507577Z","time spent":"919.637354ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:18:07.762383Z","caller":"traceutil/trace.go:171","msg":"trace[460520396] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"177.14568ms","start":"2026-06-10T10:18:07.585207Z","end":"2026-06-10T10:18:07.762353Z","steps":["trace[460520396] 'read index received' (duration: 177.004085ms)","trace[460520396] 'applied index is now lower than readState.Index' (duration: 139.525µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:07.762405Z","caller":"traceutil/trace.go:171","msg":"trace[1611970525] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"250.295746ms","start":"2026-06-10T10:18:07.512077Z","end":"2026-06-10T10:18:07.762373Z","steps":["trace[1611970525] 'process raft request' (duration: 250.060109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:07.762563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.339935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:07.762597Z","caller":"traceutil/trace.go:171","msg":"trace[20377157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"177.443249ms","start":"2026-06-10T10:18:07.585144Z","end":"2026-06-10T10:18:07.762587Z","steps":["trace[20377157] 'agreement among raft nodes before linearized reading' (duration: 177.311745ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:10.648551Z","caller":"traceutil/trace.go:171","msg":"trace[514293012] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"112.804892ms","start":"2026-06-10T10:18:10.53572Z","end":"2026-06-10T10:18:10.648525Z","steps":["trace[514293012] 'process raft request' (duration: 112.609016ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:18.533217Z","caller":"traceutil/trace.go:171","msg":"trace[202696273] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"101.502265ms","start":"2026-06-10T10:18:18.4317Z","end":"2026-06-10T10:18:18.533202Z","steps":["trace[202696273] 'process raft request' (duration: 101.403392ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:21.849845Z","caller":"traceutil/trace.go:171","msg":"trace[2069382153] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"601.31494ms","start":"2026-06-10T10:18:21.248502Z","end":"2026-06-10T10:18:21.849817Z","steps":["trace[2069382153] 'process raft request' (duration: 601.071014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.850087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.248491Z","time spent":"601.431773ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:18:21.922881Z","caller":"traceutil/trace.go:171","msg":"trace[336089876] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"474.097666ms","start":"2026-06-10T10:18:21.448753Z","end":"2026-06-10T10:18:21.922851Z","steps":["trace[336089876] 'process raft request' (duration: 473.876319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.923099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.44872Z","time spent":"474.24682ms","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:18:21.930896Z","caller":"traceutil/trace.go:171","msg":"trace[1485338280] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:807; }","duration":"422.079811ms","start":"2026-06-10T10:18:21.508583Z","end":"2026-06-10T10:18:21.930662Z","steps":["trace[1485338280] 'read index received' (duration: 341.013427ms)","trace[1485338280] 'applied index is now lower than readState.Index' (duration: 81.065544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:18:21.931032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.444921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T10:18:21.931049Z","caller":"traceutil/trace.go:171","msg":"trace[2110091703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:779; }","duration":"422.509092ms","start":"2026-06-10T10:18:21.508535Z","end":"2026-06-10T10:18:21.931044Z","steps":["trace[2110091703] 'agreement among raft nodes before linearized reading' (duration: 422.42327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.931068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.508512Z","time spent":"422.551254ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:18:21.931203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.760587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:18:21.931714Z","caller":"traceutil/trace.go:171","msg":"trace[893558623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:779; }","duration":"408.294042ms","start":"2026-06-10T10:18:21.523413Z","end":"2026-06-10T10:18:21.931707Z","steps":["trace[893558623] 'agreement among raft nodes before linearized reading' (duration: 407.756487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.931731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.523395Z","time spent":"408.331803ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:18:21.931737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.769036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-10T10:18:21.931351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.14511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:21.931792Z","caller":"traceutil/trace.go:171","msg":"trace[951533137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:779; }","duration":"397.845168ms","start":"2026-06-10T10:18:21.533933Z","end":"2026-06-10T10:18:21.931778Z","steps":["trace[951533137] 'agreement among raft nodes before linearized reading' (duration: 397.649903ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:21.93182Z","caller":"traceutil/trace.go:171","msg":"trace[43847393] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:779; }","duration":"188.618703ms","start":"2026-06-10T10:18:21.743195Z","end":"2026-06-10T10:18:21.931813Z","steps":["trace[43847393] 'agreement among raft nodes before linearized reading' (duration: 188.129619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.93183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.533922Z","time spent":"397.900999ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:18:21.931535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.331406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:21.931936Z","caller":"traceutil/trace.go:171","msg":"trace[1383191362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"346.757968ms","start":"2026-06-10T10:18:21.58517Z","end":"2026-06-10T10:18:21.931928Z","steps":["trace[1383191362] 'agreement among raft nodes before linearized reading' (duration: 346.350947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.931961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.58515Z","time spent":"346.8055ms","remote":"127.0.0.1:44180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:18:21.931556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.628204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:21.932034Z","caller":"traceutil/trace.go:171","msg":"trace[1377927273] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:779; }","duration":"189.104757ms","start":"2026-06-10T10:18:21.742923Z","end":"2026-06-10T10:18:21.932028Z","steps":["trace[1377927273] 'agreement among raft nodes before linearized reading' (duration: 188.622744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.931587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.717317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:18:21.932102Z","caller":"traceutil/trace.go:171","msg":"trace[1916106626] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:779; }","duration":"189.258391ms","start":"2026-06-10T10:18:21.742839Z","end":"2026-06-10T10:18:21.932098Z","steps":["trace[1916106626] 'agreement among raft nodes before linearized reading' (duration: 188.735736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.931672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.937121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-10T10:18:21.93214Z","caller":"traceutil/trace.go:171","msg":"trace[773411288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:779; }","duration":"403.431205ms","start":"2026-06-10T10:18:21.528706Z","end":"2026-06-10T10:18:21.932137Z","steps":["trace[773411288] 'agreement among raft nodes before linearized reading' (duration: 402.931351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:21.932155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:21.528688Z","time spent":"403.462267ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:18:26.075178Z","caller":"traceutil/trace.go:171","msg":"trace[1385533391] linearizableReadLoop","detail":"{readStateIndex:854; appliedIndex:853; }","duration":"100.256993ms","start":"2026-06-10T10:18:25.974874Z","end":"2026-06-10T10:18:26.075131Z","steps":["trace[1385533391] 'read index received' (duration: 90.062515ms)","trace[1385533391] 'applied index is now lower than readState.Index' (duration: 10.193698ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:26.075331Z","caller":"traceutil/trace.go:171","msg":"trace[1850171432] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"114.626458ms","start":"2026-06-10T10:18:25.960627Z","end":"2026-06-10T10:18:26.075254Z","steps":["trace[1850171432] 'process raft request' (duration: 112.919291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:26.075433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.543461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:18:26.075472Z","caller":"traceutil/trace.go:171","msg":"trace[707462181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:823; }","duration":"100.602702ms","start":"2026-06-10T10:18:25.974859Z","end":"2026-06-10T10:18:26.075462Z","steps":["trace[707462181] 'agreement among raft nodes before linearized reading' (duration: 100.414357ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:18:39.843226Z","caller":"traceutil/trace.go:171","msg":"trace[865801203] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"152.123407ms","start":"2026-06-10T10:18:39.69106Z","end":"2026-06-10T10:18:39.843184Z","steps":["trace[865801203] 'process raft request' (duration: 111.389774ms)","trace[865801203] 'compare' (duration: 40.21623ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:40.026401Z","caller":"traceutil/trace.go:171","msg":"trace[288676406] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"163.736209ms","start":"2026-06-10T10:18:39.862615Z","end":"2026-06-10T10:18:40.026352Z","steps":["trace[288676406] 'process raft request' (duration: 139.888587ms)","trace[288676406] 'compare' (duration: 23.620286ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:40.026615Z","caller":"traceutil/trace.go:171","msg":"trace[443689393] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"162.366263ms","start":"2026-06-10T10:18:39.864046Z","end":"2026-06-10T10:18:40.026412Z","steps":["trace[443689393] 'process raft request' (duration: 162.21859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:52.273364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.097284ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T10:18:52.273496Z","caller":"traceutil/trace.go:171","msg":"trace[1350879584] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1217; }","duration":"418.457389ms","start":"2026-06-10T10:18:51.855021Z","end":"2026-06-10T10:18:52.273478Z","steps":["trace[1350879584] 'read index received' (duration: 52.081µs)","trace[1350879584] 'applied index is now lower than readState.Index' (duration: 418.403888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:18:52.273582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.540711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:18:52.273648Z","caller":"traceutil/trace.go:171","msg":"trace[725508858] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1178; }","duration":"418.653263ms","start":"2026-06-10T10:18:51.85498Z","end":"2026-06-10T10:18:52.273634Z","steps":["trace[725508858] 'agreement among raft nodes before linearized reading' (duration: 418.543191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:52.27368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:18:51.85496Z","time spent":"418.711834ms","remote":"127.0.0.1:44592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:18:52.274245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.763244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-10T10:18:52.274387Z","caller":"traceutil/trace.go:171","msg":"trace[980228124] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1178; }","duration":"162.275896ms","start":"2026-06-10T10:18:52.112043Z","end":"2026-06-10T10:18:52.274318Z","steps":["trace[980228124] 'agreement among raft nodes before linearized reading' (duration: 161.539648ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:15.067157Z","caller":"traceutil/trace.go:171","msg":"trace[1969913666] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"133.266687ms","start":"2026-06-10T10:19:14.933684Z","end":"2026-06-10T10:19:15.066951Z","steps":["trace[1969913666] 'process raft request' (duration: 133.060793ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:17.183987Z","caller":"traceutil/trace.go:171","msg":"trace[1093798506] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"125.771981ms","start":"2026-06-10T10:19:17.058171Z","end":"2026-06-10T10:19:17.183943Z","steps":["trace[1093798506] 'process raft request' (duration: 76.553194ms)","trace[1093798506] 'compare' (duration: 48.605563ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:19:17.183984Z","caller":"traceutil/trace.go:171","msg":"trace[1347286645] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"104.75843ms","start":"2026-06-10T10:19:17.079192Z","end":"2026-06-10T10:19:17.183951Z","steps":["trace[1347286645] 'process raft request' (duration: 104.439923ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:17.184372Z","caller":"traceutil/trace.go:171","msg":"trace[2099873057] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"109.280447ms","start":"2026-06-10T10:19:17.075073Z","end":"2026-06-10T10:19:17.184353Z","steps":["trace[2099873057] 'process raft request' (duration: 108.440919ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:19.259572Z","caller":"traceutil/trace.go:171","msg":"trace[937882207] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1541; }","duration":"116.955105ms","start":"2026-06-10T10:19:19.142595Z","end":"2026-06-10T10:19:19.25955Z","steps":["trace[937882207] 'read index received' (duration: 87.796073ms)","trace[937882207] 'applied index is now lower than readState.Index' (duration: 29.157892ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:19:19.259688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.063677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/policies.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:19.259714Z","caller":"traceutil/trace.go:171","msg":"trace[790386522] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/policies.rabbitmq.com; range_end:; response_count:0; response_revision:1492; }","duration":"117.140288ms","start":"2026-06-10T10:19:19.142564Z","end":"2026-06-10T10:19:19.259704Z","steps":["trace[790386522] 'agreement among raft nodes before linearized reading' (duration: 117.072237ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:19.259877Z","caller":"traceutil/trace.go:171","msg":"trace[1012956386] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"117.774182ms","start":"2026-06-10T10:19:19.142053Z","end":"2026-06-10T10:19:19.259827Z","steps":["trace[1012956386] 'process raft request' (duration: 117.322702ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:23.139627Z","caller":"traceutil/trace.go:171","msg":"trace[251730769] linearizableReadLoop","detail":"{readStateIndex:1604; appliedIndex:1603; }","duration":"120.123648ms","start":"2026-06-10T10:19:23.019482Z","end":"2026-06-10T10:19:23.139606Z","steps":["trace[251730769] 'read index received' (duration: 119.995685ms)","trace[251730769] 'applied index is now lower than readState.Index' (duration: 127.423µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:19:23.139648Z","caller":"traceutil/trace.go:171","msg":"trace[269867314] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1548; }","duration":"137.037754ms","start":"2026-06-10T10:19:23.002589Z","end":"2026-06-10T10:19:23.139626Z","steps":["trace[269867314] 'process raft request' (duration: 136.955833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:23.139869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.260532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:23.139925Z","caller":"traceutil/trace.go:171","msg":"trace[1711007137] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1548; }","duration":"120.491657ms","start":"2026-06-10T10:19:23.019426Z","end":"2026-06-10T10:19:23.139918Z","steps":["trace[1711007137] 'agreement among raft nodes before linearized reading' (duration: 120.275522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:23.140022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.061178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:23.140053Z","caller":"traceutil/trace.go:171","msg":"trace[376338956] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1548; }","duration":"102.110279ms","start":"2026-06-10T10:19:23.037935Z","end":"2026-06-10T10:19:23.140045Z","steps":["trace[376338956] 'agreement among raft nodes before linearized reading' (duration: 102.033678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:23.140136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.607329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:23.140218Z","caller":"traceutil/trace.go:171","msg":"trace[1474904214] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1548; }","duration":"120.756292ms","start":"2026-06-10T10:19:23.019447Z","end":"2026-06-10T10:19:23.140204Z","steps":["trace[1474904214] 'agreement among raft nodes before linearized reading' (duration: 120.574628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:23.140412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.321575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:23.140431Z","caller":"traceutil/trace.go:171","msg":"trace[1245593454] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1548; }","duration":"103.367155ms","start":"2026-06-10T10:19:23.037059Z","end":"2026-06-10T10:19:23.140426Z","steps":["trace[1245593454] 'agreement among raft nodes before linearized reading' (duration: 103.331005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:23.140474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.264291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:23.140499Z","caller":"traceutil/trace.go:171","msg":"trace[317740319] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1548; }","duration":"120.303493ms","start":"2026-06-10T10:19:23.020189Z","end":"2026-06-10T10:19:23.140492Z","steps":["trace[317740319] 'agreement among raft nodes before linearized reading' (duration: 120.268972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:23.14058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.500248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:23.140597Z","caller":"traceutil/trace.go:171","msg":"trace[1519086097] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1548; }","duration":"103.531559ms","start":"2026-06-10T10:19:23.037061Z","end":"2026-06-10T10:19:23.140593Z","steps":["trace[1519086097] 'agreement among raft nodes before linearized reading' (duration: 103.503318ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:41.007864Z","caller":"traceutil/trace.go:171","msg":"trace[1374249472] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"199.715241ms","start":"2026-06-10T10:19:40.808075Z","end":"2026-06-10T10:19:41.00779Z","steps":["trace[1374249472] 'process raft request' (duration: 129.730899ms)","trace[1374249472] 'compare' (duration: 69.660516ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:19:41.008315Z","caller":"traceutil/trace.go:171","msg":"trace[1891457264] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1927; }","duration":"193.802014ms","start":"2026-06-10T10:19:40.814499Z","end":"2026-06-10T10:19:41.008301Z","steps":["trace[1891457264] 'read index received' (duration: 14.724685ms)","trace[1891457264] 'applied index is now lower than readState.Index' (duration: 179.076039ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:19:41.008513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.988797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T10:19:41.008578Z","caller":"traceutil/trace.go:171","msg":"trace[397780786] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1855; }","duration":"194.088399ms","start":"2026-06-10T10:19:40.814477Z","end":"2026-06-10T10:19:41.008565Z","steps":["trace[397780786] 'agreement among raft nodes before linearized reading' (duration: 193.891105ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:41.008549Z","caller":"traceutil/trace.go:171","msg":"trace[21051906] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"198.874485ms","start":"2026-06-10T10:19:40.80963Z","end":"2026-06-10T10:19:41.008504Z","steps":["trace[21051906] 'process raft request' (duration: 198.378705ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:41.008224Z","caller":"traceutil/trace.go:171","msg":"trace[932970218] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"199.401825ms","start":"2026-06-10T10:19:40.808716Z","end":"2026-06-10T10:19:41.008118Z","steps":["trace[932970218] 'process raft request' (duration: 199.219931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:41.796061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.985758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:19:41.796165Z","caller":"traceutil/trace.go:171","msg":"trace[2016456771] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"553.601065ms","start":"2026-06-10T10:19:41.242546Z","end":"2026-06-10T10:19:41.796147Z","steps":["trace[2016456771] 'read index received' (duration: 449.448003ms)","trace[2016456771] 'applied index is now lower than readState.Index' (duration: 104.151352ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:19:41.796267Z","caller":"traceutil/trace.go:171","msg":"trace[1460837924] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"782.647494ms","start":"2026-06-10T10:19:41.013608Z","end":"2026-06-10T10:19:41.796256Z","steps":["trace[1460837924] 'process raft request' (duration: 678.36881ms)","trace[1460837924] 'compare' (duration: 103.674772ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:19:41.796338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:41.013579Z","time spent":"782.723675ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:19:41.796529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.980803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-337ef171-01bd-4cc2-a4b0-6fb3d943462d\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-06-10T10:19:41.796586Z","caller":"traceutil/trace.go:171","msg":"trace[1279480487] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-337ef171-01bd-4cc2-a4b0-6fb3d943462d; range_end:; response_count:1; response_revision:1856; }","duration":"554.147047ms","start":"2026-06-10T10:19:41.242427Z","end":"2026-06-10T10:19:41.796574Z","steps":["trace[1279480487] 'agreement among raft nodes before linearized reading' (duration: 553.967373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:41.796613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:41.242405Z","time spent":"554.203507ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-337ef171-01bd-4cc2-a4b0-6fb3d943462d\" "} {"level":"info","ts":"2026-06-10T10:19:41.848107Z","caller":"traceutil/trace.go:171","msg":"trace[115206637] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"497.595476ms","start":"2026-06-10T10:19:41.350476Z","end":"2026-06-10T10:19:41.848072Z","steps":["trace[115206637] 'process raft request' (duration: 497.263189ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:41.848203Z","caller":"traceutil/trace.go:171","msg":"trace[1764455312] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"594.119566ms","start":"2026-06-10T10:19:41.254035Z","end":"2026-06-10T10:19:41.848155Z","steps":["trace[1764455312] 'process raft request' (duration: 593.371181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:41.848264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:41.350446Z","time spent":"497.730769ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:19:41.84824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.186881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:19:41.848404Z","caller":"traceutil/trace.go:171","msg":"trace[365262338] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"514.639196ms","start":"2026-06-10T10:19:41.333757Z","end":"2026-06-10T10:19:41.848396Z","steps":["trace[365262338] 'process raft request' (duration: 513.890061ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:41.848408Z","caller":"traceutil/trace.go:171","msg":"trace[364874410] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1860; }","duration":"280.405295ms","start":"2026-06-10T10:19:41.567959Z","end":"2026-06-10T10:19:41.848364Z","steps":["trace[364874410] 'agreement among raft nodes before linearized reading' (duration: 279.999327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:41.848443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.406305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:41.848558Z","caller":"traceutil/trace.go:171","msg":"trace[80605972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"263.544008ms","start":"2026-06-10T10:19:41.584992Z","end":"2026-06-10T10:19:41.848536Z","steps":["trace[80605972] 'agreement among raft nodes before linearized reading' (duration: 263.375705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:41.848201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.301354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:19:41.848435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:41.25401Z","time spent":"594.302419ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:19:41.848461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:41.33373Z","time spent":"514.703138ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:19:41.848695Z","caller":"traceutil/trace.go:171","msg":"trace[293511855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1860; }","duration":"159.858135ms","start":"2026-06-10T10:19:41.688797Z","end":"2026-06-10T10:19:41.848655Z","steps":["trace[293511855] 'agreement among raft nodes before linearized reading' (duration: 159.273464ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:41.848307Z","caller":"traceutil/trace.go:171","msg":"trace[9297971] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"402.476455ms","start":"2026-06-10T10:19:41.445805Z","end":"2026-06-10T10:19:41.848282Z","steps":["trace[9297971] 'process raft request' (duration: 402.040776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:41.849257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:41.445767Z","time spent":"403.386212ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:19:41.966567Z","caller":"traceutil/trace.go:171","msg":"trace[565382937] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1936; }","duration":"116.400426ms","start":"2026-06-10T10:19:41.850114Z","end":"2026-06-10T10:19:41.966514Z","steps":["trace[565382937] 'read index received' (duration: 17.998599ms)","trace[565382937] 'applied index is now lower than readState.Index' (duration: 98.400187ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:19:41.966712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.578901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:41.966751Z","caller":"traceutil/trace.go:171","msg":"trace[166804578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"116.684993ms","start":"2026-06-10T10:19:41.850057Z","end":"2026-06-10T10:19:41.966742Z","steps":["trace[166804578] 'agreement among raft nodes before linearized reading' (duration: 116.590251ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.074681Z","caller":"traceutil/trace.go:171","msg":"trace[21568952] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"214.105193ms","start":"2026-06-10T10:19:45.860547Z","end":"2026-06-10T10:19:46.074652Z","steps":["trace[21568952] 'process raft request' (duration: 213.91793ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.07481Z","caller":"traceutil/trace.go:171","msg":"trace[1675864633] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1894; }","duration":"205.443012ms","start":"2026-06-10T10:19:45.869347Z","end":"2026-06-10T10:19:46.07479Z","steps":["trace[1675864633] 'process raft request' (duration: 205.283969ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.074801Z","caller":"traceutil/trace.go:171","msg":"trace[247746186] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"213.711875ms","start":"2026-06-10T10:19:45.861035Z","end":"2026-06-10T10:19:46.074747Z","steps":["trace[247746186] 'process raft request' (duration: 213.499691ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.075005Z","caller":"traceutil/trace.go:171","msg":"trace[1878349490] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"213.077373ms","start":"2026-06-10T10:19:45.861907Z","end":"2026-06-10T10:19:46.074984Z","steps":["trace[1878349490] 'process raft request' (duration: 212.680475ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.075149Z","caller":"traceutil/trace.go:171","msg":"trace[962979081] linearizableReadLoop","detail":"{readStateIndex:1968; appliedIndex:1966; }","duration":"239.025887ms","start":"2026-06-10T10:19:45.836107Z","end":"2026-06-10T10:19:46.075133Z","steps":["trace[962979081] 'read index received' (duration: 30.683698ms)","trace[962979081] 'applied index is now lower than readState.Index' (duration: 208.339849ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:19:46.075377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.262922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10981"} {"level":"warn","ts":"2026-06-10T10:19:46.075411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.27109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:19:46.075517Z","caller":"traceutil/trace.go:171","msg":"trace[236347529] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1894; }","duration":"199.404812ms","start":"2026-06-10T10:19:45.876093Z","end":"2026-06-10T10:19:46.075498Z","steps":["trace[236347529] 'agreement among raft nodes before linearized reading' (duration: 199.175377ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.075435Z","caller":"traceutil/trace.go:171","msg":"trace[1256833223] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1894; }","duration":"239.380933ms","start":"2026-06-10T10:19:45.836039Z","end":"2026-06-10T10:19:46.07542Z","steps":["trace[1256833223] 'agreement among raft nodes before linearized reading' (duration: 239.20301ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.075035Z","caller":"traceutil/trace.go:171","msg":"trace[978007696] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"239.058847ms","start":"2026-06-10T10:19:45.835895Z","end":"2026-06-10T10:19:46.074954Z","steps":["trace[978007696] 'process raft request' (duration: 207.29607ms)","trace[978007696] 'compare' (duration: 31.096144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:19:46.075808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.50434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:46.076028Z","caller":"traceutil/trace.go:171","msg":"trace[1926916643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1894; }","duration":"173.751025ms","start":"2026-06-10T10:19:45.902252Z","end":"2026-06-10T10:19:46.076003Z","steps":["trace[1926916643] 'agreement among raft nodes before linearized reading' (duration: 173.116272ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:46.251346Z","caller":"traceutil/trace.go:171","msg":"trace[1730930949] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"131.286792ms","start":"2026-06-10T10:19:46.120032Z","end":"2026-06-10T10:19:46.251318Z","steps":["trace[1730930949] 'process raft request' (duration: 118.091161ms)","trace[1730930949] 'compare' (duration: 12.875655ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:19:46.25135Z","caller":"traceutil/trace.go:171","msg":"trace[1730222089] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"124.197412ms","start":"2026-06-10T10:19:46.127104Z","end":"2026-06-10T10:19:46.251301Z","steps":["trace[1730222089] 'process raft request' (duration: 124.045289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:48.844512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.277715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:19:48.84462Z","caller":"traceutil/trace.go:171","msg":"trace[1245909971] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1923; }","duration":"114.460939ms","start":"2026-06-10T10:19:48.730137Z","end":"2026-06-10T10:19:48.844598Z","steps":["trace[1245909971] 'range keys from in-memory index tree' (duration: 114.04279ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:19:56.77269Z","caller":"traceutil/trace.go:171","msg":"trace[1783951476] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"120.784602ms","start":"2026-06-10T10:19:56.651864Z","end":"2026-06-10T10:19:56.772649Z","steps":["trace[1783951476] 'process raft request' (duration: 118.735322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:57.609382Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1789510910150886079,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:19:58.046286Z","caller":"traceutil/trace.go:171","msg":"trace[1513855638] linearizableReadLoop","detail":"{readStateIndex:2073; appliedIndex:2072; }","duration":"937.135932ms","start":"2026-06-10T10:19:57.109125Z","end":"2026-06-10T10:19:58.046261Z","steps":["trace[1513855638] 'read index received' (duration: 936.969279ms)","trace[1513855638] 'applied index is now lower than readState.Index' (duration: 165.613µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:19:58.046345Z","caller":"traceutil/trace.go:171","msg":"trace[50424449] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"951.289315ms","start":"2026-06-10T10:19:57.095023Z","end":"2026-06-10T10:19:58.046313Z","steps":["trace[50424449] 'process raft request' (duration: 951.061641ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:58.046505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:57.095007Z","time spent":"951.407007ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:19:58.046572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.420678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:19:58.046643Z","caller":"traceutil/trace.go:171","msg":"trace[1424259069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1992; }","duration":"937.54641ms","start":"2026-06-10T10:19:57.109079Z","end":"2026-06-10T10:19:58.046625Z","steps":["trace[1424259069] 'agreement among raft nodes before linearized reading' (duration: 937.343316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:58.046697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:57.10906Z","time spent":"937.620252ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:19:58.054383Z","caller":"traceutil/trace.go:171","msg":"trace[1285759767] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"165.910675ms","start":"2026-06-10T10:19:57.888456Z","end":"2026-06-10T10:19:58.054367Z","steps":["trace[1285759767] 'process raft request' (duration: 165.614509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:58.054506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.95763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:19:58.054532Z","caller":"traceutil/trace.go:171","msg":"trace[955583146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1993; }","duration":"471.013092ms","start":"2026-06-10T10:19:57.583512Z","end":"2026-06-10T10:19:58.054525Z","steps":["trace[955583146] 'agreement among raft nodes before linearized reading' (duration: 470.94292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:58.054563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:57.583495Z","time spent":"471.062302ms","remote":"127.0.0.1:44180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:19:58.05464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.550075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T10:19:58.054715Z","caller":"traceutil/trace.go:171","msg":"trace[1270201993] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1993; }","duration":"168.682518ms","start":"2026-06-10T10:19:57.886012Z","end":"2026-06-10T10:19:58.054695Z","steps":["trace[1270201993] 'agreement among raft nodes before linearized reading' (duration: 168.430163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:58.055155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.278594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:19:58.055315Z","caller":"traceutil/trace.go:171","msg":"trace[476674847] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1993; }","duration":"870.826905ms","start":"2026-06-10T10:19:57.184423Z","end":"2026-06-10T10:19:58.05525Z","steps":["trace[476674847] 'agreement among raft nodes before linearized reading' (duration: 869.940338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:19:58.055418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:19:57.184399Z","time spent":"871.001337ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-10T10:20:12.888956Z","caller":"traceutil/trace.go:171","msg":"trace[1651876887] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"183.634771ms","start":"2026-06-10T10:20:12.705302Z","end":"2026-06-10T10:20:12.888936Z","steps":["trace[1651876887] 'process raft request' (duration: 183.496668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:13.445868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.311376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:20:13.445934Z","caller":"traceutil/trace.go:171","msg":"trace[1999407005] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2084; }","duration":"455.418329ms","start":"2026-06-10T10:20:12.990497Z","end":"2026-06-10T10:20:13.445916Z","steps":["trace[1999407005] 'range keys from in-memory index tree' (duration: 455.155993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:13.445981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:12.990477Z","time spent":"455.49032ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T10:20:13.445973Z","caller":"traceutil/trace.go:171","msg":"trace[407855470] linearizableReadLoop","detail":"{readStateIndex:2169; appliedIndex:2168; }","duration":"294.961477ms","start":"2026-06-10T10:20:13.150978Z","end":"2026-06-10T10:20:13.445939Z","steps":["trace[407855470] 'read index received' (duration: 292.863488ms)","trace[407855470] 'applied index is now lower than readState.Index' (duration: 2.096689ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:20:13.446035Z","caller":"traceutil/trace.go:171","msg":"trace[1870071429] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"377.233385ms","start":"2026-06-10T10:20:13.068771Z","end":"2026-06-10T10:20:13.446004Z","steps":["trace[1870071429] 'process raft request' (duration: 375.057055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:13.44615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.54869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-10T10:20:13.44617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:13.068752Z","time spent":"377.344808ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:20:13.446207Z","caller":"traceutil/trace.go:171","msg":"trace[1551091162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2084; }","duration":"402.660902ms","start":"2026-06-10T10:20:13.043529Z","end":"2026-06-10T10:20:13.44619Z","steps":["trace[1551091162] 'range keys from in-memory index tree' (duration: 402.102712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:13.4462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.209822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:20:13.446279Z","caller":"traceutil/trace.go:171","msg":"trace[1854874107] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2085; }","duration":"295.295493ms","start":"2026-06-10T10:20:13.150964Z","end":"2026-06-10T10:20:13.44626Z","steps":["trace[1854874107] 'agreement among raft nodes before linearized reading' (duration: 295.086089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:13.446434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:13.043508Z","time spent":"402.736373ms","remote":"127.0.0.1:44446","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-06-10T10:20:19.803881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.40368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T10:20:19.803955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.35697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:19.803994Z","caller":"traceutil/trace.go:171","msg":"trace[1027347425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2117; }","duration":"317.557414ms","start":"2026-06-10T10:20:19.48641Z","end":"2026-06-10T10:20:19.803967Z","steps":["trace[1027347425] 'range keys from in-memory index tree' (duration: 317.148576ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:19.804018Z","caller":"traceutil/trace.go:171","msg":"trace[798203667] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:2117; }","duration":"208.476653ms","start":"2026-06-10T10:20:19.595524Z","end":"2026-06-10T10:20:19.804001Z","steps":["trace[798203667] 'count revisions from in-memory index tree' (duration: 208.213788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:19.804057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:19.486397Z","time spent":"317.645185ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:20:19.804157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.416404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:20:19.804245Z","caller":"traceutil/trace.go:171","msg":"trace[1433404034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2117; }","duration":"315.553467ms","start":"2026-06-10T10:20:19.48867Z","end":"2026-06-10T10:20:19.804223Z","steps":["trace[1433404034] 'range keys from in-memory index tree' (duration: 315.20778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:19.804286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:19.488639Z","time spent":"315.637778ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-10T10:20:19.804375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.272611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-06-10T10:20:19.804421Z","caller":"traceutil/trace.go:171","msg":"trace[1578215063] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2117; }","duration":"125.369753ms","start":"2026-06-10T10:20:19.679033Z","end":"2026-06-10T10:20:19.804403Z","steps":["trace[1578215063] 'range keys from in-memory index tree' (duration: 125.139648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:19.804906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.446758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:20:19.804968Z","caller":"traceutil/trace.go:171","msg":"trace[615990704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2117; }","duration":"319.55535ms","start":"2026-06-10T10:20:19.4854Z","end":"2026-06-10T10:20:19.804956Z","steps":["trace[615990704] 'range keys from in-memory index tree' (duration: 319.319626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:19.805005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:19.485375Z","time spent":"319.620252ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:20:19.805287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.929255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b7b1044411f17b\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-10T10:20:19.8054Z","caller":"traceutil/trace.go:171","msg":"trace[1806237245] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b7b1044411f17b; range_end:; response_count:1; response_revision:2117; }","duration":"221.477434ms","start":"2026-06-10T10:20:19.583893Z","end":"2026-06-10T10:20:19.805371Z","steps":["trace[1806237245] 'range keys from in-memory index tree' (duration: 219.699721ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:19.925686Z","caller":"traceutil/trace.go:171","msg":"trace[1735905393] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"117.255423ms","start":"2026-06-10T10:20:19.808399Z","end":"2026-06-10T10:20:19.925654Z","steps":["trace[1735905393] 'process raft request' (duration: 117.047809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:20.385705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.435976ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-06-10T10:20:20.385972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:19.80924Z","time spent":"576.726555ms","remote":"127.0.0.1:44260","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T10:20:20.386199Z","caller":"traceutil/trace.go:171","msg":"trace[1111874293] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"178.066814ms","start":"2026-06-10T10:20:20.20805Z","end":"2026-06-10T10:20:20.386117Z","steps":["trace[1111874293] 'process raft request' (duration: 178.006203ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:20.386196Z","caller":"traceutil/trace.go:171","msg":"trace[55065676] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"576.678184ms","start":"2026-06-10T10:20:19.809461Z","end":"2026-06-10T10:20:20.386139Z","steps":["trace[55065676] 'process raft request' (duration: 576.345218ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:20.386352Z","caller":"traceutil/trace.go:171","msg":"trace[531603411] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2202; }","duration":"574.112567ms","start":"2026-06-10T10:20:19.812227Z","end":"2026-06-10T10:20:20.38634Z","steps":["trace[531603411] 'read index received' (duration: 113.33407ms)","trace[531603411] 'applied index is now lower than readState.Index' (duration: 460.777377ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:20.38645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.231798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:20.386494Z","caller":"traceutil/trace.go:171","msg":"trace[168576156] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2120; }","duration":"574.322771ms","start":"2026-06-10T10:20:19.812145Z","end":"2026-06-10T10:20:20.386468Z","steps":["trace[168576156] 'agreement among raft nodes before linearized reading' (duration: 574.25301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:20.386522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:19.812128Z","time spent":"574.386542ms","remote":"127.0.0.1:44618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-10T10:20:20.386651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:19.809448Z","time spent":"576.823066ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:20:20.448495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.918955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-06-10T10:20:20.448558Z","caller":"traceutil/trace.go:171","msg":"trace[2053571818] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2122; }","duration":"162.020928ms","start":"2026-06-10T10:20:20.28652Z","end":"2026-06-10T10:20:20.448541Z","steps":["trace[2053571818] 'agreement among raft nodes before linearized reading' (duration: 161.885155ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:20.448696Z","caller":"traceutil/trace.go:171","msg":"trace[1077517012] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"196.182009ms","start":"2026-06-10T10:20:20.252505Z","end":"2026-06-10T10:20:20.448687Z","steps":["trace[1077517012] 'process raft request' (duration: 195.730021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:20.448766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.803192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-10T10:20:20.448794Z","caller":"traceutil/trace.go:171","msg":"trace[1269749865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2122; }","duration":"289.848482ms","start":"2026-06-10T10:20:20.158939Z","end":"2026-06-10T10:20:20.448788Z","steps":["trace[1269749865] 'agreement among raft nodes before linearized reading' (duration: 289.778241ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:20.448814Z","caller":"traceutil/trace.go:171","msg":"trace[1219265092] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"192.854958ms","start":"2026-06-10T10:20:20.25595Z","end":"2026-06-10T10:20:20.448805Z","steps":["trace[1219265092] 'process raft request' (duration: 192.4078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:20.448498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.363696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:20.448888Z","caller":"traceutil/trace.go:171","msg":"trace[1165509052] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2122; }","duration":"100.799795ms","start":"2026-06-10T10:20:20.348082Z","end":"2026-06-10T10:20:20.448881Z","steps":["trace[1165509052] 'agreement among raft nodes before linearized reading' (duration: 100.310056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:20.449021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.343055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:20:20.449045Z","caller":"traceutil/trace.go:171","msg":"trace[1034017832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2122; }","duration":"294.406417ms","start":"2026-06-10T10:20:20.154633Z","end":"2026-06-10T10:20:20.449039Z","steps":["trace[1034017832] 'agreement among raft nodes before linearized reading' (duration: 294.342806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:20.449136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.890759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-10T10:20:20.449158Z","caller":"traceutil/trace.go:171","msg":"trace[1123371367] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2122; }","duration":"298.946911ms","start":"2026-06-10T10:20:20.150206Z","end":"2026-06-10T10:20:20.449153Z","steps":["trace[1123371367] 'agreement among raft nodes before linearized reading' (duration: 298.88956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.255461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.584932ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:20:21.255629Z","caller":"traceutil/trace.go:171","msg":"trace[889237708] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"867.173056ms","start":"2026-06-10T10:20:20.388424Z","end":"2026-06-10T10:20:21.255597Z","steps":["trace[889237708] 'process raft request' (duration: 131.35738ms)","trace[889237708] 'compare' (duration: 735.332497ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:20:21.255796Z","caller":"traceutil/trace.go:171","msg":"trace[1487904335] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"318.75663ms","start":"2026-06-10T10:20:20.937021Z","end":"2026-06-10T10:20:21.255777Z","steps":["trace[1487904335] 'process raft request' (duration: 318.716019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.255865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.936992Z","time spent":"318.841112ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:20:21.256047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.388393Z","time spent":"867.42675ms","remote":"127.0.0.1:44260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:20:21.256166Z","caller":"traceutil/trace.go:171","msg":"trace[252955977] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"798.875973ms","start":"2026-06-10T10:20:20.457231Z","end":"2026-06-10T10:20:21.256107Z","steps":["trace[252955977] 'process raft request' (duration: 798.335923ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:21.256279Z","caller":"traceutil/trace.go:171","msg":"trace[334140203] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"798.685589ms","start":"2026-06-10T10:20:20.457577Z","end":"2026-06-10T10:20:21.256263Z","steps":["trace[334140203] 'process raft request' (duration: 798.081357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.256406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.457567Z","time spent":"798.803411ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:20:21.256562Z","caller":"traceutil/trace.go:171","msg":"trace[448765965] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"798.942564ms","start":"2026-06-10T10:20:20.457609Z","end":"2026-06-10T10:20:21.256552Z","steps":["trace[448765965] 'process raft request' (duration: 798.088648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.256626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.457601Z","time spent":"798.993265ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:20:21.256482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.457207Z","time spent":"799.056606ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:20:21.256943Z","caller":"traceutil/trace.go:171","msg":"trace[1079174081] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"808.539551ms","start":"2026-06-10T10:20:20.448387Z","end":"2026-06-10T10:20:21.256927Z","steps":["trace[1079174081] 'read index received' (duration: 71.400451ms)","trace[1079174081] 'applied index is now lower than readState.Index' (duration: 737.1368ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:21.257296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.135813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:21.257348Z","caller":"traceutil/trace.go:171","msg":"trace[1677305187] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2127; }","duration":"815.405578ms","start":"2026-06-10T10:20:20.441932Z","end":"2026-06-10T10:20:21.257337Z","steps":["trace[1677305187] 'agreement among raft nodes before linearized reading' (duration: 815.319427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.257384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.441909Z","time spent":"815.466789ms","remote":"127.0.0.1:44464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:20:21.257506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.744506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:21.257585Z","caller":"traceutil/trace.go:171","msg":"trace[1685831314] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2127; }","duration":"867.812967ms","start":"2026-06-10T10:20:20.389729Z","end":"2026-06-10T10:20:21.257542Z","steps":["trace[1685831314] 'agreement among raft nodes before linearized reading' (duration: 867.739476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.257619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.38972Z","time spent":"867.891729ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-10T10:20:21.320247Z","caller":"traceutil/trace.go:171","msg":"trace[888189987] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"368.267944ms","start":"2026-06-10T10:20:20.951958Z","end":"2026-06-10T10:20:21.320226Z","steps":["trace[888189987] 'process raft request' (duration: 368.102441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.320458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.951922Z","time spent":"368.393427ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:20:21.32046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.924785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:20:21.320528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.203713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:21.32061Z","caller":"traceutil/trace.go:171","msg":"trace[1957418461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2128; }","duration":"863.14562ms","start":"2026-06-10T10:20:20.457439Z","end":"2026-06-10T10:20:21.320584Z","steps":["trace[1957418461] 'agreement among raft nodes before linearized reading' (duration: 862.831244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.320564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.116152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:20:21.320651Z","caller":"traceutil/trace.go:171","msg":"trace[631337800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2128; }","duration":"735.434686ms","start":"2026-06-10T10:20:20.585197Z","end":"2026-06-10T10:20:21.320631Z","steps":["trace[631337800] 'agreement among raft nodes before linearized reading' (duration: 735.189612ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:21.320797Z","caller":"traceutil/trace.go:171","msg":"trace[614519692] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2128; }","duration":"508.360366ms","start":"2026-06-10T10:20:20.812387Z","end":"2026-06-10T10:20:21.320748Z","steps":["trace[614519692] 'agreement among raft nodes before linearized reading' (duration: 507.910067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:21.320781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.585179Z","time spent":"735.59189ms","remote":"127.0.0.1:44182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:20:21.32072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.457429Z","time spent":"863.252561ms","remote":"127.0.0.1:44180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:20:21.320973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:20.812368Z","time spent":"508.58769ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-10T10:20:22.457168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058154595s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T10:20:22.457298Z","caller":"traceutil/trace.go:171","msg":"trace[661091541] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2214; }","duration":"871.664311ms","start":"2026-06-10T10:20:21.585612Z","end":"2026-06-10T10:20:22.457276Z","steps":["trace[661091541] 'read index received' (duration: 54.642µs)","trace[661091541] 'applied index is now lower than readState.Index' (duration: 871.607159ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:22.457695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.068208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:22.457776Z","caller":"traceutil/trace.go:171","msg":"trace[385161117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2128; }","duration":"872.187559ms","start":"2026-06-10T10:20:21.585571Z","end":"2026-06-10T10:20:22.457758Z","steps":["trace[385161117] 'agreement among raft nodes before linearized reading' (duration: 872.043857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:22.457822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:21.585532Z","time spent":"872.281622ms","remote":"127.0.0.1:44180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:20:22.589667Z","caller":"traceutil/trace.go:171","msg":"trace[1590013933] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"436.191126ms","start":"2026-06-10T10:20:22.153447Z","end":"2026-06-10T10:20:22.589638Z","steps":["trace[1590013933] 'process raft request' (duration: 436.016103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:22.589973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.153424Z","time spent":"436.324668ms","remote":"127.0.0.1:44354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:20:23.120953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.020735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:20:23.121438Z","caller":"traceutil/trace.go:171","msg":"trace[714059221] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"729.390691ms","start":"2026-06-10T10:20:22.392028Z","end":"2026-06-10T10:20:23.121418Z","steps":["trace[714059221] 'process raft request' (duration: 514.823596ms)","trace[714059221] 'compare' (duration: 213.886152ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:23.121512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.392004Z","time spent":"729.472652ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:20:23.121965Z","caller":"traceutil/trace.go:171","msg":"trace[1264301563] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"189.526903ms","start":"2026-06-10T10:20:22.932408Z","end":"2026-06-10T10:20:23.121935Z","steps":["trace[1264301563] 'process raft request' (duration: 189.470432ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:23.122239Z","caller":"traceutil/trace.go:171","msg":"trace[616397710] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"667.605992ms","start":"2026-06-10T10:20:22.454615Z","end":"2026-06-10T10:20:23.122221Z","steps":["trace[616397710] 'process raft request' (duration: 667.174644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.122445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.454606Z","time spent":"667.761924ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:20:23.122532Z","caller":"traceutil/trace.go:171","msg":"trace[915368660] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2215; }","duration":"664.895101ms","start":"2026-06-10T10:20:22.457624Z","end":"2026-06-10T10:20:23.122519Z","steps":["trace[915368660] 'read index received' (duration: 131.896203ms)","trace[915368660] 'applied index is now lower than readState.Index' (duration: 532.997648ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:23.122684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.048113ms","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-06-10T10:20:23.122709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.230878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-10T10:20:23.122721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.192369953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T10:20:23.122743Z","caller":"traceutil/trace.go:171","msg":"trace[1036690390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2133; }","duration":"730.153675ms","start":"2026-06-10T10:20:22.392576Z","end":"2026-06-10T10:20:23.12273Z","steps":["trace[1036690390] 'agreement among raft nodes before linearized reading' (duration: 729.997422ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:23.122752Z","caller":"traceutil/trace.go:171","msg":"trace[1514939344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2133; }","duration":"1.192492565s","start":"2026-06-10T10:20:21.930251Z","end":"2026-06-10T10:20:23.122744Z","steps":["trace[1514939344] 'agreement among raft nodes before linearized reading' (duration: 1.192362123s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.122773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.392561Z","time spent":"730.206146ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:20:23.122791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:21.930232Z","time spent":"1.192551596s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T10:20:23.122005Z","caller":"traceutil/trace.go:171","msg":"trace[174349925] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"667.837375ms","start":"2026-06-10T10:20:22.454154Z","end":"2026-06-10T10:20:23.121992Z","steps":["trace[174349925] 'process raft request' (duration: 667.215894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.122872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.100166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:23.122751Z","caller":"traceutil/trace.go:171","msg":"trace[1782186682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2133; }","duration":"793.30834ms","start":"2026-06-10T10:20:22.329432Z","end":"2026-06-10T10:20:23.12274Z","steps":["trace[1782186682] 'agreement among raft nodes before linearized reading' (duration: 793.140467ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:23.122954Z","caller":"traceutil/trace.go:171","msg":"trace[331348685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2133; }","duration":"664.228189ms","start":"2026-06-10T10:20:22.458708Z","end":"2026-06-10T10:20:23.122936Z","steps":["trace[331348685] 'agreement among raft nodes before linearized reading' (duration: 664.084606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.123014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.458695Z","time spent":"664.30064ms","remote":"127.0.0.1:44182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:20:23.122992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.329412Z","time spent":"793.568485ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-10T10:20:23.123025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:22.454134Z","time spent":"668.776792ms","remote":"127.0.0.1:44446","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-06-10T10:20:23.123795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.160538035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:20:23.123963Z","caller":"traceutil/trace.go:171","msg":"trace[2032978165] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2133; }","duration":"1.161459051s","start":"2026-06-10T10:20:21.962432Z","end":"2026-06-10T10:20:23.123891Z","steps":["trace[2032978165] 'agreement among raft nodes before linearized reading' (duration: 1.160157327s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.124231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:21.96241Z","time spent":"1.161658715s","remote":"127.0.0.1:45556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:20:23.430594Z","caller":"traceutil/trace.go:171","msg":"trace[1328834895] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"302.769937ms","start":"2026-06-10T10:20:23.127783Z","end":"2026-06-10T10:20:23.430553Z","steps":["trace[1328834895] 'process raft request' (duration: 283.37347ms)","trace[1328834895] 'compare' (duration: 19.247234ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:23.430801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:23.127743Z","time spent":"302.96054ms","remote":"127.0.0.1:44446","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-06-10T10:20:23.431378Z","caller":"traceutil/trace.go:171","msg":"trace[735868059] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2220; }","duration":"299.803562ms","start":"2026-06-10T10:20:23.131545Z","end":"2026-06-10T10:20:23.431348Z","steps":["trace[735868059] 'read index received' (duration: 279.773384ms)","trace[735868059] 'applied index is now lower than readState.Index' (duration: 20.028428ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:20:23.431515Z","caller":"traceutil/trace.go:171","msg":"trace[1994409380] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"168.079126ms","start":"2026-06-10T10:20:23.263414Z","end":"2026-06-10T10:20:23.431493Z","steps":["trace[1994409380] 'process raft request' (duration: 167.839412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.431682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.075047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:23.431812Z","caller":"traceutil/trace.go:171","msg":"trace[91608978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2136; }","duration":"300.269221ms","start":"2026-06-10T10:20:23.131525Z","end":"2026-06-10T10:20:23.431794Z","steps":["trace[91608978] 'agreement among raft nodes before linearized reading' (duration: 300.000376ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:23.431428Z","caller":"traceutil/trace.go:171","msg":"trace[1836325535] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"302.309968ms","start":"2026-06-10T10:20:23.129094Z","end":"2026-06-10T10:20:23.431404Z","steps":["trace[1836325535] 'process raft request' (duration: 302.017773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.431956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:23.131518Z","time spent":"300.395553ms","remote":"127.0.0.1:44180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:20:23.431999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:20:23.129065Z","time spent":"302.870088ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:20:23.43258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.781604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-10T10:20:23.432595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.826236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-10T10:20:23.432653Z","caller":"traceutil/trace.go:171","msg":"trace[799682926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2136; }","duration":"170.942568ms","start":"2026-06-10T10:20:23.261698Z","end":"2026-06-10T10:20:23.43264Z","steps":["trace[799682926] 'agreement among raft nodes before linearized reading' (duration: 170.773845ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:23.432652Z","caller":"traceutil/trace.go:171","msg":"trace[595947512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2136; }","duration":"171.911636ms","start":"2026-06-10T10:20:23.260723Z","end":"2026-06-10T10:20:23.432634Z","steps":["trace[595947512] 'agreement among raft nodes before linearized reading' (duration: 171.679752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:20:23.432597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.445339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-10T10:20:23.43286Z","caller":"traceutil/trace.go:171","msg":"trace[1882706173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2136; }","duration":"170.721715ms","start":"2026-06-10T10:20:23.262123Z","end":"2026-06-10T10:20:23.432844Z","steps":["trace[1882706173] 'agreement among raft nodes before linearized reading' (duration: 170.337178ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:45.685569Z","caller":"traceutil/trace.go:171","msg":"trace[562732037] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"124.960351ms","start":"2026-06-10T10:20:45.560586Z","end":"2026-06-10T10:20:45.685547Z","steps":["trace[562732037] 'process raft request' (duration: 124.89615ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:45.685571Z","caller":"traceutil/trace.go:171","msg":"trace[1479856000] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"125.007242ms","start":"2026-06-10T10:20:45.560543Z","end":"2026-06-10T10:20:45.685551Z","steps":["trace[1479856000] 'process raft request' (duration: 112.535378ms)","trace[1479856000] 'compare' (duration: 12.303261ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:20:45.685893Z","caller":"traceutil/trace.go:171","msg":"trace[1296036000] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"124.051615ms","start":"2026-06-10T10:20:45.561828Z","end":"2026-06-10T10:20:45.68588Z","steps":["trace[1296036000] 'process raft request' (duration: 123.911692ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:45.685898Z","caller":"traceutil/trace.go:171","msg":"trace[568218] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"125.267597ms","start":"2026-06-10T10:20:45.560605Z","end":"2026-06-10T10:20:45.685872Z","steps":["trace[568218] 'process raft request' (duration: 124.90788ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:20:45.685891Z","caller":"traceutil/trace.go:171","msg":"trace[386543397] linearizableReadLoop","detail":"{readStateIndex:2346; appliedIndex:2342; }","duration":"100.182496ms","start":"2026-06-10T10:20:45.585679Z","end":"2026-06-10T10:20:45.685862Z","steps":["trace[386543397] 'read index received' (duration: 87.466548ms)","trace[386543397] 'applied index is now lower than readState.Index' (duration: 12.714538ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:20:45.686112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.40664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:20:45.686177Z","caller":"traceutil/trace.go:171","msg":"trace[342698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2255; }","duration":"100.520693ms","start":"2026-06-10T10:20:45.58564Z","end":"2026-06-10T10:20:45.686161Z","steps":["trace[342698] 'agreement among raft nodes before linearized reading' (duration: 100.38446ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:21:16.52176Z","caller":"traceutil/trace.go:171","msg":"trace[1547281803] linearizableReadLoop","detail":"{readStateIndex:2567; appliedIndex:2566; }","duration":"153.732765ms","start":"2026-06-10T10:21:16.368Z","end":"2026-06-10T10:21:16.521733Z","steps":["trace[1547281803] 'read index received' (duration: 152.228488ms)","trace[1547281803] 'applied index is now lower than readState.Index' (duration: 1.502867ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:21:16.521996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.96896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-10T10:21:16.522036Z","caller":"traceutil/trace.go:171","msg":"trace[1060459329] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2468; }","duration":"154.051731ms","start":"2026-06-10T10:21:16.367974Z","end":"2026-06-10T10:21:16.522025Z","steps":["trace[1060459329] 'agreement among raft nodes before linearized reading' (duration: 153.860207ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:21:25.591487Z","caller":"traceutil/trace.go:171","msg":"trace[450243641] transaction","detail":"{read_only:false; response_revision:2569; number_of_response:1; }","duration":"258.014703ms","start":"2026-06-10T10:21:25.333453Z","end":"2026-06-10T10:21:25.591468Z","steps":["trace[450243641] 'process raft request' (duration: 257.872361ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:21:25.665511Z","caller":"traceutil/trace.go:171","msg":"trace[1135256714] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"314.530576ms","start":"2026-06-10T10:21:25.350962Z","end":"2026-06-10T10:21:25.665492Z","steps":["trace[1135256714] 'process raft request' (duration: 314.017977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:25.665639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:21:25.350931Z","time spent":"314.638058ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:21:25.665791Z","caller":"traceutil/trace.go:171","msg":"trace[911100567] transaction","detail":"{read_only:false; response_revision:2571; number_of_response:1; }","duration":"286.453728ms","start":"2026-06-10T10:21:25.379326Z","end":"2026-06-10T10:21:25.66578Z","steps":["trace[911100567] 'process raft request' (duration: 285.768316ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:21:57.800158Z","caller":"traceutil/trace.go:171","msg":"trace[648824109] transaction","detail":"{read_only:false; response_revision:2746; number_of_response:1; }","duration":"100.168927ms","start":"2026-06-10T10:21:57.69996Z","end":"2026-06-10T10:21:57.800128Z","steps":["trace[648824109] 'process raft request' (duration: 100.005262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.238969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.27686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:21:58.239186Z","caller":"traceutil/trace.go:171","msg":"trace[2131748594] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"477.265587ms","start":"2026-06-10T10:21:57.761889Z","end":"2026-06-10T10:21:58.239155Z","steps":["trace[2131748594] 'process raft request' (duration: 312.680376ms)","trace[2131748594] 'compare' (duration: 164.030592ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:21:58.239208Z","caller":"traceutil/trace.go:171","msg":"trace[800444492] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"469.586198ms","start":"2026-06-10T10:21:57.769605Z","end":"2026-06-10T10:21:58.239191Z","steps":["trace[800444492] 'process raft request' (duration: 469.462994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.239295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:21:57.769586Z","time spent":"469.675392ms","remote":"127.0.0.1:44446","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-06-10T10:21:58.239336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:21:57.761867Z","time spent":"477.390831ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:21:58.239448Z","caller":"traceutil/trace.go:171","msg":"trace[1189251865] linearizableReadLoop","detail":"{readStateIndex:2857; appliedIndex:2854; }","duration":"323.317445ms","start":"2026-06-10T10:21:57.916087Z","end":"2026-06-10T10:21:58.239405Z","steps":["trace[1189251865] 'read index received' (duration: 158.435185ms)","trace[1189251865] 'applied index is now lower than readState.Index' (duration: 164.87997ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:21:58.239615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.531893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:21:58.239655Z","caller":"traceutil/trace.go:171","msg":"trace[1738856633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2749; }","duration":"323.607805ms","start":"2026-06-10T10:21:57.916037Z","end":"2026-06-10T10:21:58.239645Z","steps":["trace[1738856633] 'agreement among raft nodes before linearized reading' (duration: 323.479681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.239685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:21:57.916015Z","time spent":"323.663938ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:21:58.239456Z","caller":"traceutil/trace.go:171","msg":"trace[11078584] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"454.262521ms","start":"2026-06-10T10:21:57.785136Z","end":"2026-06-10T10:21:58.239399Z","steps":["trace[11078584] 'process raft request' (duration: 454.017073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.239772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.295057ms","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-06-10T10:21:58.23981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:21:57.785113Z","time spent":"454.666385ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:21:58.239815Z","caller":"traceutil/trace.go:171","msg":"trace[495722506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2749; }","duration":"213.372261ms","start":"2026-06-10T10:21:58.026429Z","end":"2026-06-10T10:21:58.239801Z","steps":["trace[495722506] 'agreement among raft nodes before linearized reading' (duration: 213.240546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.239905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.415658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T10:21:58.239952Z","caller":"traceutil/trace.go:171","msg":"trace[317903344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2749; }","duration":"198.500431ms","start":"2026-06-10T10:21:58.041443Z","end":"2026-06-10T10:21:58.239943Z","steps":["trace[317903344] 'agreement among raft nodes before linearized reading' (duration: 198.390407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.240064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.698089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-10T10:21:58.240115Z","caller":"traceutil/trace.go:171","msg":"trace[1407978576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2749; }","duration":"207.768702ms","start":"2026-06-10T10:21:58.032333Z","end":"2026-06-10T10:21:58.240101Z","steps":["trace[1407978576] 'agreement among raft nodes before linearized reading' (duration: 207.616137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.240081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.045107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-10T10:21:58.240731Z","caller":"traceutil/trace.go:171","msg":"trace[1450353822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2749; }","duration":"182.753801ms","start":"2026-06-10T10:21:58.057959Z","end":"2026-06-10T10:21:58.240713Z","steps":["trace[1450353822] 'agreement among raft nodes before linearized reading' (duration: 181.785469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.786542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.319552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:21:58.786568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.866797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b7b118fa440715\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-10T10:21:58.786652Z","caller":"traceutil/trace.go:171","msg":"trace[1743308136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2754; }","duration":"203.467317ms","start":"2026-06-10T10:21:58.583143Z","end":"2026-06-10T10:21:58.786611Z","steps":["trace[1743308136] 'range keys from in-memory index tree' (duration: 203.24404ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:21:58.786655Z","caller":"traceutil/trace.go:171","msg":"trace[1133245203] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b7b118fa440715; range_end:; response_count:1; response_revision:2754; }","duration":"299.998932ms","start":"2026-06-10T10:21:58.486619Z","end":"2026-06-10T10:21:58.786633Z","steps":["trace[1133245203] 'range keys from in-memory index tree' (duration: 299.63972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:21:58.786702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:21:58.4866Z","time spent":"300.091645ms","remote":"127.0.0.1:44260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":804,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b7b118fa440715\" "} {"level":"info","ts":"2026-06-10T10:22:04.254786Z","caller":"traceutil/trace.go:171","msg":"trace[1023365786] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"413.045337ms","start":"2026-06-10T10:22:03.841701Z","end":"2026-06-10T10:22:04.254747Z","steps":["trace[1023365786] 'process raft request' (duration: 411.593129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:22:04.255031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:22:03.841668Z","time spent":"413.234453ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:25:02.287615Z","caller":"traceutil/trace.go:171","msg":"trace[902585885] transaction","detail":"{read_only:false; response_revision:3850; number_of_response:1; }","duration":"144.569053ms","start":"2026-06-10T10:25:02.143001Z","end":"2026-06-10T10:25:02.28757Z","steps":["trace[902585885] 'process raft request' (duration: 91.234045ms)","trace[902585885] 'compare' (duration: 53.038442ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:03.1264Z","caller":"traceutil/trace.go:171","msg":"trace[290477307] transaction","detail":"{read_only:false; response_revision:3866; number_of_response:1; }","duration":"131.094119ms","start":"2026-06-10T10:25:02.99527Z","end":"2026-06-10T10:25:03.126364Z","steps":["trace[290477307] 'process raft request' (duration: 118.744954ms)","trace[290477307] 'compare' (duration: 12.15474ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:03.142094Z","caller":"traceutil/trace.go:171","msg":"trace[771566162] transaction","detail":"{read_only:false; response_revision:3867; number_of_response:1; }","duration":"102.957722ms","start":"2026-06-10T10:25:03.039114Z","end":"2026-06-10T10:25:03.142072Z","steps":["trace[771566162] 'process raft request' (duration: 102.751048ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:03.427176Z","caller":"traceutil/trace.go:171","msg":"trace[1054691543] transaction","detail":"{read_only:false; response_revision:3876; number_of_response:1; }","duration":"155.506922ms","start":"2026-06-10T10:25:03.271641Z","end":"2026-06-10T10:25:03.427148Z","steps":["trace[1054691543] 'process raft request' (duration: 155.302958ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:03.5239Z","caller":"traceutil/trace.go:171","msg":"trace[349090744] transaction","detail":"{read_only:false; response_revision:3877; number_of_response:1; }","duration":"169.976755ms","start":"2026-06-10T10:25:03.353874Z","end":"2026-06-10T10:25:03.52385Z","steps":["trace[349090744] 'process raft request' (duration: 96.534299ms)","trace[349090744] 'compare' (duration: 73.252151ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:27.418966Z","caller":"traceutil/trace.go:171","msg":"trace[634070302] transaction","detail":"{read_only:false; response_revision:4013; number_of_response:1; }","duration":"170.788121ms","start":"2026-06-10T10:25:27.248154Z","end":"2026-06-10T10:25:27.418942Z","steps":["trace[634070302] 'process raft request' (duration: 170.647588ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:27.504531Z","caller":"traceutil/trace.go:171","msg":"trace[724547341] transaction","detail":"{read_only:false; response_revision:4014; number_of_response:1; }","duration":"248.133747ms","start":"2026-06-10T10:25:27.256371Z","end":"2026-06-10T10:25:27.504505Z","steps":["trace[724547341] 'process raft request' (duration: 229.841341ms)","trace[724547341] 'compare' (duration: 18.094482ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:27.504735Z","caller":"traceutil/trace.go:171","msg":"trace[284175884] transaction","detail":"{read_only:false; response_revision:4015; number_of_response:1; }","duration":"212.26137ms","start":"2026-06-10T10:25:27.292466Z","end":"2026-06-10T10:25:27.504728Z","steps":["trace[284175884] 'process raft request' (duration: 212.014155ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:27.504903Z","caller":"traceutil/trace.go:171","msg":"trace[241436096] transaction","detail":"{read_only:false; response_revision:4016; number_of_response:1; }","duration":"187.160117ms","start":"2026-06-10T10:25:27.317725Z","end":"2026-06-10T10:25:27.504885Z","steps":["trace[241436096] 'process raft request' (duration: 186.944712ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:29.561822Z","caller":"traceutil/trace.go:171","msg":"trace[1524913881] transaction","detail":"{read_only:false; response_revision:4025; number_of_response:1; }","duration":"105.360979ms","start":"2026-06-10T10:25:29.456427Z","end":"2026-06-10T10:25:29.561788Z","steps":["trace[1524913881] 'process raft request' (duration: 29.987329ms)","trace[1524913881] 'compare' (duration: 75.101874ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:54.797982Z","caller":"traceutil/trace.go:171","msg":"trace[998569225] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"129.326442ms","start":"2026-06-10T10:25:54.66862Z","end":"2026-06-10T10:25:54.797947Z","steps":["trace[998569225] 'process raft request' (duration: 100.227547ms)","trace[998569225] 'compare' (duration: 28.956522ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:02.864479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.519931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:26:02.864591Z","caller":"traceutil/trace.go:171","msg":"trace[1021709683] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"163.745905ms","start":"2026-06-10T10:26:02.700824Z","end":"2026-06-10T10:26:02.86457Z","steps":["trace[1021709683] 'process raft request' (duration: 62.062731ms)","trace[1021709683] 'compare' (duration: 101.088811ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:03.40964Z","caller":"traceutil/trace.go:171","msg":"trace[1676353832] linearizableReadLoop","detail":"{readStateIndex:4934; appliedIndex:4932; }","duration":"692.41917ms","start":"2026-06-10T10:26:02.717198Z","end":"2026-06-10T10:26:03.409618Z","steps":["trace[1676353832] 'read index received' (duration: 45.77109ms)","trace[1676353832] 'applied index is now lower than readState.Index' (duration: 646.64702ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:03.409727Z","caller":"traceutil/trace.go:171","msg":"trace[1657733785] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"700.153161ms","start":"2026-06-10T10:26:02.70953Z","end":"2026-06-10T10:26:03.409683Z","steps":["trace[1657733785] 'process raft request' (duration: 699.949327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:03.409928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:02.709515Z","time spent":"700.300205ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16384,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:03.410001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.780947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-10T10:26:03.410079Z","caller":"traceutil/trace.go:171","msg":"trace[1804106209] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4748; }","duration":"692.871689ms","start":"2026-06-10T10:26:02.717162Z","end":"2026-06-10T10:26:03.410033Z","steps":["trace[1804106209] 'agreement among raft nodes before linearized reading' (duration: 692.540822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:03.410155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:02.717144Z","time spent":"692.973371ms","remote":"127.0.0.1:44350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-06-10T10:26:03.693755Z","caller":"traceutil/trace.go:171","msg":"trace[609295832] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"101.10315ms","start":"2026-06-10T10:26:03.592379Z","end":"2026-06-10T10:26:03.693482Z","steps":["trace[609295832] 'process raft request' (duration: 20.847957ms)","trace[609295832] 'compare' (duration: 80.065669ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:04.159967Z","caller":"traceutil/trace.go:171","msg":"trace[1407969081] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"228.902616ms","start":"2026-06-10T10:26:03.931028Z","end":"2026-06-10T10:26:04.159931Z","steps":["trace[1407969081] 'process raft request' (duration: 222.574123ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:04.160027Z","caller":"traceutil/trace.go:171","msg":"trace[569493332] linearizableReadLoop","detail":"{readStateIndex:4943; appliedIndex:4939; }","duration":"184.000944ms","start":"2026-06-10T10:26:03.976001Z","end":"2026-06-10T10:26:04.160002Z","steps":["trace[569493332] 'read index received' (duration: 30.894127ms)","trace[569493332] 'applied index is now lower than readState.Index' (duration: 153.105997ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:04.160216Z","caller":"traceutil/trace.go:171","msg":"trace[1692776625] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"228.621641ms","start":"2026-06-10T10:26:03.931583Z","end":"2026-06-10T10:26:04.160205Z","steps":["trace[1692776625] 'process raft request' (duration: 228.334405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:04.160522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.26163ms","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-06-10T10:26:04.160593Z","caller":"traceutil/trace.go:171","msg":"trace[2042169269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4757; }","duration":"184.363542ms","start":"2026-06-10T10:26:03.976211Z","end":"2026-06-10T10:26:04.160575Z","steps":["trace[2042169269] 'agreement among raft nodes before linearized reading' (duration: 184.164078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:04.160683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.236449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T10:26:04.160732Z","caller":"traceutil/trace.go:171","msg":"trace[532926759] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4757; }","duration":"173.319512ms","start":"2026-06-10T10:26:03.987401Z","end":"2026-06-10T10:26:04.16072Z","steps":["trace[532926759] 'agreement among raft nodes before linearized reading' (duration: 173.164778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:04.1608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.927008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:26:04.16084Z","caller":"traceutil/trace.go:171","msg":"trace[908379357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4757; }","duration":"178.98843ms","start":"2026-06-10T10:26:03.981841Z","end":"2026-06-10T10:26:04.160829Z","steps":["trace[908379357] 'agreement among raft nodes before linearized reading' (duration: 178.897258ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:04.160865Z","caller":"traceutil/trace.go:171","msg":"trace[1811205266] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"228.320714ms","start":"2026-06-10T10:26:03.932535Z","end":"2026-06-10T10:26:04.160855Z","steps":["trace[1811205266] 'process raft request' (duration: 227.432356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:04.161164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.36883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T10:26:04.16115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.236911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T10:26:04.161204Z","caller":"traceutil/trace.go:171","msg":"trace[286594167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4757; }","duration":"181.677645ms","start":"2026-06-10T10:26:03.979518Z","end":"2026-06-10T10:26:04.161196Z","steps":["trace[286594167] 'agreement among raft nodes before linearized reading' (duration: 181.43372ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:04.161229Z","caller":"traceutil/trace.go:171","msg":"trace[487693707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4757; }","duration":"185.410974ms","start":"2026-06-10T10:26:03.975799Z","end":"2026-06-10T10:26:04.16121Z","steps":["trace[487693707] 'agreement among raft nodes before linearized reading' (duration: 185.121958ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:06.420757Z","caller":"traceutil/trace.go:171","msg":"trace[1853505089] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"254.115834ms","start":"2026-06-10T10:26:06.166615Z","end":"2026-06-10T10:26:06.420731Z","steps":["trace[1853505089] 'process raft request' (duration: 253.94017ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:06.435361Z","caller":"traceutil/trace.go:171","msg":"trace[1136023486] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"268.208568ms","start":"2026-06-10T10:26:06.167133Z","end":"2026-06-10T10:26:06.435341Z","steps":["trace[1136023486] 'process raft request' (duration: 268.076805ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:06.435529Z","caller":"traceutil/trace.go:171","msg":"trace[1933720172] linearizableReadLoop","detail":"{readStateIndex:4964; appliedIndex:4961; }","duration":"251.041989ms","start":"2026-06-10T10:26:06.184473Z","end":"2026-06-10T10:26:06.435515Z","steps":["trace[1933720172] 'read index received' (duration: 236.157008ms)","trace[1933720172] 'applied index is now lower than readState.Index' (duration: 14.883591ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:06.435718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.234313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:26:06.435779Z","caller":"traceutil/trace.go:171","msg":"trace[110263265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4778; }","duration":"251.323675ms","start":"2026-06-10T10:26:06.184442Z","end":"2026-06-10T10:26:06.435766Z","steps":["trace[110263265] 'agreement among raft nodes before linearized reading' (duration: 251.175082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:06.435923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.242685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-10T10:26:06.436028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.816066ms","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-06-10T10:26:06.436051Z","caller":"traceutil/trace.go:171","msg":"trace[289650451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4778; }","duration":"219.878107ms","start":"2026-06-10T10:26:06.216168Z","end":"2026-06-10T10:26:06.436046Z","steps":["trace[289650451] 'agreement among raft nodes before linearized reading' (duration: 219.705043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:06.436161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.622232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:26:06.436245Z","caller":"traceutil/trace.go:171","msg":"trace[1861666432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4778; }","duration":"219.755085ms","start":"2026-06-10T10:26:06.21647Z","end":"2026-06-10T10:26:06.436225Z","steps":["trace[1861666432] 'agreement among raft nodes before linearized reading' (duration: 219.455498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:06.436207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.021411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T10:26:06.436334Z","caller":"traceutil/trace.go:171","msg":"trace[486257580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4778; }","duration":"220.157214ms","start":"2026-06-10T10:26:06.216154Z","end":"2026-06-10T10:26:06.436312Z","steps":["trace[486257580] 'agreement among raft nodes before linearized reading' (duration: 219.773115ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:06.435971Z","caller":"traceutil/trace.go:171","msg":"trace[884471260] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4778; }","duration":"220.339057ms","start":"2026-06-10T10:26:06.215619Z","end":"2026-06-10T10:26:06.435958Z","steps":["trace[884471260] 'agreement among raft nodes before linearized reading' (duration: 220.187244ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:06.436406Z","caller":"traceutil/trace.go:171","msg":"trace[1326066430] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"268.29755ms","start":"2026-06-10T10:26:06.167554Z","end":"2026-06-10T10:26:06.435852Z","steps":["trace[1326066430] 'process raft request' (duration: 267.747408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.344303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.173306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:26:11.34446Z","caller":"traceutil/trace.go:171","msg":"trace[1742180905] linearizableReadLoop","detail":"{readStateIndex:5085; appliedIndex:5083; }","duration":"886.165789ms","start":"2026-06-10T10:26:10.458279Z","end":"2026-06-10T10:26:11.344444Z","steps":["trace[1742180905] 'read index received' (duration: 8.992008ms)","trace[1742180905] 'applied index is now lower than readState.Index' (duration: 877.172541ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:11.344693Z","caller":"traceutil/trace.go:171","msg":"trace[209919043] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"899.400005ms","start":"2026-06-10T10:26:10.445277Z","end":"2026-06-10T10:26:11.344676Z","steps":["trace[209919043] 'process raft request' (duration: 427.77504ms)","trace[209919043] 'compare' (duration: 471.043853ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:11.344754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.445265Z","time spent":"899.456396ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:11.34497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.00091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:26:11.345003Z","caller":"traceutil/trace.go:171","msg":"trace[1903228564] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4895; }","duration":"761.069871ms","start":"2026-06-10T10:26:10.583923Z","end":"2026-06-10T10:26:11.344992Z","steps":["trace[1903228564] 'agreement among raft nodes before linearized reading' (duration: 761.010659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.34504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.632159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-10T10:26:11.345041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.506698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T10:26:11.345119Z","caller":"traceutil/trace.go:171","msg":"trace[1403970955] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4895; }","duration":"877.624331ms","start":"2026-06-10T10:26:10.46748Z","end":"2026-06-10T10:26:11.345104Z","steps":["trace[1403970955] 'agreement among raft nodes before linearized reading' (duration: 877.410697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.345165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.46747Z","time spent":"877.684692ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:26:11.345207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.039381ms","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-06-10T10:26:11.345187Z","caller":"traceutil/trace.go:171","msg":"trace[1263242567] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"894.520343ms","start":"2026-06-10T10:26:10.450637Z","end":"2026-06-10T10:26:11.345157Z","steps":["trace[1263242567] 'process raft request' (duration: 893.755597ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:11.345252Z","caller":"traceutil/trace.go:171","msg":"trace[2054512316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4895; }","duration":"880.081842ms","start":"2026-06-10T10:26:10.46516Z","end":"2026-06-10T10:26:11.345242Z","steps":["trace[2054512316] 'agreement among raft nodes before linearized reading' (duration: 879.98224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.345271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.969196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T10:26:11.345298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.465122Z","time spent":"880.167674ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T10:26:11.345317Z","caller":"traceutil/trace.go:171","msg":"trace[832583782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4895; }","duration":"887.051167ms","start":"2026-06-10T10:26:10.458254Z","end":"2026-06-10T10:26:11.345305Z","steps":["trace[832583782] 'agreement among raft nodes before linearized reading' (duration: 886.840773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.345334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.450614Z","time spent":"894.648956ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:11.345349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.458245Z","time spent":"887.094938ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:26:11.345116Z","caller":"traceutil/trace.go:171","msg":"trace[483733967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4895; }","duration":"886.756461ms","start":"2026-06-10T10:26:10.458342Z","end":"2026-06-10T10:26:11.345099Z","steps":["trace[483733967] 'agreement among raft nodes before linearized reading' (duration: 886.527756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.345388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.458299Z","time spent":"887.078358ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:26:11.345393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.005581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-8q6f2\" ","response":"range_response_count:1 size:9855"} {"level":"warn","ts":"2026-06-10T10:26:11.345569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.089703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e06ea077-5ec7-4bd6-8ecb-41002e945771\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-10T10:26:11.345583Z","caller":"traceutil/trace.go:171","msg":"trace[842936184] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-8q6f2; range_end:; response_count:1; response_revision:4895; }","duration":"575.207106ms","start":"2026-06-10T10:26:10.770353Z","end":"2026-06-10T10:26:11.34556Z","steps":["trace[842936184] 'agreement among raft nodes before linearized reading' (duration: 574.847318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.345677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.770256Z","time spent":"575.40692ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9878,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-8q6f2\" "} {"level":"warn","ts":"2026-06-10T10:26:11.345745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.336426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"info","ts":"2026-06-10T10:26:11.345825Z","caller":"traceutil/trace.go:171","msg":"trace[1879248214] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4895; }","duration":"760.429568ms","start":"2026-06-10T10:26:10.585378Z","end":"2026-06-10T10:26:11.345808Z","steps":["trace[1879248214] 'agreement among raft nodes before linearized reading' (duration: 759.506538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.345875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.585318Z","time spent":"760.5452ms","remote":"127.0.0.1:44284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206989,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-06-10T10:26:11.346047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.5839Z","time spent":"762.125193ms","remote":"127.0.0.1:60686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:26:11.345614Z","caller":"traceutil/trace.go:171","msg":"trace[1419016207] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e06ea077-5ec7-4bd6-8ecb-41002e945771; range_end:; response_count:1; response_revision:4895; }","duration":"715.165324ms","start":"2026-06-10T10:26:10.630436Z","end":"2026-06-10T10:26:11.345601Z","steps":["trace[1419016207] 'agreement among raft nodes before linearized reading' (duration: 715.057502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.347379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.630426Z","time spent":"716.926341ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e06ea077-5ec7-4bd6-8ecb-41002e945771\" "} {"level":"warn","ts":"2026-06-10T10:26:11.347571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.737792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:26:11.347837Z","caller":"traceutil/trace.go:171","msg":"trace[1497308336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4895; }","duration":"889.006068ms","start":"2026-06-10T10:26:10.458816Z","end":"2026-06-10T10:26:11.347822Z","steps":["trace[1497308336] 'agreement among raft nodes before linearized reading' (duration: 886.615008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.347904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:10.458807Z","time spent":"889.08436ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:26:11.840341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.254419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:26:11.840462Z","caller":"traceutil/trace.go:171","msg":"trace[536298616] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"489.632561ms","start":"2026-06-10T10:26:11.350809Z","end":"2026-06-10T10:26:11.840442Z","steps":["trace[536298616] 'process raft request' (duration: 257.176758ms)","trace[536298616] 'compare' (duration: 232.107816ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:11.840536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.35079Z","time spent":"489.716194ms","remote":"127.0.0.1:44446","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-06-10T10:26:11.841266Z","caller":"traceutil/trace.go:171","msg":"trace[1823599986] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"489.716894ms","start":"2026-06-10T10:26:11.351522Z","end":"2026-06-10T10:26:11.841239Z","steps":["trace[1823599986] 'process raft request' (duration: 489.53967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.841436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.351503Z","time spent":"489.827546ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:11.841354Z","caller":"traceutil/trace.go:171","msg":"trace[41456444] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"489.737384ms","start":"2026-06-10T10:26:11.351592Z","end":"2026-06-10T10:26:11.84133Z","steps":["trace[41456444] 'process raft request' (duration: 489.55619ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:11.841517Z","caller":"traceutil/trace.go:171","msg":"trace[1985500427] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5085; }","duration":"470.720468ms","start":"2026-06-10T10:26:11.370784Z","end":"2026-06-10T10:26:11.841504Z","steps":["trace[1985500427] 'read index received' (duration: 237.204732ms)","trace[1985500427] 'applied index is now lower than readState.Index' (duration: 233.514906ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:11.841562Z","caller":"traceutil/trace.go:171","msg":"trace[2068631724] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"487.58483ms","start":"2026-06-10T10:26:11.353966Z","end":"2026-06-10T10:26:11.841551Z","steps":["trace[2068631724] 'process raft request' (duration: 487.449067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.841616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.353957Z","time spent":"487.63273ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:11.841755Z","caller":"traceutil/trace.go:171","msg":"trace[2126874371] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"486.681501ms","start":"2026-06-10T10:26:11.355058Z","end":"2026-06-10T10:26:11.841739Z","steps":["trace[2126874371] 'process raft request' (duration: 486.401155ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:11.841803Z","caller":"traceutil/trace.go:171","msg":"trace[965859969] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"490.154563ms","start":"2026-06-10T10:26:11.351635Z","end":"2026-06-10T10:26:11.841789Z","steps":["trace[965859969] 'process raft request' (duration: 489.739864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.84187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.351629Z","time spent":"490.210374ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:11.841892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.355039Z","time spent":"486.767912ms","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9667,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:11.842036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.659938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:11.842072Z","caller":"traceutil/trace.go:171","msg":"trace[156709259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4901; }","duration":"256.729459ms","start":"2026-06-10T10:26:11.585334Z","end":"2026-06-10T10:26:11.842063Z","steps":["trace[156709259] 'agreement among raft nodes before linearized reading' (duration: 256.648008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.842106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.351587Z","time spent":"489.945688ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:11.842391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.595366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-06-10T10:26:11.842453Z","caller":"traceutil/trace.go:171","msg":"trace[688989606] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4901; }","duration":"471.682038ms","start":"2026-06-10T10:26:11.370755Z","end":"2026-06-10T10:26:11.842437Z","steps":["trace[688989606] 'agreement among raft nodes before linearized reading' (duration: 471.481104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:11.842494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:11.370742Z","time spent":"471.741329ms","remote":"127.0.0.1:44270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1840,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-06-10T10:26:11.844296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.451845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-10T10:26:11.844357Z","caller":"traceutil/trace.go:171","msg":"trace[229909237] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4901; }","duration":"245.551027ms","start":"2026-06-10T10:26:11.59879Z","end":"2026-06-10T10:26:11.844341Z","steps":["trace[229909237] 'agreement among raft nodes before linearized reading' (duration: 243.422892ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:23.132784Z","caller":"traceutil/trace.go:171","msg":"trace[1723571132] linearizableReadLoop","detail":"{readStateIndex:5221; appliedIndex:5220; }","duration":"227.736354ms","start":"2026-06-10T10:26:22.905023Z","end":"2026-06-10T10:26:23.132759Z","steps":["trace[1723571132] 'read index received' (duration: 227.447678ms)","trace[1723571132] 'applied index is now lower than readState.Index' (duration: 287.616µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:23.132894Z","caller":"traceutil/trace.go:171","msg":"trace[1205045430] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"230.785677ms","start":"2026-06-10T10:26:22.902068Z","end":"2026-06-10T10:26:23.132854Z","steps":["trace[1205045430] 'process raft request' (duration: 230.553402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:23.132972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.935658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-10T10:26:23.133011Z","caller":"traceutil/trace.go:171","msg":"trace[1820981410] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5027; }","duration":"228.02445ms","start":"2026-06-10T10:26:22.904972Z","end":"2026-06-10T10:26:23.132997Z","steps":["trace[1820981410] 'agreement among raft nodes before linearized reading' (duration: 227.881307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:23.683324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1789510910150893370,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:24.14773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.136312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:26:24.148119Z","caller":"traceutil/trace.go:171","msg":"trace[2077587340] linearizableReadLoop","detail":"{readStateIndex:5227; appliedIndex:5221; }","duration":"965.856142ms","start":"2026-06-10T10:26:23.182245Z","end":"2026-06-10T10:26:24.148101Z","steps":["trace[2077587340] 'read index received' (duration: 763.272541ms)","trace[2077587340] 'applied index is now lower than readState.Index' (duration: 202.582651ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:24.148361Z","caller":"traceutil/trace.go:171","msg":"trace[1721759949] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"1.00933357s","start":"2026-06-10T10:26:23.139014Z","end":"2026-06-10T10:26:24.148347Z","steps":["trace[1721759949] 'process raft request' (duration: 806.488753ms)","trace[1721759949] 'compare' (duration: 201.427837ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:24.148399Z","caller":"traceutil/trace.go:171","msg":"trace[2111279941] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"768.71866ms","start":"2026-06-10T10:26:23.379638Z","end":"2026-06-10T10:26:24.148357Z","steps":["trace[2111279941] 'process raft request' (duration: 768.367273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.148441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.139Z","time spent":"1.009390901s","remote":"127.0.0.1:44352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:24.148514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.379613Z","time spent":"768.835003ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:24.148564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.062542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:24.148668Z","caller":"traceutil/trace.go:171","msg":"trace[1757415426] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"1.009530534s","start":"2026-06-10T10:26:23.139129Z","end":"2026-06-10T10:26:24.148659Z","steps":["trace[1757415426] 'process raft request' (duration: 1.008708147s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:24.14866Z","caller":"traceutil/trace.go:171","msg":"trace[1650983151] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:5034; }","duration":"559.199505ms","start":"2026-06-10T10:26:23.589433Z","end":"2026-06-10T10:26:24.148632Z","steps":["trace[1650983151] 'agreement among raft nodes before linearized reading' (duration: 559.061982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.148708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.13911Z","time spent":"1.009577155s","remote":"127.0.0.1:44352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:24.148728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.589417Z","time spent":"559.292567ms","remote":"127.0.0.1:49174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:26:24.148857Z","caller":"traceutil/trace.go:171","msg":"trace[623195128] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"1.009213747s","start":"2026-06-10T10:26:23.139637Z","end":"2026-06-10T10:26:24.14885Z","steps":["trace[623195128] 'process raft request' (duration: 1.008291508s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.148889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.139625Z","time spent":"1.009246928s","remote":"127.0.0.1:44450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:24.148983Z","caller":"traceutil/trace.go:171","msg":"trace[353514070] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"1.008804939s","start":"2026-06-10T10:26:23.140171Z","end":"2026-06-10T10:26:24.148976Z","steps":["trace[353514070] 'process raft request' (duration: 1.007800368s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.148948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.400845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T10:26:24.149025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.140163Z","time spent":"1.008839739s","remote":"127.0.0.1:44450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:24.149013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.08943ms","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-06-10T10:26:24.149047Z","caller":"traceutil/trace.go:171","msg":"trace[1866080703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5034; }","duration":"246.531499ms","start":"2026-06-10T10:26:23.902492Z","end":"2026-06-10T10:26:24.149023Z","steps":["trace[1866080703] 'agreement among raft nodes before linearized reading' (duration: 246.240263ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:24.149071Z","caller":"traceutil/trace.go:171","msg":"trace[1180360540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5034; }","duration":"247.182141ms","start":"2026-06-10T10:26:23.901872Z","end":"2026-06-10T10:26:24.149054Z","steps":["trace[1180360540] 'agreement among raft nodes before linearized reading' (duration: 247.010208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.149283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.322404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T10:26:24.14932Z","caller":"traceutil/trace.go:171","msg":"trace[1461534938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5034; }","duration":"245.375935ms","start":"2026-06-10T10:26:23.903932Z","end":"2026-06-10T10:26:24.149308Z","steps":["trace[1461534938] 'agreement among raft nodes before linearized reading' (duration: 245.270702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.149475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.347074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-10T10:26:24.149505Z","caller":"traceutil/trace.go:171","msg":"trace[207534072] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5034; }","duration":"199.373674ms","start":"2026-06-10T10:26:23.950121Z","end":"2026-06-10T10:26:24.149494Z","steps":["trace[207534072] 'agreement among raft nodes before linearized reading' (duration: 199.278433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.149688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.884942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T10:26:24.149773Z","caller":"traceutil/trace.go:171","msg":"trace[20937240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5034; }","duration":"241.019695ms","start":"2026-06-10T10:26:23.908732Z","end":"2026-06-10T10:26:24.149751Z","steps":["trace[20937240] 'agreement among raft nodes before linearized reading' (duration: 240.680248ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:24.149775Z","caller":"traceutil/trace.go:171","msg":"trace[743904395] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"768.507406ms","start":"2026-06-10T10:26:23.381254Z","end":"2026-06-10T10:26:24.149761Z","steps":["trace[743904395] 'process raft request' (duration: 766.78968ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:24.149816Z","caller":"traceutil/trace.go:171","msg":"trace[549082659] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"247.705453ms","start":"2026-06-10T10:26:23.90206Z","end":"2026-06-10T10:26:24.149766Z","steps":["trace[549082659] 'process raft request' (duration: 246.011018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.149895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.381224Z","time spent":"768.593548ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:24.151995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.971638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:26:24.152055Z","caller":"traceutil/trace.go:171","msg":"trace[1179125444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5034; }","duration":"248.07101ms","start":"2026-06-10T10:26:23.903968Z","end":"2026-06-10T10:26:24.152039Z","steps":["trace[1179125444] 'agreement among raft nodes before linearized reading' (duration: 244.730881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.15395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.25071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:24.154058Z","caller":"traceutil/trace.go:171","msg":"trace[1618717862] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:5034; }","duration":"971.860446ms","start":"2026-06-10T10:26:23.182175Z","end":"2026-06-10T10:26:24.154035Z","steps":["trace[1618717862] 'agreement among raft nodes before linearized reading' (duration: 966.24634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:24.154574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:23.18215Z","time spent":"972.382296ms","remote":"127.0.0.1:49188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:24.410778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.616415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-10T10:26:24.41086Z","caller":"traceutil/trace.go:171","msg":"trace[1589053729] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5039; }","duration":"144.743547ms","start":"2026-06-10T10:26:24.266095Z","end":"2026-06-10T10:26:24.410839Z","steps":["trace[1589053729] 'range keys from in-memory index tree' (duration: 144.3696ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:25.932531Z","caller":"traceutil/trace.go:171","msg":"trace[1237349614] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"109.873785ms","start":"2026-06-10T10:26:25.822634Z","end":"2026-06-10T10:26:25.932507Z","steps":["trace[1237349614] 'process raft request' (duration: 109.733722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:46.113312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.470395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:26:46.113392Z","caller":"traceutil/trace.go:171","msg":"trace[1152847837] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"147.878539ms","start":"2026-06-10T10:26:45.9655Z","end":"2026-06-10T10:26:46.113378Z","steps":["trace[1152847837] 'process raft request' (duration: 43.281161ms)","trace[1152847837] 'compare' (duration: 104.402034ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:46.118347Z","caller":"traceutil/trace.go:171","msg":"trace[635818183] transaction","detail":"{read_only:false; response_revision:5158; number_of_response:1; }","duration":"151.544834ms","start":"2026-06-10T10:26:45.966792Z","end":"2026-06-10T10:26:46.118337Z","steps":["trace[635818183] 'process raft request' (duration: 151.454572ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:46.118369Z","caller":"traceutil/trace.go:171","msg":"trace[1264547696] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"152.284499ms","start":"2026-06-10T10:26:45.966057Z","end":"2026-06-10T10:26:46.118342Z","steps":["trace[1264547696] 'process raft request' (duration: 152.103765ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:46.118427Z","caller":"traceutil/trace.go:171","msg":"trace[981320180] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"151.964232ms","start":"2026-06-10T10:26:45.966421Z","end":"2026-06-10T10:26:46.118386Z","steps":["trace[981320180] 'process raft request' (duration: 151.800699ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:46.118797Z","caller":"traceutil/trace.go:171","msg":"trace[317779796] transaction","detail":"{read_only:false; response_revision:5159; number_of_response:1; }","duration":"148.170645ms","start":"2026-06-10T10:26:45.970594Z","end":"2026-06-10T10:26:46.118764Z","steps":["trace[317779796] 'process raft request' (duration: 147.685765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:46.119106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.273679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-10T10:26:46.119149Z","caller":"traceutil/trace.go:171","msg":"trace[1306384432] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5159; }","duration":"125.35909ms","start":"2026-06-10T10:26:45.993777Z","end":"2026-06-10T10:26:46.119136Z","steps":["trace[1306384432] 'agreement among raft nodes before linearized reading' (duration: 125.223247ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:46.120486Z","caller":"traceutil/trace.go:171","msg":"trace[928628687] linearizableReadLoop","detail":"{readStateIndex:5357; appliedIndex:5352; }","duration":"124.778578ms","start":"2026-06-10T10:26:45.993824Z","end":"2026-06-10T10:26:46.118602Z","steps":["trace[928628687] 'read index received' (duration: 14.966614ms)","trace[928628687] 'applied index is now lower than readState.Index' (duration: 109.810934ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:50.615064Z","caller":"traceutil/trace.go:171","msg":"trace[1928753922] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"179.880381ms","start":"2026-06-10T10:26:50.43516Z","end":"2026-06-10T10:26:50.61504Z","steps":["trace[1928753922] 'process raft request' (duration: 173.754507ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:50.615335Z","caller":"traceutil/trace.go:171","msg":"trace[726033318] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"180.010664ms","start":"2026-06-10T10:26:50.4353Z","end":"2026-06-10T10:26:50.615311Z","steps":["trace[726033318] 'process raft request' (duration: 179.694347ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:50.615549Z","caller":"traceutil/trace.go:171","msg":"trace[1250794191] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"180.181827ms","start":"2026-06-10T10:26:50.435355Z","end":"2026-06-10T10:26:50.615537Z","steps":["trace[1250794191] 'process raft request' (duration: 179.881271ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:50.616219Z","caller":"traceutil/trace.go:171","msg":"trace[220911693] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"180.090176ms","start":"2026-06-10T10:26:50.436106Z","end":"2026-06-10T10:26:50.616196Z","steps":["trace[220911693] 'process raft request' (duration: 179.382351ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:56.544499Z","caller":"traceutil/trace.go:171","msg":"trace[1627712813] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"138.179904ms","start":"2026-06-10T10:26:56.406282Z","end":"2026-06-10T10:26:56.544462Z","steps":["trace[1627712813] 'process raft request' (duration: 107.350971ms)","trace[1627712813] 'compare' (duration: 30.634509ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:56.545404Z","caller":"traceutil/trace.go:171","msg":"trace[1931135303] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"106.960263ms","start":"2026-06-10T10:26:56.438401Z","end":"2026-06-10T10:26:56.545362Z","steps":["trace[1931135303] 'process raft request' (duration: 106.677358ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:56.545209Z","caller":"traceutil/trace.go:171","msg":"trace[740197742] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"125.215873ms","start":"2026-06-10T10:26:56.41998Z","end":"2026-06-10T10:26:56.545196Z","steps":["trace[740197742] 'process raft request' (duration: 124.419087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:04.932694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.46411ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:27:04.93291Z","caller":"traceutil/trace.go:171","msg":"trace[2116697765] linearizableReadLoop","detail":"{readStateIndex:5561; appliedIndex:5559; }","duration":"173.083195ms","start":"2026-06-10T10:27:04.759808Z","end":"2026-06-10T10:27:04.932891Z","steps":["trace[2116697765] 'read index received' (duration: 25.34933ms)","trace[2116697765] 'applied index is now lower than readState.Index' (duration: 147.732995ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:04.933062Z","caller":"traceutil/trace.go:171","msg":"trace[1468843236] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"185.493265ms","start":"2026-06-10T10:27:04.747497Z","end":"2026-06-10T10:27:04.93299Z","steps":["trace[1468843236] 'process raft request' (duration: 37.646708ms)","trace[1468843236] 'compare' (duration: 147.250575ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:04.933197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.374632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:27:04.933234Z","caller":"traceutil/trace.go:171","msg":"trace[740462817] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"177.673538ms","start":"2026-06-10T10:27:04.755551Z","end":"2026-06-10T10:27:04.933225Z","steps":["trace[740462817] 'process raft request' (duration: 177.26631ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:04.933271Z","caller":"traceutil/trace.go:171","msg":"trace[136744155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5357; }","duration":"173.498053ms","start":"2026-06-10T10:27:04.759755Z","end":"2026-06-10T10:27:04.933253Z","steps":["trace[136744155] 'agreement among raft nodes before linearized reading' (duration: 173.276179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:04.933286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.689803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T10:27:04.933392Z","caller":"traceutil/trace.go:171","msg":"trace[310503554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5357; }","duration":"139.811736ms","start":"2026-06-10T10:27:04.793554Z","end":"2026-06-10T10:27:04.933366Z","steps":["trace[310503554] 'agreement among raft nodes before linearized reading' (duration: 139.5319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:04.933734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.142642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:27:04.9338Z","caller":"traceutil/trace.go:171","msg":"trace[180705639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5357; }","duration":"138.240454ms","start":"2026-06-10T10:27:04.795544Z","end":"2026-06-10T10:27:04.933785Z","steps":["trace[180705639] 'agreement among raft nodes before linearized reading' (duration: 138.05744ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:12.891806Z","caller":"traceutil/trace.go:171","msg":"trace[2102050100] linearizableReadLoop","detail":"{readStateIndex:5607; appliedIndex:5606; }","duration":"137.529768ms","start":"2026-06-10T10:27:12.754251Z","end":"2026-06-10T10:27:12.891781Z","steps":["trace[2102050100] 'read index received' (duration: 59.83342ms)","trace[2102050100] 'applied index is now lower than readState.Index' (duration: 77.695068ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:12.891989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.717413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-10T10:27:12.891916Z","caller":"traceutil/trace.go:171","msg":"trace[807271443] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"139.57546ms","start":"2026-06-10T10:27:12.752282Z","end":"2026-06-10T10:27:12.891857Z","steps":["trace[807271443] 'process raft request' (duration: 61.929152ms)","trace[807271443] 'compare' (duration: 77.407993ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:12.892049Z","caller":"traceutil/trace.go:171","msg":"trace[530500500] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5401; }","duration":"137.811754ms","start":"2026-06-10T10:27:12.754218Z","end":"2026-06-10T10:27:12.89203Z","steps":["trace[530500500] 'agreement among raft nodes before linearized reading' (duration: 137.649871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:13.82849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.865528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:27:13.828633Z","caller":"traceutil/trace.go:171","msg":"trace[40242628] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"895.617026ms","start":"2026-06-10T10:27:12.932987Z","end":"2026-06-10T10:27:13.828604Z","steps":["trace[40242628] 'process raft request' (duration: 72.536044ms)","trace[40242628] 'compare' (duration: 822.613233ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:13.828722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:12.932965Z","time spent":"895.710908ms","remote":"127.0.0.1:55314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7366,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:27:14.027548Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.021983759s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-10T10:27:14.173956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.103178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:27:14.174238Z","caller":"traceutil/trace.go:171","msg":"trace[1450328377] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"1.231725533s","start":"2026-06-10T10:27:12.942471Z","end":"2026-06-10T10:27:14.174197Z","steps":["trace[1450328377] 'process raft request' (duration: 1.085271498s)","trace[1450328377] 'compare' (duration: 145.785871ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:14.17439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:12.942436Z","time spent":"1.231881876s","remote":"127.0.0.1:44190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:27:14.17451Z","caller":"traceutil/trace.go:171","msg":"trace[941322526] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"1.213858645s","start":"2026-06-10T10:27:12.960544Z","end":"2026-06-10T10:27:14.174403Z","steps":["trace[941322526] 'process raft request' (duration: 1.213548749s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.174556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202970417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T10:27:14.174244Z","caller":"traceutil/trace.go:171","msg":"trace[1573371116] linearizableReadLoop","detail":"{readStateIndex:5610; appliedIndex:5607; }","duration":"1.202651489s","start":"2026-06-10T10:27:12.971576Z","end":"2026-06-10T10:27:14.174228Z","steps":["trace[1573371116] 'read index received' (duration: 33.963721ms)","trace[1573371116] 'applied index is now lower than readState.Index' (duration: 1.168686528s)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:14.174615Z","caller":"traceutil/trace.go:171","msg":"trace[1003342527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5404; }","duration":"1.203077919s","start":"2026-06-10T10:27:12.971522Z","end":"2026-06-10T10:27:14.1746Z","steps":["trace[1003342527] 'agreement among raft nodes before linearized reading' (duration: 1.202756972s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.174659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:12.971498Z","time spent":"1.20315058s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:27:14.174676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:12.960499Z","time spent":"1.21409082s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:27:14.174797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19813281s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:27:14.174844Z","caller":"traceutil/trace.go:171","msg":"trace[2117388374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5404; }","duration":"1.198194581s","start":"2026-06-10T10:27:12.976637Z","end":"2026-06-10T10:27:14.174831Z","steps":["trace[2117388374] 'agreement among raft nodes before linearized reading' (duration: 1.198079678s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.174856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081393638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6084"} {"level":"warn","ts":"2026-06-10T10:27:14.17488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:12.976627Z","time spent":"1.198244321s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:27:14.174899Z","caller":"traceutil/trace.go:171","msg":"trace[1237429915] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5404; }","duration":"1.08147036s","start":"2026-06-10T10:27:13.093416Z","end":"2026-06-10T10:27:14.174886Z","steps":["trace[1237429915] 'agreement among raft nodes before linearized reading' (duration: 1.081351177s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.174921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154974624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-10T10:27:14.174937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:13.093398Z","time spent":"1.08152939s","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":6107,"request content":"key:\"/registry/jobs/openstack/keystone-credential-setup\" "} {"level":"info","ts":"2026-06-10T10:27:14.17496Z","caller":"traceutil/trace.go:171","msg":"trace[1959542913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5404; }","duration":"1.155048445s","start":"2026-06-10T10:27:13.019901Z","end":"2026-06-10T10:27:14.174949Z","steps":["trace[1959542913] 'agreement among raft nodes before linearized reading' (duration: 1.154909582s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.174999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:13.019877Z","time spent":"1.155110387s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:27:14.175031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177676758s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-10T10:27:14.175059Z","caller":"traceutil/trace.go:171","msg":"trace[1088828800] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5404; }","duration":"1.17774907s","start":"2026-06-10T10:27:12.997302Z","end":"2026-06-10T10:27:14.175051Z","steps":["trace[1088828800] 'agreement among raft nodes before linearized reading' (duration: 1.177649628s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.175093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:12.997281Z","time spent":"1.177802812s","remote":"127.0.0.1:44360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-10T10:27:14.175148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114626255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:27:14.175155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081208285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:14.175178Z","caller":"traceutil/trace.go:171","msg":"trace[1076711536] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5404; }","duration":"1.114719986s","start":"2026-06-10T10:27:13.060448Z","end":"2026-06-10T10:27:14.175168Z","steps":["trace[1076711536] 'agreement among raft nodes before linearized reading' (duration: 1.114659545s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:14.175198Z","caller":"traceutil/trace.go:171","msg":"trace[1697492354] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5404; }","duration":"1.081278486s","start":"2026-06-10T10:27:13.093907Z","end":"2026-06-10T10:27:14.175185Z","steps":["trace[1697492354] 'agreement among raft nodes before linearized reading' (duration: 1.081212334s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.175206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:13.060417Z","time spent":"1.114782118s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:27:14.175235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:13.093897Z","time spent":"1.081328776s","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-06-10T10:27:14.175256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081416269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:14.175307Z","caller":"traceutil/trace.go:171","msg":"trace[1644594854] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5404; }","duration":"1.08149622s","start":"2026-06-10T10:27:13.093798Z","end":"2026-06-10T10:27:14.175294Z","steps":["trace[1644594854] 'agreement among raft nodes before linearized reading' (duration: 1.081413938s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.175341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:13.093787Z","time spent":"1.081547742s","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"warn","ts":"2026-06-10T10:27:14.175509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155416072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-10T10:27:14.1756Z","caller":"traceutil/trace.go:171","msg":"trace[2042629277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5404; }","duration":"1.155588336s","start":"2026-06-10T10:27:13.019986Z","end":"2026-06-10T10:27:14.175574Z","steps":["trace[2042629277] 'agreement among raft nodes before linearized reading' (duration: 1.15478589s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.177453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:13.01996Z","time spent":"1.157470004s","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T10:27:14.295855Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2829} {"level":"info","ts":"2026-06-10T10:27:14.296056Z","caller":"traceutil/trace.go:171","msg":"trace[159302467] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"115.039595ms","start":"2026-06-10T10:27:14.180988Z","end":"2026-06-10T10:27:14.296027Z","steps":["trace[159302467] 'process raft request' (duration: 114.840491ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:14.296119Z","caller":"traceutil/trace.go:171","msg":"trace[594703709] compact","detail":"{revision:2829; response_revision:5405; }","duration":"119.639897ms","start":"2026-06-10T10:27:14.176448Z","end":"2026-06-10T10:27:14.296088Z","steps":["trace[594703709] 'process raft request' (duration: 31.059902ms)","trace[594703709] 'check and update compact revision' (duration: 88.150327ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:14.297614Z","caller":"traceutil/trace.go:171","msg":"trace[1319069340] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"116.471044ms","start":"2026-06-10T10:27:14.181117Z","end":"2026-06-10T10:27:14.297588Z","steps":["trace[1319069340] 'process raft request' (duration: 114.892533ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:14.298066Z","caller":"traceutil/trace.go:171","msg":"trace[666587509] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"116.856532ms","start":"2026-06-10T10:27:14.181189Z","end":"2026-06-10T10:27:14.298045Z","steps":["trace[666587509] 'process raft request' (duration: 116.381652ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:14.298646Z","caller":"traceutil/trace.go:171","msg":"trace[1273035907] linearizableReadLoop","detail":"{readStateIndex:5614; appliedIndex:5610; }","duration":"117.209989ms","start":"2026-06-10T10:27:14.18142Z","end":"2026-06-10T10:27:14.29863Z","steps":["trace[1273035907] 'read index received' (duration: 26.065493ms)","trace[1273035907] 'applied index is now lower than readState.Index' (duration: 91.143476ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:14.298799Z","caller":"traceutil/trace.go:171","msg":"trace[1047074005] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"117.173928ms","start":"2026-06-10T10:27:14.181603Z","end":"2026-06-10T10:27:14.298776Z","steps":["trace[1047074005] 'process raft request' (duration: 116.379062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:14.299506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.481175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-10T10:27:14.299565Z","caller":"traceutil/trace.go:171","msg":"trace[1875190977] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5408; }","duration":"118.169278ms","start":"2026-06-10T10:27:14.181381Z","end":"2026-06-10T10:27:14.29955Z","steps":["trace[1875190977] 'agreement among raft nodes before linearized reading' (duration: 117.315611ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:14.485633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2829,"took":"186.914794ms","hash":867941462,"current-db-size-bytes":53002240,"current-db-size":"53 MB","current-db-size-in-use-bytes":28360704,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-10T10:27:14.485727Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":867941462,"revision":2829,"compact-revision":-1} {"level":"info","ts":"2026-06-10T10:27:41.613249Z","caller":"traceutil/trace.go:171","msg":"trace[1661195975] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"193.799877ms","start":"2026-06-10T10:27:41.419417Z","end":"2026-06-10T10:27:41.613217Z","steps":["trace[1661195975] 'process raft request' (duration: 191.995392ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:41.802136Z","caller":"traceutil/trace.go:171","msg":"trace[582582593] transaction","detail":"{read_only:false; response_revision:5614; number_of_response:1; }","duration":"106.858306ms","start":"2026-06-10T10:27:41.69523Z","end":"2026-06-10T10:27:41.802088Z","steps":["trace[582582593] 'process raft request' (duration: 29.749329ms)","trace[582582593] 'compare' (duration: 76.933524ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:29:03.130598Z","caller":"traceutil/trace.go:171","msg":"trace[150376152] transaction","detail":"{read_only:false; response_revision:6099; number_of_response:1; }","duration":"109.299172ms","start":"2026-06-10T10:29:03.021272Z","end":"2026-06-10T10:29:03.130571Z","steps":["trace[150376152] 'process raft request' (duration: 109.136769ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:29:40.462632Z","caller":"traceutil/trace.go:171","msg":"trace[824990666] transaction","detail":"{read_only:false; response_revision:6329; number_of_response:1; }","duration":"206.497413ms","start":"2026-06-10T10:29:40.256116Z","end":"2026-06-10T10:29:40.462613Z","steps":["trace[824990666] 'process raft request' (duration: 206.34692ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:29:40.46545Z","caller":"traceutil/trace.go:171","msg":"trace[1345609534] transaction","detail":"{read_only:false; response_revision:6330; number_of_response:1; }","duration":"123.357617ms","start":"2026-06-10T10:29:40.342072Z","end":"2026-06-10T10:29:40.46543Z","steps":["trace[1345609534] 'process raft request' (duration: 123.101752ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:30:40.175387Z","caller":"traceutil/trace.go:171","msg":"trace[1875618124] transaction","detail":"{read_only:false; response_revision:6849; number_of_response:1; }","duration":"101.547553ms","start":"2026-06-10T10:30:40.073813Z","end":"2026-06-10T10:30:40.17536Z","steps":["trace[1875618124] 'process raft request' (duration: 101.363206ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:14.303226Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5403} {"level":"info","ts":"2026-06-10T10:32:14.413179Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5403,"took":"108.968054ms","hash":170227009,"current-db-size-bytes":53002240,"current-db-size":"53 MB","current-db-size-in-use-bytes":18472960,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-10T10:32:14.413242Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":170227009,"revision":5403,"compact-revision":2829}