{"level":"warn","ts":"2026-06-16T00:17:26.160842Z","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-16T00:17:26.160994Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-16T00:17:26.161204Z","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-16T00:17:26.161219Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-16T00:17:26.161238Z","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-16T00:17:26.161907Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-16T00:17:26.162003Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-16T00:17:26.167551Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.279491ms"} {"level":"info","ts":"2026-06-16T00:17:26.172908Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-16T00:17:26.172976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T00:17:26.172998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-16T00:17:26.173014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T00:17:26.173028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-16T00:17:26.173082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-16T00:17:26.179737Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T00:17:26.181549Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T00:17:26.182774Z","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-16T00:17:26.185952Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T00:17:26.188654Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T00:17:26.188825Z","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-16T00:17:26.188866Z","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-16T00:17:26.188874Z","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-16T00:17:26.189848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-16T00:17:26.189957Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-16T00:17:26.198368Z","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-16T00:17:26.198511Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-16T00:17:26.198541Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-16T00:17:26.198842Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T00:17:26.198889Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T00:17:26.873561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T00:17:26.873618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T00:17:26.873644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-16T00:17:26.873663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-16T00:17:26.874058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-16T00:17:26.874169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-16T00:17:26.874195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-16T00:17:26.894877Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:17:26.895475Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T00:17:26.895488Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T00:17:26.895616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T00:17:26.895649Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:17:26.895886Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:17:26.895924Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:17:26.896247Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T00:17:26.896282Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T00:17:26.898727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T00:17:26.899596Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-06-16T00:17:29.480357Z","caller":"traceutil/trace.go:171","msg":"trace[2113574392] transaction","detail":"{read_only:false; response_revision:115; number_of_response:1; }","duration":"122.767064ms","start":"2026-06-16T00:17:29.357561Z","end":"2026-06-16T00:17:29.480328Z","steps":["trace[2113574392] 'process raft request' (duration: 119.640144ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:17:30.029444Z","caller":"traceutil/trace.go:171","msg":"trace[2067869552] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"158.943967ms","start":"2026-06-16T00:17:29.870467Z","end":"2026-06-16T00:17:30.029411Z","steps":["trace[2067869552] 'process raft request' (duration: 99.257499ms)","trace[2067869552] 'compare' (duration: 59.541007ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:17:35.51592Z","caller":"traceutil/trace.go:171","msg":"trace[1274499582] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"130.508844ms","start":"2026-06-16T00:17:35.385274Z","end":"2026-06-16T00:17:35.515782Z","steps":["trace[1274499582] 'process raft request' (duration: 128.401475ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:17:35.717501Z","caller":"traceutil/trace.go:171","msg":"trace[1642222703] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"192.093218ms","start":"2026-06-16T00:17:35.525292Z","end":"2026-06-16T00:17:35.717385Z","steps":["trace[1642222703] 'process raft request' (duration: 95.892062ms)","trace[1642222703] 'compare' (duration: 95.906533ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:17:35.757583Z","caller":"traceutil/trace.go:171","msg":"trace[63013902] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:312; }","duration":"183.058367ms","start":"2026-06-16T00:17:35.574497Z","end":"2026-06-16T00:17:35.757556Z","steps":["trace[63013902] 'read index received' (duration: 46.69265ms)","trace[63013902] 'applied index is now lower than readState.Index' (duration: 136.364547ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:17:35.757706Z","caller":"traceutil/trace.go:171","msg":"trace[1961074355] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"226.315677ms","start":"2026-06-16T00:17:35.531378Z","end":"2026-06-16T00:17:35.757694Z","steps":["trace[1961074355] 'process raft request' (duration: 226.036154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:35.758094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.525601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-16T00:17:35.758217Z","caller":"traceutil/trace.go:171","msg":"trace[1110926923] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:302; }","duration":"183.755914ms","start":"2026-06-16T00:17:35.574438Z","end":"2026-06-16T00:17:35.758194Z","steps":["trace[1110926923] 'agreement among raft nodes before linearized reading' (duration: 183.461491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.179279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.235811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:17:36.179444Z","caller":"traceutil/trace.go:171","msg":"trace[1125873626] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:314; }","duration":"421.709289ms","start":"2026-06-16T00:17:35.757663Z","end":"2026-06-16T00:17:36.179372Z","steps":["trace[1125873626] 'read index received' (duration: 253.909813ms)","trace[1125873626] 'applied index is now lower than readState.Index' (duration: 167.798106ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:17:36.179546Z","caller":"traceutil/trace.go:171","msg":"trace[832574784] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"453.889079ms","start":"2026-06-16T00:17:35.725645Z","end":"2026-06-16T00:17:36.179534Z","steps":["trace[832574784] 'process raft request' (duration: 285.902391ms)","trace[832574784] 'compare' (duration: 167.09335ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:17:36.179607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.725627Z","time spent":"453.952959ms","remote":"127.0.0.1:55772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-16T00:17:36.179762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.588416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-16T00:17:36.179831Z","caller":"traceutil/trace.go:171","msg":"trace[990132306] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:303; }","duration":"503.718917ms","start":"2026-06-16T00:17:35.676093Z","end":"2026-06-16T00:17:36.179812Z","steps":["trace[990132306] 'agreement among raft nodes before linearized reading' (duration: 503.545594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.179855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.265782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-16T00:17:36.180016Z","caller":"traceutil/trace.go:171","msg":"trace[152649419] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:303; }","duration":"554.480054ms","start":"2026-06-16T00:17:35.625523Z","end":"2026-06-16T00:17:36.180003Z","steps":["trace[152649419] 'agreement among raft nodes before linearized reading' (duration: 554.281922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.180066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.625493Z","time spent":"554.562444ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-06-16T00:17:36.179873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.676069Z","time spent":"503.797098ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-06-16T00:17:36.179923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.249072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-16T00:17:36.180321Z","caller":"traceutil/trace.go:171","msg":"trace[835405177] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:303; }","duration":"455.715695ms","start":"2026-06-16T00:17:35.724594Z","end":"2026-06-16T00:17:36.18031Z","steps":["trace[835405177] 'agreement among raft nodes before linearized reading' (duration: 455.302132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.180364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.724568Z","time spent":"455.784556ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-06-16T00:17:36.422111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.721623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:17:36.422233Z","caller":"traceutil/trace.go:171","msg":"trace[1769540481] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"653.989958ms","start":"2026-06-16T00:17:35.768213Z","end":"2026-06-16T00:17:36.422203Z","steps":["trace[1769540481] 'process raft request' (duration: 512.011632ms)","trace[1769540481] 'compare' (duration: 141.567362ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:17:36.422394Z","caller":"traceutil/trace.go:171","msg":"trace[1109318840] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"242.855655ms","start":"2026-06-16T00:17:36.179503Z","end":"2026-06-16T00:17:36.422359Z","steps":["trace[1109318840] 'read index received' (duration: 100.756338ms)","trace[1109318840] 'applied index is now lower than readState.Index' (duration: 142.097737ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:17:36.422447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.768189Z","time spent":"654.097679ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-16T00:17:36.422579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.081475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-06-16T00:17:36.42262Z","caller":"traceutil/trace.go:171","msg":"trace[2070623328] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:305; }","duration":"548.189766ms","start":"2026-06-16T00:17:35.874419Z","end":"2026-06-16T00:17:36.422609Z","steps":["trace[2070623328] 'agreement among raft nodes before linearized reading' (duration: 548.083525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.422654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.874398Z","time spent":"548.247456ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-06-16T00:17:36.422848Z","caller":"traceutil/trace.go:171","msg":"trace[899866777] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"239.551824ms","start":"2026-06-16T00:17:36.183269Z","end":"2026-06-16T00:17:36.42282Z","steps":["trace[899866777] 'process raft request' (duration: 238.958299ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:17:36.422955Z","caller":"traceutil/trace.go:171","msg":"trace[757271178] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"236.099294ms","start":"2026-06-16T00:17:36.186846Z","end":"2026-06-16T00:17:36.422945Z","steps":["trace[757271178] 'process raft request' (duration: 235.555939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.423052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.485489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-16T00:17:36.423102Z","caller":"traceutil/trace.go:171","msg":"trace[184266082] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:306; }","duration":"648.579979ms","start":"2026-06-16T00:17:35.774512Z","end":"2026-06-16T00:17:36.423092Z","steps":["trace[184266082] 'agreement among raft nodes before linearized reading' (duration: 648.264217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.42316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.774494Z","time spent":"648.65731ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-06-16T00:17:36.423167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.150204ms","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-16T00:17:36.423247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.489683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:17:36.423279Z","caller":"traceutil/trace.go:171","msg":"trace[1001285603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:308; }","duration":"185.549104ms","start":"2026-06-16T00:17:36.237721Z","end":"2026-06-16T00:17:36.42327Z","steps":["trace[1001285603] 'agreement among raft nodes before linearized reading' (duration: 185.490623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.423118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.207206ms","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-16T00:17:36.423329Z","caller":"traceutil/trace.go:171","msg":"trace[2063632383] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:306; }","duration":"598.498209ms","start":"2026-06-16T00:17:35.824816Z","end":"2026-06-16T00:17:36.423314Z","steps":["trace[2063632383] 'agreement among raft nodes before linearized reading' (duration: 597.988345ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:17:36.423273Z","caller":"traceutil/trace.go:171","msg":"trace[1447531614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:306; }","duration":"550.316366ms","start":"2026-06-16T00:17:35.872937Z","end":"2026-06-16T00:17:36.423254Z","steps":["trace[1447531614] 'agreement among raft nodes before linearized reading' (duration: 549.859142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.423399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.824806Z","time spent":"598.55623ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-06-16T00:17:36.423419Z","caller":"traceutil/trace.go:171","msg":"trace[1790996660] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"230.566205ms","start":"2026-06-16T00:17:36.192843Z","end":"2026-06-16T00:17:36.42341Z","steps":["trace[1790996660] 'process raft request' (duration: 230.318843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:17:36.423402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:17:35.872909Z","time spent":"550.470827ms","remote":"127.0.0.1:55890","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-16T00:17:36.42352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.779248ms","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-16T00:17:36.423551Z","caller":"traceutil/trace.go:171","msg":"trace[207974151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:308; }","duration":"119.853008ms","start":"2026-06-16T00:17:36.303691Z","end":"2026-06-16T00:17:36.423544Z","steps":["trace[207974151] 'agreement among raft nodes before linearized reading' (duration: 119.798478ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:17:36.423602Z","caller":"traceutil/trace.go:171","msg":"trace[1320747315] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"233.715143ms","start":"2026-06-16T00:17:36.189857Z","end":"2026-06-16T00:17:36.423572Z","steps":["trace[1320747315] 'process raft request' (duration: 233.036687ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.913706Z","caller":"traceutil/trace.go:171","msg":"trace[2038589231] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"243.725602ms","start":"2026-06-16T00:18:04.669958Z","end":"2026-06-16T00:18:04.913684Z","steps":["trace[2038589231] 'process raft request' (duration: 241.752288ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.91382Z","caller":"traceutil/trace.go:171","msg":"trace[523682985] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"240.457608ms","start":"2026-06-16T00:18:04.673337Z","end":"2026-06-16T00:18:04.913794Z","steps":["trace[523682985] 'process raft request' (duration: 240.196846ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.914081Z","caller":"traceutil/trace.go:171","msg":"trace[1302130836] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"240.65263ms","start":"2026-06-16T00:18:04.673419Z","end":"2026-06-16T00:18:04.914071Z","steps":["trace[1302130836] 'process raft request' (duration: 240.283698ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.914462Z","caller":"traceutil/trace.go:171","msg":"trace[1584999290] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"226.863068ms","start":"2026-06-16T00:18:04.687589Z","end":"2026-06-16T00:18:04.914452Z","steps":["trace[1584999290] 'process raft request' (duration: 226.467625ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.914573Z","caller":"traceutil/trace.go:171","msg":"trace[1009153129] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"225.839991ms","start":"2026-06-16T00:18:04.688705Z","end":"2026-06-16T00:18:04.914545Z","steps":["trace[1009153129] 'process raft request' (duration: 225.530848ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.914674Z","caller":"traceutil/trace.go:171","msg":"trace[1102093352] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"224.801382ms","start":"2026-06-16T00:18:04.689865Z","end":"2026-06-16T00:18:04.914667Z","steps":["trace[1102093352] 'process raft request' (duration: 224.573011ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.914738Z","caller":"traceutil/trace.go:171","msg":"trace[578887152] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"223.08663ms","start":"2026-06-16T00:18:04.691645Z","end":"2026-06-16T00:18:04.914731Z","steps":["trace[578887152] 'process raft request' (duration: 222.914329ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.914792Z","caller":"traceutil/trace.go:171","msg":"trace[791144361] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"210.797888ms","start":"2026-06-16T00:18:04.703988Z","end":"2026-06-16T00:18:04.914785Z","steps":["trace[791144361] 'process raft request' (duration: 210.626997ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.91485Z","caller":"traceutil/trace.go:171","msg":"trace[1635380944] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:501; }","duration":"231.887445ms","start":"2026-06-16T00:18:04.682842Z","end":"2026-06-16T00:18:04.914729Z","steps":["trace[1635380944] 'read index received' (duration: 31.833456ms)","trace[1635380944] 'applied index is now lower than readState.Index' (duration: 200.053309ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:18:04.914236Z","caller":"traceutil/trace.go:171","msg":"trace[269074467] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"228.747462ms","start":"2026-06-16T00:18:04.685467Z","end":"2026-06-16T00:18:04.914215Z","steps":["trace[269074467] 'process raft request' (duration: 228.44241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:04.915053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.201377ms","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-16T00:18:04.915105Z","caller":"traceutil/trace.go:171","msg":"trace[1273960602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:492; }","duration":"232.300297ms","start":"2026-06-16T00:18:04.682796Z","end":"2026-06-16T00:18:04.915096Z","steps":["trace[1273960602] 'agreement among raft nodes before linearized reading' (duration: 232.143576ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.921297Z","caller":"traceutil/trace.go:171","msg":"trace[2040703493] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"188.370843ms","start":"2026-06-16T00:18:04.732898Z","end":"2026-06-16T00:18:04.921269Z","steps":["trace[2040703493] 'process raft request' (duration: 186.993503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:04.921775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.331622ms","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-16T00:18:04.92246Z","caller":"traceutil/trace.go:171","msg":"trace[622024514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:495; }","duration":"147.020297ms","start":"2026-06-16T00:18:04.775423Z","end":"2026-06-16T00:18:04.922443Z","steps":["trace[622024514] 'agreement among raft nodes before linearized reading' (duration: 146.288912ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:04.921814Z","caller":"traceutil/trace.go:171","msg":"trace[1477005024] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"183.74581ms","start":"2026-06-16T00:18:04.738059Z","end":"2026-06-16T00:18:04.921805Z","steps":["trace[1477005024] 'process raft request' (duration: 182.797792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:04.922012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.26616ms","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-16T00:18:04.922736Z","caller":"traceutil/trace.go:171","msg":"trace[278137253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:495; }","duration":"117.023015ms","start":"2026-06-16T00:18:04.805694Z","end":"2026-06-16T00:18:04.922717Z","steps":["trace[278137253] 'agreement among raft nodes before linearized reading' (duration: 116.25277ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:10.836363Z","caller":"traceutil/trace.go:171","msg":"trace[1203380921] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"108.610523ms","start":"2026-06-16T00:18:10.727708Z","end":"2026-06-16T00:18:10.836318Z","steps":["trace[1203380921] 'process raft request' (duration: 101.020608ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:11.944515Z","caller":"traceutil/trace.go:171","msg":"trace[1305192175] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"144.555004ms","start":"2026-06-16T00:18:11.799942Z","end":"2026-06-16T00:18:11.944497Z","steps":["trace[1305192175] 'read index received' (duration: 144.393502ms)","trace[1305192175] 'applied index is now lower than readState.Index' (duration: 160.822µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:18:11.944687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.752755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pzp2f\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-16T00:18:11.944715Z","caller":"traceutil/trace.go:171","msg":"trace[1317844384] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pzp2f; range_end:; response_count:1; response_revision:596; }","duration":"144.833286ms","start":"2026-06-16T00:18:11.799874Z","end":"2026-06-16T00:18:11.944707Z","steps":["trace[1317844384] 'agreement among raft nodes before linearized reading' (duration: 144.696854ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:11.944709Z","caller":"traceutil/trace.go:171","msg":"trace[614971868] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"525.875371ms","start":"2026-06-16T00:18:11.418762Z","end":"2026-06-16T00:18:11.944637Z","steps":["trace[614971868] 'process raft request' (duration: 525.639329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:11.94539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:11.418733Z","time spent":"526.548849ms","remote":"127.0.0.1:55870","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-16T00:18:12.479442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.483168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:18:12.479541Z","caller":"traceutil/trace.go:171","msg":"trace[998779896] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"516.030477ms","start":"2026-06-16T00:18:11.963498Z","end":"2026-06-16T00:18:12.479528Z","steps":["trace[998779896] 'read index received' (duration: 28.176496ms)","trace[998779896] 'applied index is now lower than readState.Index' (duration: 487.853211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:18:12.479617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.142921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:18:12.479641Z","caller":"traceutil/trace.go:171","msg":"trace[1961581145] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:597; }","duration":"516.199362ms","start":"2026-06-16T00:18:11.963435Z","end":"2026-06-16T00:18:12.479634Z","steps":["trace[1961581145] 'agreement among raft nodes before linearized reading' (duration: 516.15647ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:12.479619Z","caller":"traceutil/trace.go:171","msg":"trace[1140649491] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"522.383608ms","start":"2026-06-16T00:18:11.957189Z","end":"2026-06-16T00:18:12.479573Z","steps":["trace[1140649491] 'process raft request' (duration: 34.604367ms)","trace[1140649491] 'compare' (duration: 487.341882ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:18:12.4798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:11.957176Z","time spent":"522.539633ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:18:12.479668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:11.963423Z","time spent":"516.240003ms","remote":"127.0.0.1:55806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"info","ts":"2026-06-16T00:18:12.790932Z","caller":"traceutil/trace.go:171","msg":"trace[479473942] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"311.323572ms","start":"2026-06-16T00:18:12.479569Z","end":"2026-06-16T00:18:12.790893Z","steps":["trace[479473942] 'read index received' (duration: 297.918711ms)","trace[479473942] 'applied index is now lower than readState.Index' (duration: 13.402901ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:18:12.791046Z","caller":"traceutil/trace.go:171","msg":"trace[290451557] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"307.950669ms","start":"2026-06-16T00:18:12.483085Z","end":"2026-06-16T00:18:12.791036Z","steps":["trace[290451557] 'process raft request' (duration: 307.72693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:12.791136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:12.483064Z","time spent":"308.014801ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-16T00:18:12.791306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.767973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:18:12.791389Z","caller":"traceutil/trace.go:171","msg":"trace[623093315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"813.908497ms","start":"2026-06-16T00:18:11.977464Z","end":"2026-06-16T00:18:12.791373Z","steps":["trace[623093315] 'agreement among raft nodes before linearized reading' (duration: 813.509111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:12.791455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:11.977421Z","time spent":"814.025971ms","remote":"127.0.0.1:55644","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-16T00:18:12.792475Z","caller":"traceutil/trace.go:171","msg":"trace[900259463] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"422.399722ms","start":"2026-06-16T00:18:12.370039Z","end":"2026-06-16T00:18:12.792439Z","steps":["trace[900259463] 'process raft request' (duration: 407.350276ms)","trace[900259463] 'compare' (duration: 13.170622ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:18:12.792616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:12.370015Z","time spent":"422.523796ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:18:14.167474Z","caller":"traceutil/trace.go:171","msg":"trace[1084734488] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"166.630679ms","start":"2026-06-16T00:18:14.00081Z","end":"2026-06-16T00:18:14.167441Z","steps":["trace[1084734488] 'process raft request' (duration: 166.477943ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:23.212259Z","caller":"traceutil/trace.go:171","msg":"trace[1550171294] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"130.64184ms","start":"2026-06-16T00:18:23.081582Z","end":"2026-06-16T00:18:23.212224Z","steps":["trace[1550171294] 'process raft request' (duration: 103.971389ms)","trace[1550171294] 'compare' (duration: 26.524336ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:18:23.214759Z","caller":"traceutil/trace.go:171","msg":"trace[89184304] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"133.068395ms","start":"2026-06-16T00:18:23.081666Z","end":"2026-06-16T00:18:23.214735Z","steps":["trace[89184304] 'process raft request' (duration: 132.956611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:29.195708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.670872ms","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-16T00:18:29.195838Z","caller":"traceutil/trace.go:171","msg":"trace[361940210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:758; }","duration":"251.883969ms","start":"2026-06-16T00:18:28.943924Z","end":"2026-06-16T00:18:29.195808Z","steps":["trace[361940210] 'range keys from in-memory index tree' (duration: 251.417094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:29.19593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.58468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-n7g7h\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-16T00:18:29.196031Z","caller":"traceutil/trace.go:171","msg":"trace[1879451553] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-n7g7h; range_end:; response_count:1; response_revision:758; }","duration":"297.739454ms","start":"2026-06-16T00:18:28.898265Z","end":"2026-06-16T00:18:29.196004Z","steps":["trace[1879451553] 'range keys from in-memory index tree' (duration: 297.257438ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:52.138201Z","caller":"traceutil/trace.go:171","msg":"trace[1405923582] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1163; }","duration":"102.648676ms","start":"2026-06-16T00:18:52.035526Z","end":"2026-06-16T00:18:52.138175Z","steps":["trace[1405923582] 'read index received' (duration: 102.496153ms)","trace[1405923582] 'applied index is now lower than readState.Index' (duration: 151.713µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:18:52.138336Z","caller":"traceutil/trace.go:171","msg":"trace[1215375686] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"112.987823ms","start":"2026-06-16T00:18:52.025287Z","end":"2026-06-16T00:18:52.138274Z","steps":["trace[1215375686] 'process raft request' (duration: 112.737977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:52.138418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.864122ms","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-16T00:18:52.138479Z","caller":"traceutil/trace.go:171","msg":"trace[814700561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1129; }","duration":"102.945164ms","start":"2026-06-16T00:18:52.035517Z","end":"2026-06-16T00:18:52.138463Z","steps":["trace[814700561] 'agreement among raft nodes before linearized reading' (duration: 102.760419ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:52.755253Z","caller":"traceutil/trace.go:171","msg":"trace[291890694] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"108.323253ms","start":"2026-06-16T00:18:52.646904Z","end":"2026-06-16T00:18:52.755227Z","steps":["trace[291890694] 'process raft request' (duration: 108.170478ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:18:58.847697Z","caller":"traceutil/trace.go:171","msg":"trace[1810659591] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"678.35666ms","start":"2026-06-16T00:18:58.169314Z","end":"2026-06-16T00:18:58.84767Z","steps":["trace[1810659591] 'process raft request' (duration: 678.212816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:18:58.847829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:18:58.169287Z","time spent":"678.472842ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:19:23.724706Z","caller":"traceutil/trace.go:171","msg":"trace[785357763] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"191.567914ms","start":"2026-06-16T00:19:23.533112Z","end":"2026-06-16T00:19:23.72468Z","steps":["trace[785357763] 'process raft request' (duration: 191.392571ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:23.803001Z","caller":"traceutil/trace.go:171","msg":"trace[1103238513] linearizableReadLoop","detail":"{readStateIndex:1477; appliedIndex:1473; }","duration":"240.030389ms","start":"2026-06-16T00:19:23.562946Z","end":"2026-06-16T00:19:23.802976Z","steps":["trace[1103238513] 'read index received' (duration: 161.548603ms)","trace[1103238513] 'applied index is now lower than readState.Index' (duration: 78.480596ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:19:23.803159Z","caller":"traceutil/trace.go:171","msg":"trace[2093944655] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"269.423679ms","start":"2026-06-16T00:19:23.533691Z","end":"2026-06-16T00:19:23.803114Z","steps":["trace[2093944655] 'process raft request' (duration: 247.841673ms)","trace[2093944655] 'compare' (duration: 21.224049ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:19:23.803315Z","caller":"traceutil/trace.go:171","msg":"trace[282960541] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"269.319396ms","start":"2026-06-16T00:19:23.533941Z","end":"2026-06-16T00:19:23.803261Z","steps":["trace[282960541] 'process raft request' (duration: 268.928048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:23.803342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.365256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:23.803317Z","caller":"traceutil/trace.go:171","msg":"trace[791830277] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"268.928428ms","start":"2026-06-16T00:19:23.534369Z","end":"2026-06-16T00:19:23.803297Z","steps":["trace[791830277] 'process raft request' (duration: 268.560271ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:23.803431Z","caller":"traceutil/trace.go:171","msg":"trace[2128477774] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1432; }","duration":"240.497539ms","start":"2026-06-16T00:19:23.562918Z","end":"2026-06-16T00:19:23.803416Z","steps":["trace[2128477774] 'agreement among raft nodes before linearized reading' (duration: 240.165552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:42.329409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.763025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:42.329529Z","caller":"traceutil/trace.go:171","msg":"trace[1230328443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1747; }","duration":"153.921088ms","start":"2026-06-16T00:19:42.175583Z","end":"2026-06-16T00:19:42.329504Z","steps":["trace[1230328443] 'count revisions from in-memory index tree' (duration: 153.715414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:42.329943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.765293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:42.330003Z","caller":"traceutil/trace.go:171","msg":"trace[159679828] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1747; }","duration":"186.839764ms","start":"2026-06-16T00:19:42.143148Z","end":"2026-06-16T00:19:42.329987Z","steps":["trace[159679828] 'count revisions from in-memory index tree' (duration: 186.727562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:42.330241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.145789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T00:19:42.330164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.504618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:42.330383Z","caller":"traceutil/trace.go:171","msg":"trace[83472998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1747; }","duration":"154.884294ms","start":"2026-06-16T00:19:42.175472Z","end":"2026-06-16T00:19:42.330357Z","steps":["trace[83472998] 'range keys from in-memory index tree' (duration: 154.352255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:42.330716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.818575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:42.330753Z","caller":"traceutil/trace.go:171","msg":"trace[1978891252] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1747; }","duration":"121.871576ms","start":"2026-06-16T00:19:42.208872Z","end":"2026-06-16T00:19:42.330744Z","steps":["trace[1978891252] 'range keys from in-memory index tree' (duration: 121.776944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:42.33152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.765764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:42.330278Z","caller":"traceutil/trace.go:171","msg":"trace[861358801] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1747; }","duration":"187.221201ms","start":"2026-06-16T00:19:42.143049Z","end":"2026-06-16T00:19:42.33027Z","steps":["trace[861358801] 'range keys from in-memory index tree' (duration: 187.010326ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:42.331856Z","caller":"traceutil/trace.go:171","msg":"trace[1980899856] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1747; }","duration":"122.829523ms","start":"2026-06-16T00:19:42.209009Z","end":"2026-06-16T00:19:42.331839Z","steps":["trace[1980899856] 'count revisions from in-memory index tree' (duration: 121.726534ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:49.157661Z","caller":"traceutil/trace.go:171","msg":"trace[1468856462] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"257.934895ms","start":"2026-06-16T00:19:48.899705Z","end":"2026-06-16T00:19:49.15764Z","steps":["trace[1468856462] 'read index received' (duration: 257.867933ms)","trace[1468856462] 'applied index is now lower than readState.Index' (duration: 66.102µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:19:49.157897Z","caller":"traceutil/trace.go:171","msg":"trace[568067411] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"287.86874ms","start":"2026-06-16T00:19:48.870014Z","end":"2026-06-16T00:19:49.157883Z","steps":["trace[568067411] 'process raft request' (duration: 287.502344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:49.15819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.463254ms","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-16T00:19:49.158238Z","caller":"traceutil/trace.go:171","msg":"trace[1935783279] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1841; }","duration":"258.584106ms","start":"2026-06-16T00:19:48.899638Z","end":"2026-06-16T00:19:49.158222Z","steps":["trace[1935783279] 'agreement among raft nodes before linearized reading' (duration: 258.431043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:49.160142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.158986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:19:49.160215Z","caller":"traceutil/trace.go:171","msg":"trace[627636167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1842; }","duration":"180.278279ms","start":"2026-06-16T00:19:48.979919Z","end":"2026-06-16T00:19:49.160197Z","steps":["trace[627636167] 'agreement among raft nodes before linearized reading' (duration: 180.145747ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:51.464642Z","caller":"traceutil/trace.go:171","msg":"trace[1200340051] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"103.272248ms","start":"2026-06-16T00:19:51.361337Z","end":"2026-06-16T00:19:51.464609Z","steps":["trace[1200340051] 'process raft request' (duration: 103.192627ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:51.464844Z","caller":"traceutil/trace.go:171","msg":"trace[164071552] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"103.726945ms","start":"2026-06-16T00:19:51.36108Z","end":"2026-06-16T00:19:51.464807Z","steps":["trace[164071552] 'process raft request' (duration: 103.279018ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:51.48557Z","caller":"traceutil/trace.go:171","msg":"trace[1813667879] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"124.083976ms","start":"2026-06-16T00:19:51.361458Z","end":"2026-06-16T00:19:51.485542Z","steps":["trace[1813667879] 'process raft request' (duration: 123.916713ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:52.521973Z","caller":"traceutil/trace.go:171","msg":"trace[1166287502] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"426.939707ms","start":"2026-06-16T00:19:52.095002Z","end":"2026-06-16T00:19:52.521942Z","steps":["trace[1166287502] 'read index received' (duration: 426.241737ms)","trace[1166287502] 'applied index is now lower than readState.Index' (duration: 696.79µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:19:52.52206Z","caller":"traceutil/trace.go:171","msg":"trace[1246019360] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"442.384937ms","start":"2026-06-16T00:19:52.079638Z","end":"2026-06-16T00:19:52.522023Z","steps":["trace[1246019360] 'process raft request' (duration: 442.131333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.522233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.079597Z","time spent":"442.551351ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:19:52.522282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.899822ms","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-16T00:19:52.522342Z","caller":"traceutil/trace.go:171","msg":"trace[1178787788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1870; }","duration":"426.014925ms","start":"2026-06-16T00:19:52.09631Z","end":"2026-06-16T00:19:52.522325Z","steps":["trace[1178787788] 'agreement among raft nodes before linearized reading' (duration: 425.826201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.522421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.09629Z","time spent":"426.112616ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T00:19:52.522438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.043523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1186ca51-77c3-48b4-b6bb-2d68e94f1172\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-16T00:19:52.522553Z","caller":"traceutil/trace.go:171","msg":"trace[1897668343] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1186ca51-77c3-48b4-b6bb-2d68e94f1172; range_end:; response_count:1; response_revision:1870; }","duration":"161.182305ms","start":"2026-06-16T00:19:52.361355Z","end":"2026-06-16T00:19:52.522537Z","steps":["trace[1897668343] 'agreement among raft nodes before linearized reading' (duration: 160.816468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.522571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.836714ms","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-16T00:19:52.522696Z","caller":"traceutil/trace.go:171","msg":"trace[353027274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1870; }","duration":"373.031628ms","start":"2026-06-16T00:19:52.149637Z","end":"2026-06-16T00:19:52.522669Z","steps":["trace[353027274] 'agreement among raft nodes before linearized reading' (duration: 372.647942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.522768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.149613Z","time spent":"373.144099ms","remote":"127.0.0.1:55890","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-16T00:19:52.522833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.278755ms","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-16T00:19:52.522934Z","caller":"traceutil/trace.go:171","msg":"trace[158664711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1870; }","duration":"427.959155ms","start":"2026-06-16T00:19:52.094951Z","end":"2026-06-16T00:19:52.52291Z","steps":["trace[158664711] 'agreement among raft nodes before linearized reading' (duration: 427.161851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.522995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.09493Z","time spent":"428.053617ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T00:19:52.523078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.243333ms","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-16T00:19:52.52313Z","caller":"traceutil/trace.go:171","msg":"trace[1810583038] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1870; }","duration":"323.980295ms","start":"2026-06-16T00:19:52.199134Z","end":"2026-06-16T00:19:52.523114Z","steps":["trace[1810583038] 'agreement among raft nodes before linearized reading' (duration: 323.06986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.523157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.199113Z","time spent":"324.035135ms","remote":"127.0.0.1:39150","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-16T00:19:52.523085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.424059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1186ca51-77c3-48b4-b6bb-2d68e94f1172\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-16T00:19:52.52321Z","caller":"traceutil/trace.go:171","msg":"trace[1742032493] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1186ca51-77c3-48b4-b6bb-2d68e94f1172; range_end:; response_count:1; response_revision:1870; }","duration":"179.553061ms","start":"2026-06-16T00:19:52.343638Z","end":"2026-06-16T00:19:52.523191Z","steps":["trace[1742032493] 'agreement among raft nodes before linearized reading' (duration: 178.703568ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:52.713194Z","caller":"traceutil/trace.go:171","msg":"trace[713688161] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"185.815153ms","start":"2026-06-16T00:19:52.527274Z","end":"2026-06-16T00:19:52.71309Z","steps":["trace[713688161] 'process raft request' (duration: 99.02136ms)","trace[713688161] 'compare' (duration: 86.570839ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:19:52.864608Z","caller":"traceutil/trace.go:171","msg":"trace[78257949] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"334.270991ms","start":"2026-06-16T00:19:52.530304Z","end":"2026-06-16T00:19:52.864575Z","steps":["trace[78257949] 'process raft request' (duration: 305.236611ms)","trace[78257949] 'compare' (duration: 28.786126ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:19:52.864955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.530287Z","time spent":"334.417394ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:19:52.865425Z","caller":"traceutil/trace.go:171","msg":"trace[1798166318] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"334.349232ms","start":"2026-06-16T00:19:52.531039Z","end":"2026-06-16T00:19:52.865388Z","steps":["trace[1798166318] 'process raft request' (duration: 333.482598ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:52.865562Z","caller":"traceutil/trace.go:171","msg":"trace[2101177455] linearizableReadLoop","detail":"{readStateIndex:1948; appliedIndex:1944; }","duration":"330.891816ms","start":"2026-06-16T00:19:52.534519Z","end":"2026-06-16T00:19:52.865411Z","steps":["trace[2101177455] 'read index received' (duration: 91.778283ms)","trace[2101177455] 'applied index is now lower than readState.Index' (duration: 239.108953ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:19:52.865625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.531031Z","time spent":"334.481634ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:19:52.865688Z","caller":"traceutil/trace.go:171","msg":"trace[165280218] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"334.26326ms","start":"2026-06-16T00:19:52.531396Z","end":"2026-06-16T00:19:52.865659Z","steps":["trace[165280218] 'process raft request' (duration: 333.531668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.865878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.531388Z","time spent":"334.409192ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:19:52.865738Z","caller":"traceutil/trace.go:171","msg":"trace[1317029516] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"292.831261ms","start":"2026-06-16T00:19:52.572881Z","end":"2026-06-16T00:19:52.865712Z","steps":["trace[1317029516] 'process raft request' (duration: 292.273122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.866015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.477985ms","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-16T00:19:52.866096Z","caller":"traceutil/trace.go:171","msg":"trace[835817378] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1875; }","duration":"331.586707ms","start":"2026-06-16T00:19:52.534492Z","end":"2026-06-16T00:19:52.866079Z","steps":["trace[835817378] 'agreement among raft nodes before linearized reading' (duration: 331.246671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:52.866168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:19:52.534484Z","time spent":"331.672259ms","remote":"127.0.0.1:56080","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":"info","ts":"2026-06-16T00:19:53.446575Z","caller":"traceutil/trace.go:171","msg":"trace[1984128014] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"273.097816ms","start":"2026-06-16T00:19:53.17345Z","end":"2026-06-16T00:19:53.446547Z","steps":["trace[1984128014] 'process raft request' (duration: 267.007458ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:53.480663Z","caller":"traceutil/trace.go:171","msg":"trace[1812956230] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1949; }","duration":"244.955765ms","start":"2026-06-16T00:19:53.235678Z","end":"2026-06-16T00:19:53.480634Z","steps":["trace[1812956230] 'read index received' (duration: 204.800259ms)","trace[1812956230] 'applied index is now lower than readState.Index' (duration: 40.154256ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:19:53.480781Z","caller":"traceutil/trace.go:171","msg":"trace[2055588774] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"196.065749ms","start":"2026-06-16T00:19:53.284626Z","end":"2026-06-16T00:19:53.480692Z","steps":["trace[2055588774] 'process raft request' (duration: 195.945987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:19:53.480919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.225839ms","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-16T00:19:53.480993Z","caller":"traceutil/trace.go:171","msg":"trace[70083773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1878; }","duration":"245.364211ms","start":"2026-06-16T00:19:53.235618Z","end":"2026-06-16T00:19:53.480982Z","steps":["trace[70083773] 'agreement among raft nodes before linearized reading' (duration: 245.146798ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:53.480723Z","caller":"traceutil/trace.go:171","msg":"trace[220898490] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"285.516186ms","start":"2026-06-16T00:19:53.195136Z","end":"2026-06-16T00:19:53.480652Z","steps":["trace[220898490] 'process raft request' (duration: 285.273692ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:19:58.850507Z","caller":"traceutil/trace.go:171","msg":"trace[950676648] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"112.477787ms","start":"2026-06-16T00:19:58.738003Z","end":"2026-06-16T00:19:58.850481Z","steps":["trace[950676648] 'process raft request' (duration: 112.325633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:20:05.695063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.832306ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-16T00:20:05.743343Z","caller":"traceutil/trace.go:171","msg":"trace[931397634] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"254.358651ms","start":"2026-06-16T00:20:05.488949Z","end":"2026-06-16T00:20:05.743308Z","steps":["trace[931397634] 'process raft request' (duration: 254.177799ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:05.774996Z","caller":"traceutil/trace.go:171","msg":"trace[159398867] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"260.279641ms","start":"2026-06-16T00:20:05.514689Z","end":"2026-06-16T00:20:05.774968Z","steps":["trace[159398867] 'process raft request' (duration: 259.983766ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:05.774986Z","caller":"traceutil/trace.go:171","msg":"trace[1812957269] linearizableReadLoop","detail":"{readStateIndex:2068; appliedIndex:2065; }","duration":"238.542053ms","start":"2026-06-16T00:20:05.536411Z","end":"2026-06-16T00:20:05.774953Z","steps":["trace[1812957269] 'read index received' (duration: 206.776017ms)","trace[1812957269] 'applied index is now lower than readState.Index' (duration: 31.764506ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:20:05.775307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.884818ms","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-16T00:20:05.775145Z","caller":"traceutil/trace.go:171","msg":"trace[1774975397] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"246.31042ms","start":"2026-06-16T00:20:05.528818Z","end":"2026-06-16T00:20:05.775128Z","steps":["trace[1774975397] 'process raft request' (duration: 246.069506ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:05.775358Z","caller":"traceutil/trace.go:171","msg":"trace[1568501702] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1990; }","duration":"238.97522ms","start":"2026-06-16T00:20:05.536366Z","end":"2026-06-16T00:20:05.775341Z","steps":["trace[1568501702] 'agreement among raft nodes before linearized reading' (duration: 238.806218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:20:05.775496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.38749ms","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-16T00:20:05.775671Z","caller":"traceutil/trace.go:171","msg":"trace[1991226636] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1990; }","duration":"112.633323ms","start":"2026-06-16T00:20:05.663012Z","end":"2026-06-16T00:20:05.775645Z","steps":["trace[1991226636] 'agreement among raft nodes before linearized reading' (duration: 112.174565ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:05.892397Z","caller":"traceutil/trace.go:171","msg":"trace[1343949185] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"111.313863ms","start":"2026-06-16T00:20:05.781018Z","end":"2026-06-16T00:20:05.892332Z","steps":["trace[1343949185] 'process raft request' (duration: 41.303481ms)","trace[1343949185] 'compare' (duration: 69.749688ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:20:08.993394Z","caller":"traceutil/trace.go:171","msg":"trace[588650769] linearizableReadLoop","detail":"{readStateIndex:2082; appliedIndex:2081; }","duration":"196.75827ms","start":"2026-06-16T00:20:08.796612Z","end":"2026-06-16T00:20:08.99337Z","steps":["trace[588650769] 'read index received' (duration: 196.72176ms)","trace[588650769] 'applied index is now lower than readState.Index' (duration: 35.79µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:20:08.993559Z","caller":"traceutil/trace.go:171","msg":"trace[274055203] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"341.36096ms","start":"2026-06-16T00:20:08.652141Z","end":"2026-06-16T00:20:08.993502Z","steps":["trace[274055203] 'process raft request' (duration: 341.112096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:20:08.993598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.967614ms","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-16T00:20:08.993669Z","caller":"traceutil/trace.go:171","msg":"trace[661592164] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2004; }","duration":"197.087485ms","start":"2026-06-16T00:20:08.79656Z","end":"2026-06-16T00:20:08.993647Z","steps":["trace[661592164] 'agreement among raft nodes before linearized reading' (duration: 196.897382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:20:08.993751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:20:08.652126Z","time spent":"341.511042ms","remote":"127.0.0.1:55890","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-16T00:20:09.019993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.0719ms","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-16T00:20:09.020081Z","caller":"traceutil/trace.go:171","msg":"trace[1605364762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2005; }","duration":"121.223512ms","start":"2026-06-16T00:20:08.898838Z","end":"2026-06-16T00:20:09.020062Z","steps":["trace[1605364762] 'agreement among raft nodes before linearized reading' (duration: 120.941628ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:09.020408Z","caller":"traceutil/trace.go:171","msg":"trace[808839842] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"102.136779ms","start":"2026-06-16T00:20:08.918248Z","end":"2026-06-16T00:20:09.020384Z","steps":["trace[808839842] 'process raft request' (duration: 101.420099ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:28.092127Z","caller":"traceutil/trace.go:171","msg":"trace[242764519] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"252.084776ms","start":"2026-06-16T00:20:27.840014Z","end":"2026-06-16T00:20:28.092099Z","steps":["trace[242764519] 'process raft request' (duration: 239.80323ms)","trace[242764519] 'compare' (duration: 12.182744ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:20:28.116754Z","caller":"traceutil/trace.go:171","msg":"trace[340170129] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2195; }","duration":"113.012468ms","start":"2026-06-16T00:20:28.003723Z","end":"2026-06-16T00:20:28.116736Z","steps":["trace[340170129] 'read index received' (duration: 76.067779ms)","trace[340170129] 'applied index is now lower than readState.Index' (duration: 36.943679ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:20:28.116913Z","caller":"traceutil/trace.go:171","msg":"trace[1444324482] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"240.170353ms","start":"2026-06-16T00:20:27.876681Z","end":"2026-06-16T00:20:28.116852Z","steps":["trace[1444324482] 'process raft request' (duration: 239.964731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:20:28.118019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.264625ms","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-16T00:20:28.118075Z","caller":"traceutil/trace.go:171","msg":"trace[1630109116] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2115; }","duration":"114.389486ms","start":"2026-06-16T00:20:28.003673Z","end":"2026-06-16T00:20:28.118062Z","steps":["trace[1630109116] 'agreement among raft nodes before linearized reading' (duration: 113.223011ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:29.330262Z","caller":"traceutil/trace.go:171","msg":"trace[1623010649] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"106.842207ms","start":"2026-06-16T00:20:29.223382Z","end":"2026-06-16T00:20:29.330224Z","steps":["trace[1623010649] 'process raft request' (duration: 52.204692ms)","trace[1623010649] 'compare' (duration: 54.463883ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:20:29.621903Z","caller":"traceutil/trace.go:171","msg":"trace[7435677] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"286.772548ms","start":"2026-06-16T00:20:29.335092Z","end":"2026-06-16T00:20:29.621864Z","steps":["trace[7435677] 'process raft request' (duration: 284.634209ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:20:29.622004Z","caller":"traceutil/trace.go:171","msg":"trace[970786958] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"286.623966ms","start":"2026-06-16T00:20:29.335344Z","end":"2026-06-16T00:20:29.621968Z","steps":["trace[970786958] 'process raft request' (duration: 286.376613ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:22:02.256841Z","caller":"traceutil/trace.go:171","msg":"trace[1171228558] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"167.522984ms","start":"2026-06-16T00:22:02.089295Z","end":"2026-06-16T00:22:02.256818Z","steps":["trace[1171228558] 'process raft request' (duration: 167.396892ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:22:02.319324Z","caller":"traceutil/trace.go:171","msg":"trace[563249648] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"228.519133ms","start":"2026-06-16T00:22:02.090783Z","end":"2026-06-16T00:22:02.319302Z","steps":["trace[563249648] 'process raft request' (duration: 228.380671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:22:02.801847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.728341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:22:02.802049Z","caller":"traceutil/trace.go:171","msg":"trace[240450149] linearizableReadLoop","detail":"{readStateIndex:2834; appliedIndex:2832; }","duration":"250.229729ms","start":"2026-06-16T00:22:02.551795Z","end":"2026-06-16T00:22:02.802025Z","steps":["trace[240450149] 'read index received' (duration: 3.167384ms)","trace[240450149] 'applied index is now lower than readState.Index' (duration: 247.060865ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:22:02.802246Z","caller":"traceutil/trace.go:171","msg":"trace[2063007366] transaction","detail":"{read_only:false; response_revision:2729; number_of_response:1; }","duration":"320.174796ms","start":"2026-06-16T00:22:02.482027Z","end":"2026-06-16T00:22:02.802202Z","steps":["trace[2063007366] 'process raft request' (duration: 72.920629ms)","trace[2063007366] 'compare' (duration: 246.528848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:22:02.802327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:22:02.482002Z","time spent":"320.285177ms","remote":"127.0.0.1:55890","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-16T00:22:02.802675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.866516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b967d76d318b0c\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-16T00:22:02.802778Z","caller":"traceutil/trace.go:171","msg":"trace[692141347] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b967d76d318b0c; range_end:; response_count:1; response_revision:2730; }","duration":"251.011317ms","start":"2026-06-16T00:22:02.551744Z","end":"2026-06-16T00:22:02.802756Z","steps":["trace[692141347] 'agreement among raft nodes before linearized reading' (duration: 250.618833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:22:02.802721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.431273ms","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-16T00:22:02.802906Z","caller":"traceutil/trace.go:171","msg":"trace[1161247295] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"305.380295ms","start":"2026-06-16T00:22:02.49749Z","end":"2026-06-16T00:22:02.802871Z","steps":["trace[1161247295] 'process raft request' (duration: 304.462545ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:22:02.802968Z","caller":"traceutil/trace.go:171","msg":"trace[1111989232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2730; }","duration":"205.673036ms","start":"2026-06-16T00:22:02.597243Z","end":"2026-06-16T00:22:02.802916Z","steps":["trace[1111989232] 'agreement among raft nodes before linearized reading' (duration: 205.365722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:22:02.803075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:22:02.497453Z","time spent":"305.540817ms","remote":"127.0.0.1:55890","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-16T00:22:03.254768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.727716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:22:03.254998Z","caller":"traceutil/trace.go:171","msg":"trace[109610007] linearizableReadLoop","detail":"{readStateIndex:2836; appliedIndex:2834; }","duration":"274.233345ms","start":"2026-06-16T00:22:02.980743Z","end":"2026-06-16T00:22:03.254976Z","steps":["trace[109610007] 'read index received' (duration: 127.149606ms)","trace[109610007] 'applied index is now lower than readState.Index' (duration: 147.082519ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:22:03.255125Z","caller":"traceutil/trace.go:171","msg":"trace[1341963655] transaction","detail":"{read_only:false; response_revision:2732; number_of_response:1; }","duration":"447.993737ms","start":"2026-06-16T00:22:02.807088Z","end":"2026-06-16T00:22:03.255082Z","steps":["trace[1341963655] 'process raft request' (duration: 447.811435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:22:03.255223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.477908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:22:03.255276Z","caller":"traceutil/trace.go:171","msg":"trace[688399029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2732; }","duration":"274.563278ms","start":"2026-06-16T00:22:02.9807Z","end":"2026-06-16T00:22:03.255263Z","steps":["trace[688399029] 'agreement among raft nodes before linearized reading' (duration: 274.393567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:22:03.255283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:22:02.807079Z","time spent":"448.117788ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:22:03.255551Z","caller":"traceutil/trace.go:171","msg":"trace[1953859125] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"449.938587ms","start":"2026-06-16T00:22:02.805594Z","end":"2026-06-16T00:22:03.255532Z","steps":["trace[1953859125] 'process raft request' (duration: 302.304181ms)","trace[1953859125] 'compare' (duration: 146.591814ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:22:03.255646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:22:02.805576Z","time spent":"450.020739ms","remote":"127.0.0.1:55738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:23:26.417962Z","caller":"traceutil/trace.go:171","msg":"trace[1949077283] linearizableReadLoop","detail":"{readStateIndex:3290; appliedIndex:3289; }","duration":"144.284392ms","start":"2026-06-16T00:23:26.273654Z","end":"2026-06-16T00:23:26.417938Z","steps":["trace[1949077283] 'read index received' (duration: 144.183429ms)","trace[1949077283] 'applied index is now lower than readState.Index' (duration: 99.833µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:23:26.418083Z","caller":"traceutil/trace.go:171","msg":"trace[123783414] transaction","detail":"{read_only:false; response_revision:3168; number_of_response:1; }","duration":"252.253343ms","start":"2026-06-16T00:23:26.16582Z","end":"2026-06-16T00:23:26.418074Z","steps":["trace[123783414] 'process raft request' (duration: 251.981385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:23:26.418237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.106179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-06-16T00:23:26.418274Z","caller":"traceutil/trace.go:171","msg":"trace[1434808345] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:3168; }","duration":"124.166141ms","start":"2026-06-16T00:23:26.294095Z","end":"2026-06-16T00:23:26.418262Z","steps":["trace[1434808345] 'agreement among raft nodes before linearized reading' (duration: 124.027437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:23:26.419229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.578593ms","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-16T00:23:26.419269Z","caller":"traceutil/trace.go:171","msg":"trace[1738816461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3168; }","duration":"145.619434ms","start":"2026-06-16T00:23:26.273641Z","end":"2026-06-16T00:23:26.419261Z","steps":["trace[1738816461] 'agreement among raft nodes before linearized reading' (duration: 144.954533ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:24:35.19746Z","caller":"traceutil/trace.go:171","msg":"trace[664219242] transaction","detail":"{read_only:false; response_revision:3626; number_of_response:1; }","duration":"117.563556ms","start":"2026-06-16T00:24:35.079842Z","end":"2026-06-16T00:24:35.197405Z","steps":["trace[664219242] 'process raft request' (duration: 70.330685ms)","trace[664219242] 'compare' (duration: 47.076677ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:00.289403Z","caller":"traceutil/trace.go:171","msg":"trace[333313774] linearizableReadLoop","detail":"{readStateIndex:3969; appliedIndex:3968; }","duration":"125.668946ms","start":"2026-06-16T00:25:00.163703Z","end":"2026-06-16T00:25:00.289372Z","steps":["trace[333313774] 'read index received' (duration: 125.418711ms)","trace[333313774] 'applied index is now lower than readState.Index' (duration: 248.485µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:00.289541Z","caller":"traceutil/trace.go:171","msg":"trace[20412960] transaction","detail":"{read_only:false; response_revision:3821; number_of_response:1; }","duration":"134.176854ms","start":"2026-06-16T00:25:00.155323Z","end":"2026-06-16T00:25:00.2895Z","steps":["trace[20412960] 'process raft request' (duration: 133.881298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:00.289801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.078286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-16T00:25:00.289981Z","caller":"traceutil/trace.go:171","msg":"trace[1502740420] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:3821; }","duration":"126.181428ms","start":"2026-06-16T00:25:00.163661Z","end":"2026-06-16T00:25:00.289842Z","steps":["trace[1502740420] 'agreement among raft nodes before linearized reading' (duration: 125.85413ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:07.716442Z","caller":"traceutil/trace.go:171","msg":"trace[929407406] transaction","detail":"{read_only:false; response_revision:3867; number_of_response:1; }","duration":"155.109217ms","start":"2026-06-16T00:25:07.561298Z","end":"2026-06-16T00:25:07.716408Z","steps":["trace[929407406] 'process raft request' (duration: 77.766243ms)","trace[929407406] 'compare' (duration: 77.16249ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:10.530597Z","caller":"traceutil/trace.go:171","msg":"trace[1768934275] linearizableReadLoop","detail":"{readStateIndex:4032; appliedIndex:4031; }","duration":"181.983454ms","start":"2026-06-16T00:25:10.348571Z","end":"2026-06-16T00:25:10.530555Z","steps":["trace[1768934275] 'read index received' (duration: 181.873481ms)","trace[1768934275] 'applied index is now lower than readState.Index' (duration: 108.143µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:10.530692Z","caller":"traceutil/trace.go:171","msg":"trace[715928847] transaction","detail":"{read_only:false; response_revision:3881; number_of_response:1; }","duration":"275.739745ms","start":"2026-06-16T00:25:10.254877Z","end":"2026-06-16T00:25:10.530617Z","steps":["trace[715928847] 'process raft request' (duration: 275.468349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:10.530983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.384583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T00:25:10.531639Z","caller":"traceutil/trace.go:171","msg":"trace[1916596105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3881; }","duration":"183.033517ms","start":"2026-06-16T00:25:10.348519Z","end":"2026-06-16T00:25:10.531552Z","steps":["trace[1916596105] 'agreement among raft nodes before linearized reading' (duration: 182.205078ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:10.567561Z","caller":"traceutil/trace.go:171","msg":"trace[1644415957] transaction","detail":"{read_only:false; response_revision:3882; number_of_response:1; }","duration":"114.041356ms","start":"2026-06-16T00:25:10.453492Z","end":"2026-06-16T00:25:10.567534Z","steps":["trace[1644415957] 'process raft request' (duration: 113.877143ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:35.224976Z","caller":"traceutil/trace.go:171","msg":"trace[123131266] transaction","detail":"{read_only:false; response_revision:4012; number_of_response:1; }","duration":"133.446175ms","start":"2026-06-16T00:25:35.091503Z","end":"2026-06-16T00:25:35.22495Z","steps":["trace[123131266] 'process raft request' (duration: 133.21587ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:35.241714Z","caller":"traceutil/trace.go:171","msg":"trace[1733501640] transaction","detail":"{read_only:false; response_revision:4014; number_of_response:1; }","duration":"136.259742ms","start":"2026-06-16T00:25:35.105433Z","end":"2026-06-16T00:25:35.241692Z","steps":["trace[1733501640] 'process raft request' (duration: 135.985605ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:35.241712Z","caller":"traceutil/trace.go:171","msg":"trace[395532870] transaction","detail":"{read_only:false; response_revision:4013; number_of_response:1; }","duration":"136.284812ms","start":"2026-06-16T00:25:35.105395Z","end":"2026-06-16T00:25:35.24168Z","steps":["trace[395532870] 'process raft request' (duration: 135.830262ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:35.241993Z","caller":"traceutil/trace.go:171","msg":"trace[1074124900] transaction","detail":"{read_only:false; response_revision:4015; number_of_response:1; }","duration":"136.475776ms","start":"2026-06-16T00:25:35.105506Z","end":"2026-06-16T00:25:35.241982Z","steps":["trace[1074124900] 'process raft request' (duration: 135.941184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:48.84007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.146654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-16T00:25:48.840194Z","caller":"traceutil/trace.go:171","msg":"trace[1244140873] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4533; }","duration":"119.282036ms","start":"2026-06-16T00:25:48.720886Z","end":"2026-06-16T00:25:48.840168Z","steps":["trace[1244140873] 'range keys from in-memory index tree' (duration: 116.784418ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:50.265837Z","caller":"traceutil/trace.go:171","msg":"trace[1660055309] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"114.853249ms","start":"2026-06-16T00:25:50.150953Z","end":"2026-06-16T00:25:50.265807Z","steps":["trace[1660055309] 'process raft request' (duration: 51.507775ms)","trace[1660055309] 'compare' (duration: 63.10834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:25:50.266164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.936171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-16T00:25:50.265726Z","caller":"traceutil/trace.go:171","msg":"trace[1734234594] linearizableReadLoop","detail":"{readStateIndex:4733; appliedIndex:4732; }","duration":"100.516333ms","start":"2026-06-16T00:25:50.165181Z","end":"2026-06-16T00:25:50.265697Z","steps":["trace[1734234594] 'read index received' (duration: 37.23429ms)","trace[1734234594] 'applied index is now lower than readState.Index' (duration: 63.281053ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:50.266259Z","caller":"traceutil/trace.go:171","msg":"trace[1006858736] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:4557; }","duration":"101.102343ms","start":"2026-06-16T00:25:50.165134Z","end":"2026-06-16T00:25:50.266236Z","steps":["trace[1006858736] 'agreement among raft nodes before linearized reading' (duration: 100.796818ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:51.54094Z","caller":"traceutil/trace.go:171","msg":"trace[1766908699] linearizableReadLoop","detail":"{readStateIndex:4740; appliedIndex:4739; }","duration":"389.882756ms","start":"2026-06-16T00:25:51.151037Z","end":"2026-06-16T00:25:51.54092Z","steps":["trace[1766908699] 'read index received' (duration: 389.759343ms)","trace[1766908699] 'applied index is now lower than readState.Index' (duration: 122.633µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:51.541136Z","caller":"traceutil/trace.go:171","msg":"trace[1411327844] transaction","detail":"{read_only:false; response_revision:4563; number_of_response:1; }","duration":"423.700508ms","start":"2026-06-16T00:25:51.117401Z","end":"2026-06-16T00:25:51.541101Z","steps":["trace[1411327844] 'process raft request' (duration: 423.334311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:51.541298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:25:51.117369Z","time spent":"423.839941ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4067,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:25:51.541372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.314845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-06-16T00:25:51.541512Z","caller":"traceutil/trace.go:171","msg":"trace[1136223091] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf; range_end:; response_count:1; response_revision:4563; }","duration":"390.483218ms","start":"2026-06-16T00:25:51.150976Z","end":"2026-06-16T00:25:51.54146Z","steps":["trace[1136223091] 'agreement among raft nodes before linearized reading' (duration: 390.156252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:51.541556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:25:51.150952Z","time spent":"390.59414ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4073,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf\" "} {"level":"warn","ts":"2026-06-16T00:25:51.546651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.859026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:25:51.546729Z","caller":"traceutil/trace.go:171","msg":"trace[1326448461] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4564; }","duration":"390.980888ms","start":"2026-06-16T00:25:51.155718Z","end":"2026-06-16T00:25:51.546699Z","steps":["trace[1326448461] 'agreement among raft nodes before linearized reading' (duration: 390.852686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:51.546762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:25:51.155696Z","time spent":"391.059319ms","remote":"127.0.0.1:60192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-06-16T00:25:51.54693Z","caller":"traceutil/trace.go:171","msg":"trace[1655159470] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"244.387582ms","start":"2026-06-16T00:25:51.302508Z","end":"2026-06-16T00:25:51.546896Z","steps":["trace[1655159470] 'process raft request' (duration: 243.911353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:51.547008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.890186ms","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-16T00:25:51.547065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.413598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-16T00:25:51.547088Z","caller":"traceutil/trace.go:171","msg":"trace[1978042305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4564; }","duration":"235.484889ms","start":"2026-06-16T00:25:51.311597Z","end":"2026-06-16T00:25:51.547082Z","steps":["trace[1978042305] 'agreement among raft nodes before linearized reading' (duration: 235.389047ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:51.547091Z","caller":"traceutil/trace.go:171","msg":"trace[996148182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4564; }","duration":"240.019147ms","start":"2026-06-16T00:25:51.307058Z","end":"2026-06-16T00:25:51.547078Z","steps":["trace[996148182] 'agreement among raft nodes before linearized reading' (duration: 239.844154ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:53.386834Z","caller":"traceutil/trace.go:171","msg":"trace[55241803] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"115.891625ms","start":"2026-06-16T00:25:53.270909Z","end":"2026-06-16T00:25:53.386801Z","steps":["trace[55241803] 'process raft request' (duration: 81.622407ms)","trace[55241803] 'compare' (duration: 33.773388ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:53.771918Z","caller":"traceutil/trace.go:171","msg":"trace[90426101] linearizableReadLoop","detail":"{readStateIndex:4791; appliedIndex:4790; }","duration":"297.276364ms","start":"2026-06-16T00:25:53.474611Z","end":"2026-06-16T00:25:53.771888Z","steps":["trace[90426101] 'read index received' (duration: 297.0797ms)","trace[90426101] 'applied index is now lower than readState.Index' (duration: 195.684µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:25:53.772034Z","caller":"traceutil/trace.go:171","msg":"trace[531145116] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"301.295741ms","start":"2026-06-16T00:25:53.470707Z","end":"2026-06-16T00:25:53.772002Z","steps":["trace[531145116] 'process raft request' (duration: 301.022596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:53.772261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.618571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"warn","ts":"2026-06-16T00:25:53.772277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:25:53.470681Z","time spent":"301.443734ms","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3387,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T00:25:53.772307Z","caller":"traceutil/trace.go:171","msg":"trace[1844672863] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4613; }","duration":"297.718812ms","start":"2026-06-16T00:25:53.474576Z","end":"2026-06-16T00:25:53.772294Z","steps":["trace[1844672863] 'agreement among raft nodes before linearized reading' (duration: 297.446947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:53.774365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.977556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:25:53.774464Z","caller":"traceutil/trace.go:171","msg":"trace[1490115491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4615; }","duration":"252.125918ms","start":"2026-06-16T00:25:53.522317Z","end":"2026-06-16T00:25:53.774443Z","steps":["trace[1490115491] 'agreement among raft nodes before linearized reading' (duration: 251.571207ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:53.774429Z","caller":"traceutil/trace.go:171","msg":"trace[1678607598] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"221.969699ms","start":"2026-06-16T00:25:53.552372Z","end":"2026-06-16T00:25:53.774342Z","steps":["trace[1678607598] 'process raft request' (duration: 221.346437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:53.774976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.244254ms","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-16T00:25:53.77502Z","caller":"traceutil/trace.go:171","msg":"trace[608391964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4615; }","duration":"161.371415ms","start":"2026-06-16T00:25:53.613638Z","end":"2026-06-16T00:25:53.775009Z","steps":["trace[608391964] 'agreement among raft nodes before linearized reading' (duration: 161.10372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:53.784924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.256512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-16T00:25:53.78507Z","caller":"traceutil/trace.go:171","msg":"trace[451713865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4615; }","duration":"127.422046ms","start":"2026-06-16T00:25:53.65759Z","end":"2026-06-16T00:25:53.785012Z","steps":["trace[451713865] 'agreement among raft nodes before linearized reading' (duration: 117.667908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:53.785711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.833342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-16T00:25:53.785781Z","caller":"traceutil/trace.go:171","msg":"trace[719029919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4615; }","duration":"153.915334ms","start":"2026-06-16T00:25:53.631843Z","end":"2026-06-16T00:25:53.785758Z","steps":["trace[719029919] 'agreement among raft nodes before linearized reading' (duration: 153.740381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:53.787086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.251308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-16T00:25:53.7872Z","caller":"traceutil/trace.go:171","msg":"trace[792108928] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4615; }","duration":"156.425132ms","start":"2026-06-16T00:25:53.630747Z","end":"2026-06-16T00:25:53.787172Z","steps":["trace[792108928] 'agreement among raft nodes before linearized reading' (duration: 143.979232ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:54.99199Z","caller":"traceutil/trace.go:171","msg":"trace[420692715] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"136.189758ms","start":"2026-06-16T00:25:54.855774Z","end":"2026-06-16T00:25:54.991964Z","steps":["trace[420692715] 'process raft request' (duration: 135.721039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:59.396099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.796104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8361a3eb-2d8c-4e95-844b-a71f66fabb39\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-16T00:25:59.396203Z","caller":"traceutil/trace.go:171","msg":"trace[1532026687] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8361a3eb-2d8c-4e95-844b-a71f66fabb39; range_end:; response_count:1; response_revision:4724; }","duration":"207.942166ms","start":"2026-06-16T00:25:59.188239Z","end":"2026-06-16T00:25:59.396181Z","steps":["trace[1532026687] 'range keys from in-memory index tree' (duration: 207.575399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:59.396309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.795738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:25:59.396387Z","caller":"traceutil/trace.go:171","msg":"trace[444095865] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4724; }","duration":"222.933401ms","start":"2026-06-16T00:25:59.173435Z","end":"2026-06-16T00:25:59.396368Z","steps":["trace[444095865] 'count revisions from in-memory index tree' (duration: 222.716026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:59.39641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.552954ms","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-16T00:25:59.39645Z","caller":"traceutil/trace.go:171","msg":"trace[267381034] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4724; }","duration":"212.592615ms","start":"2026-06-16T00:25:59.183848Z","end":"2026-06-16T00:25:59.396441Z","steps":["trace[267381034] 'range keys from in-memory index tree' (duration: 212.457242ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:25:59.796941Z","caller":"traceutil/trace.go:171","msg":"trace[930053038] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"396.540226ms","start":"2026-06-16T00:25:59.400355Z","end":"2026-06-16T00:25:59.796895Z","steps":["trace[930053038] 'process raft request' (duration: 396.349363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:25:59.797171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:25:59.400331Z","time spent":"396.7114ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:26:00.047155Z","caller":"traceutil/trace.go:171","msg":"trace[343787295] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"643.02929ms","start":"2026-06-16T00:25:59.404092Z","end":"2026-06-16T00:26:00.047121Z","steps":["trace[343787295] 'process raft request' (duration: 636.694101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.04733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:25:59.404082Z","time spent":"643.148112ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:26:00.078759Z","caller":"traceutil/trace.go:171","msg":"trace[1827881871] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"270.270424ms","start":"2026-06-16T00:25:59.808459Z","end":"2026-06-16T00:26:00.07873Z","steps":["trace[1827881871] 'process raft request' (duration: 270.205662ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:00.078862Z","caller":"traceutil/trace.go:171","msg":"trace[2109501775] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"276.569332ms","start":"2026-06-16T00:25:59.802241Z","end":"2026-06-16T00:26:00.078811Z","steps":["trace[2109501775] 'process raft request' (duration: 276.250875ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:00.078977Z","caller":"traceutil/trace.go:171","msg":"trace[1040961276] linearizableReadLoop","detail":"{readStateIndex:4909; appliedIndex:4906; }","duration":"264.136078ms","start":"2026-06-16T00:25:59.814806Z","end":"2026-06-16T00:26:00.078942Z","steps":["trace[1040961276] 'read index received' (duration: 225.999177ms)","trace[1040961276] 'applied index is now lower than readState.Index' (duration: 38.13476ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:26:00.079123Z","caller":"traceutil/trace.go:171","msg":"trace[1340544735] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"152.343371ms","start":"2026-06-16T00:25:59.926768Z","end":"2026-06-16T00:26:00.079111Z","steps":["trace[1340544735] 'process raft request' (duration: 151.927653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.07932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.513713ms","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-16T00:26:00.079382Z","caller":"traceutil/trace.go:171","msg":"trace[464019092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4729; }","duration":"255.616625ms","start":"2026-06-16T00:25:59.823748Z","end":"2026-06-16T00:26:00.079365Z","steps":["trace[464019092] 'agreement among raft nodes before linearized reading' (duration: 255.377481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.07941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.285485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-16T00:26:00.079449Z","caller":"traceutil/trace.go:171","msg":"trace[2000027731] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4729; }","duration":"250.428608ms","start":"2026-06-16T00:25:59.82901Z","end":"2026-06-16T00:26:00.079438Z","steps":["trace[2000027731] 'agreement among raft nodes before linearized reading' (duration: 250.254814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.079606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.750829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-16T00:26:00.079663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.924945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-16T00:26:00.079706Z","caller":"traceutil/trace.go:171","msg":"trace[893551489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4729; }","duration":"264.908112ms","start":"2026-06-16T00:25:59.814771Z","end":"2026-06-16T00:26:00.079679Z","steps":["trace[893551489] 'agreement among raft nodes before linearized reading' (duration: 264.661088ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:00.079722Z","caller":"traceutil/trace.go:171","msg":"trace[1585620421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4729; }","duration":"252.019098ms","start":"2026-06-16T00:25:59.82769Z","end":"2026-06-16T00:26:00.079709Z","steps":["trace[1585620421] 'agreement among raft nodes before linearized reading' (duration: 251.733282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.755883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.374227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:26:00.755981Z","caller":"traceutil/trace.go:171","msg":"trace[2061203754] linearizableReadLoop","detail":"{readStateIndex:4917; appliedIndex:4916; }","duration":"412.595653ms","start":"2026-06-16T00:26:00.343368Z","end":"2026-06-16T00:26:00.755964Z","steps":["trace[2061203754] 'read index received' (duration: 286.058193ms)","trace[2061203754] 'applied index is now lower than readState.Index' (duration: 126.53666ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:26:00.756029Z","caller":"traceutil/trace.go:171","msg":"trace[624869410] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"457.187425ms","start":"2026-06-16T00:26:00.298813Z","end":"2026-06-16T00:26:00.756Z","steps":["trace[624869410] 'process raft request' (duration: 330.604584ms)","trace[624869410] 'compare' (duration: 126.275126ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:26:00.756282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:00.298789Z","time spent":"457.346538ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:26:00.756068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.705686ms","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-16T00:26:00.756437Z","caller":"traceutil/trace.go:171","msg":"trace[1432333537] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4735; }","duration":"413.104712ms","start":"2026-06-16T00:26:00.343319Z","end":"2026-06-16T00:26:00.756424Z","steps":["trace[1432333537] 'agreement among raft nodes before linearized reading' (duration: 412.719605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.756502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:00.343299Z","time spent":"413.188455ms","remote":"127.0.0.1:56080","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-16T00:26:00.756492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.28785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-06-16T00:26:00.756546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.491595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:26:00.756574Z","caller":"traceutil/trace.go:171","msg":"trace[354074013] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4735; }","duration":"220.569847ms","start":"2026-06-16T00:26:00.535996Z","end":"2026-06-16T00:26:00.756566Z","steps":["trace[354074013] 'agreement among raft nodes before linearized reading' (duration: 220.513036ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:00.756571Z","caller":"traceutil/trace.go:171","msg":"trace[42601285] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4735; }","duration":"384.429883ms","start":"2026-06-16T00:26:00.372121Z","end":"2026-06-16T00:26:00.756551Z","steps":["trace[42601285] 'agreement among raft nodes before linearized reading' (duration: 384.206357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.756612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:00.37208Z","time spent":"384.525084ms","remote":"127.0.0.1:37540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-06-16T00:26:00.757294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.424882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8361a3eb-2d8c-4e95-844b-a71f66fabb39\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-06-16T00:26:00.75741Z","caller":"traceutil/trace.go:171","msg":"trace[507465796] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8361a3eb-2d8c-4e95-844b-a71f66fabb39; range_end:; response_count:1; response_revision:4735; }","duration":"356.534884ms","start":"2026-06-16T00:26:00.40081Z","end":"2026-06-16T00:26:00.757345Z","steps":["trace[507465796] 'agreement among raft nodes before linearized reading' (duration: 355.76232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:00.75746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:00.400789Z","time spent":"356.657697ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3786,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8361a3eb-2d8c-4e95-844b-a71f66fabb39\" "} {"level":"warn","ts":"2026-06-16T00:26:02.237772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.723394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-16T00:26:02.237862Z","caller":"traceutil/trace.go:171","msg":"trace[1203409883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4755; }","duration":"133.875777ms","start":"2026-06-16T00:26:02.103965Z","end":"2026-06-16T00:26:02.237841Z","steps":["trace[1203409883] 'range keys from in-memory index tree' (duration: 133.545811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:02.237861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.196403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-16T00:26:02.237873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.015596ms","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-16T00:26:02.237946Z","caller":"traceutil/trace.go:171","msg":"trace[476731164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4755; }","duration":"121.126217ms","start":"2026-06-16T00:26:02.116803Z","end":"2026-06-16T00:26:02.23793Z","steps":["trace[476731164] 'range keys from in-memory index tree' (duration: 120.921684ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:02.237964Z","caller":"traceutil/trace.go:171","msg":"trace[1366502687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4755; }","duration":"134.358187ms","start":"2026-06-16T00:26:02.103584Z","end":"2026-06-16T00:26:02.237943Z","steps":["trace[1366502687] 'range keys from in-memory index tree' (duration: 133.99598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:02.238061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.485406ms","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-16T00:26:02.238132Z","caller":"traceutil/trace.go:171","msg":"trace[1907740062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4755; }","duration":"120.623029ms","start":"2026-06-16T00:26:02.117494Z","end":"2026-06-16T00:26:02.238117Z","steps":["trace[1907740062] 'range keys from in-memory index tree' (duration: 120.397284ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:05.435218Z","caller":"traceutil/trace.go:171","msg":"trace[1913419376] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"151.875788ms","start":"2026-06-16T00:26:05.283303Z","end":"2026-06-16T00:26:05.435179Z","steps":["trace[1913419376] 'process raft request' (duration: 151.689965ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:05.435463Z","caller":"traceutil/trace.go:171","msg":"trace[194836870] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5008; }","duration":"149.26826ms","start":"2026-06-16T00:26:05.285923Z","end":"2026-06-16T00:26:05.435191Z","steps":["trace[194836870] 'read index received' (duration: 149.202028ms)","trace[194836870] 'applied index is now lower than readState.Index' (duration: 63.152µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:26:05.435634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.649786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:26:05.435765Z","caller":"traceutil/trace.go:171","msg":"trace[489284086] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4826; }","duration":"149.874081ms","start":"2026-06-16T00:26:05.285859Z","end":"2026-06-16T00:26:05.435734Z","steps":["trace[489284086] 'agreement among raft nodes before linearized reading' (duration: 149.546645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:10.49916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.524456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-16T00:26:10.499234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.26575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13287"} {"level":"info","ts":"2026-06-16T00:26:10.49926Z","caller":"traceutil/trace.go:171","msg":"trace[922928460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4889; }","duration":"201.685669ms","start":"2026-06-16T00:26:10.297551Z","end":"2026-06-16T00:26:10.499237Z","steps":["trace[922928460] 'range keys from in-memory index tree' (duration: 201.300551ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.499288Z","caller":"traceutil/trace.go:171","msg":"trace[1070922190] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4889; }","duration":"187.387413ms","start":"2026-06-16T00:26:10.311883Z","end":"2026-06-16T00:26:10.499271Z","steps":["trace[1070922190] 'range keys from in-memory index tree' (duration: 187.104398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:10.499286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.956796ms","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-16T00:26:10.499388Z","caller":"traceutil/trace.go:171","msg":"trace[1837574164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4889; }","duration":"200.118359ms","start":"2026-06-16T00:26:10.299238Z","end":"2026-06-16T00:26:10.499357Z","steps":["trace[1837574164] 'range keys from in-memory index tree' (duration: 199.749613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:10.499489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.08868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:26:10.49958Z","caller":"traceutil/trace.go:171","msg":"trace[1537206180] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:4889; }","duration":"165.308605ms","start":"2026-06-16T00:26:10.334249Z","end":"2026-06-16T00:26:10.499558Z","steps":["trace[1537206180] 'count revisions from in-memory index tree' (duration: 164.898827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:10.499542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.773287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-06-16T00:26:10.499625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.335384ms","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-16T00:26:10.49966Z","caller":"traceutil/trace.go:171","msg":"trace[547564434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4889; }","duration":"200.408745ms","start":"2026-06-16T00:26:10.299238Z","end":"2026-06-16T00:26:10.499647Z","steps":["trace[547564434] 'range keys from in-memory index tree' (duration: 200.212402ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.499652Z","caller":"traceutil/trace.go:171","msg":"trace[1308607292] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4889; }","duration":"117.930871ms","start":"2026-06-16T00:26:10.381694Z","end":"2026-06-16T00:26:10.499625Z","steps":["trace[1308607292] 'range keys from in-memory index tree' (duration: 117.566323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:10.499656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.437305ms","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-16T00:26:10.499782Z","caller":"traceutil/trace.go:171","msg":"trace[310223953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4889; }","duration":"200.581329ms","start":"2026-06-16T00:26:10.299157Z","end":"2026-06-16T00:26:10.499738Z","steps":["trace[310223953] 'range keys from in-memory index tree' (duration: 200.273822ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.655811Z","caller":"traceutil/trace.go:171","msg":"trace[480512933] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"151.977449ms","start":"2026-06-16T00:26:10.503799Z","end":"2026-06-16T00:26:10.655776Z","steps":["trace[480512933] 'process raft request' (duration: 151.796276ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.665614Z","caller":"traceutil/trace.go:171","msg":"trace[133040108] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"160.713281ms","start":"2026-06-16T00:26:10.504874Z","end":"2026-06-16T00:26:10.665588Z","steps":["trace[133040108] 'process raft request' (duration: 160.65575ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.665635Z","caller":"traceutil/trace.go:171","msg":"trace[274389194] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"161.230681ms","start":"2026-06-16T00:26:10.504381Z","end":"2026-06-16T00:26:10.665612Z","steps":["trace[274389194] 'process raft request' (duration: 161.005097ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.665914Z","caller":"traceutil/trace.go:171","msg":"trace[2064561034] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"159.57405ms","start":"2026-06-16T00:26:10.506327Z","end":"2026-06-16T00:26:10.665901Z","steps":["trace[2064561034] 'process raft request' (duration: 159.233754ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:10.66627Z","caller":"traceutil/trace.go:171","msg":"trace[1407977247] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"153.743852ms","start":"2026-06-16T00:26:10.512518Z","end":"2026-06-16T00:26:10.666261Z","steps":["trace[1407977247] 'process raft request' (duration: 153.263814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:16.369421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496755811829896,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:26:16.870627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496755811829896,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:26:17.022633Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.154877181s","expected-duration":"1s"} {"level":"info","ts":"2026-06-16T00:26:17.023016Z","caller":"traceutil/trace.go:171","msg":"trace[895006823] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"1.155393949s","start":"2026-06-16T00:26:15.867596Z","end":"2026-06-16T00:26:17.02299Z","steps":["trace[895006823] 'process raft request' (duration: 1.155220316s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.023184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:15.867566Z","time spent":"1.155497061s","remote":"127.0.0.1:55738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:26:17.043845Z","caller":"traceutil/trace.go:171","msg":"trace[2016991607] linearizableReadLoop","detail":"{readStateIndex:5131; appliedIndex:5128; }","duration":"1.175494686s","start":"2026-06-16T00:26:15.868333Z","end":"2026-06-16T00:26:17.043827Z","steps":["trace[2016991607] 'read index received' (duration: 1.154803489s)","trace[2016991607] 'applied index is now lower than readState.Index' (duration: 20.689977ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:26:17.043985Z","caller":"traceutil/trace.go:171","msg":"trace[1197130282] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"904.994882ms","start":"2026-06-16T00:26:16.138978Z","end":"2026-06-16T00:26:17.043973Z","steps":["trace[1197130282] 'process raft request' (duration: 904.775858ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.044005Z","caller":"traceutil/trace.go:171","msg":"trace[215421326] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"889.421728ms","start":"2026-06-16T00:26:16.154532Z","end":"2026-06-16T00:26:17.043954Z","steps":["trace[215421326] 'process raft request' (duration: 889.257886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.710987ms","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-16T00:26:17.044185Z","caller":"traceutil/trace.go:171","msg":"trace[1031579278] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4943; }","duration":"358.763048ms","start":"2026-06-16T00:26:16.685415Z","end":"2026-06-16T00:26:17.044178Z","steps":["trace[1031579278] 'agreement among raft nodes before linearized reading' (duration: 358.668897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.685406Z","time spent":"358.796329ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T00:26:17.044247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137078973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T00:26:17.044348Z","caller":"traceutil/trace.go:171","msg":"trace[1583400757] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4943; }","duration":"1.137233026s","start":"2026-06-16T00:26:15.907093Z","end":"2026-06-16T00:26:17.044326Z","steps":["trace[1583400757] 'agreement among raft nodes before linearized reading' (duration: 1.136932861s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176004745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1451"} {"level":"warn","ts":"2026-06-16T00:26:17.0444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:15.907075Z","time spent":"1.137314067s","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-16T00:26:17.044171Z","caller":"traceutil/trace.go:171","msg":"trace[208726714] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"906.033841ms","start":"2026-06-16T00:26:16.13797Z","end":"2026-06-16T00:26:17.044004Z","steps":["trace[208726714] 'process raft request' (duration: 905.678995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.425824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-16T00:26:17.044585Z","caller":"traceutil/trace.go:171","msg":"trace[2023394798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4943; }","duration":"357.486526ms","start":"2026-06-16T00:26:16.687092Z","end":"2026-06-16T00:26:17.044578Z","steps":["trace[2023394798] 'agreement among raft nodes before linearized reading' (duration: 357.428435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.154522Z","time spent":"889.601452ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:26:17.044055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.13897Z","time spent":"905.053083ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:26:17.0445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.335793ms","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-16T00:26:17.044836Z","caller":"traceutil/trace.go:171","msg":"trace[1704608656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4943; }","duration":"357.678439ms","start":"2026-06-16T00:26:16.687143Z","end":"2026-06-16T00:26:17.044822Z","steps":["trace[1704608656] 'agreement among raft nodes before linearized reading' (duration: 357.288972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.687138Z","time spent":"357.72752ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T00:26:17.044793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.530238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16403"} {"level":"info","ts":"2026-06-16T00:26:17.044944Z","caller":"traceutil/trace.go:171","msg":"trace[1957267900] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4943; }","duration":"672.697711ms","start":"2026-06-16T00:26:16.372238Z","end":"2026-06-16T00:26:17.044936Z","steps":["trace[1957267900] 'agreement among raft nodes before linearized reading' (duration: 672.439776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.044964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.372182Z","time spent":"672.775392ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16426,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-06-16T00:26:17.044606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.687082Z","time spent":"357.518956ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T00:26:17.04503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.83397ms","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-16T00:26:17.045181Z","caller":"traceutil/trace.go:171","msg":"trace[1031421190] 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:4943; }","duration":"623.236637ms","start":"2026-06-16T00:26:16.421901Z","end":"2026-06-16T00:26:17.045137Z","steps":["trace[1031421190] 'agreement among raft nodes before linearized reading' (duration: 622.649346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.045258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.421878Z","time spent":"623.339909ms","remote":"127.0.0.1:55828","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":"warn","ts":"2026-06-16T00:26:17.044888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045435486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-16T00:26:17.045355Z","caller":"traceutil/trace.go:171","msg":"trace[557906989] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4943; }","duration":"1.045934645s","start":"2026-06-16T00:26:15.999388Z","end":"2026-06-16T00:26:17.045323Z","steps":["trace[557906989] 'agreement among raft nodes before linearized reading' (duration: 1.045430586s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.045366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.892081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-16T00:26:17.045396Z","caller":"traceutil/trace.go:171","msg":"trace[1691180261] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4943; }","duration":"364.925871ms","start":"2026-06-16T00:26:16.680463Z","end":"2026-06-16T00:26:17.045389Z","steps":["trace[1691180261] 'agreement among raft nodes before linearized reading' (duration: 364.84652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.045409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:15.999357Z","time spent":"1.046033077s","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T00:26:17.045418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.680387Z","time spent":"365.026323ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T00:26:17.045029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:16.137941Z","time spent":"906.620332ms","remote":"127.0.0.1:55890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:26:17.044421Z","caller":"traceutil/trace.go:171","msg":"trace[1995985434] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4943; }","duration":"1.176095058s","start":"2026-06-16T00:26:15.868313Z","end":"2026-06-16T00:26:17.044408Z","steps":["trace[1995985434] 'agreement among raft nodes before linearized reading' (duration: 1.175610619s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.046132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:26:15.868306Z","time spent":"1.177772287s","remote":"127.0.0.1:55840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":1474,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-06-16T00:26:17.151723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.906883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:26:17.151827Z","caller":"traceutil/trace.go:171","msg":"trace[611097678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4943; }","duration":"104.045206ms","start":"2026-06-16T00:26:17.047757Z","end":"2026-06-16T00:26:17.151802Z","steps":["trace[611097678] 'range keys from in-memory index tree' (duration: 103.842701ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.152417Z","caller":"traceutil/trace.go:171","msg":"trace[597005929] linearizableReadLoop","detail":"{readStateIndex:5132; appliedIndex:5131; }","duration":"100.787696ms","start":"2026-06-16T00:26:17.051618Z","end":"2026-06-16T00:26:17.152406Z","steps":["trace[597005929] 'read index received' (duration: 13.240821ms)","trace[597005929] 'applied index is now lower than readState.Index' (duration: 87.546165ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:26:17.152601Z","caller":"traceutil/trace.go:171","msg":"trace[1969636611] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"100.98423ms","start":"2026-06-16T00:26:17.051575Z","end":"2026-06-16T00:26:17.152559Z","steps":["trace[1969636611] 'process raft request' (duration: 13.278912ms)","trace[1969636611] 'compare' (duration: 87.27639ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:26:17.152923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.262186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-06-16T00:26:17.153024Z","caller":"traceutil/trace.go:171","msg":"trace[553059309] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4944; }","duration":"101.402598ms","start":"2026-06-16T00:26:17.051597Z","end":"2026-06-16T00:26:17.153Z","steps":["trace[553059309] 'agreement among raft nodes before linearized reading' (duration: 101.028521ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.169579Z","caller":"traceutil/trace.go:171","msg":"trace[283522621] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"116.681286ms","start":"2026-06-16T00:26:17.052884Z","end":"2026-06-16T00:26:17.169565Z","steps":["trace[283522621] 'process raft request' (duration: 116.627405ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.169671Z","caller":"traceutil/trace.go:171","msg":"trace[782679573] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"117.94316ms","start":"2026-06-16T00:26:17.051683Z","end":"2026-06-16T00:26:17.169626Z","steps":["trace[782679573] 'process raft request' (duration: 117.738575ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.169857Z","caller":"traceutil/trace.go:171","msg":"trace[134703664] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"116.651206ms","start":"2026-06-16T00:26:17.053191Z","end":"2026-06-16T00:26:17.169842Z","steps":["trace[134703664] 'process raft request' (duration: 116.345849ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.170068Z","caller":"traceutil/trace.go:171","msg":"trace[1990540702] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"115.607787ms","start":"2026-06-16T00:26:17.054444Z","end":"2026-06-16T00:26:17.170052Z","steps":["trace[1990540702] 'process raft request' (duration: 115.310572ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.170326Z","caller":"traceutil/trace.go:171","msg":"trace[1249216064] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"109.442844ms","start":"2026-06-16T00:26:17.060874Z","end":"2026-06-16T00:26:17.170317Z","steps":["trace[1249216064] 'process raft request' (duration: 109.112148ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:17.219815Z","caller":"traceutil/trace.go:171","msg":"trace[2025516244] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"130.116091ms","start":"2026-06-16T00:26:17.08966Z","end":"2026-06-16T00:26:17.219776Z","steps":["trace[2025516244] 'process raft request' (duration: 129.887816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.220197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.244607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-16T00:26:17.220288Z","caller":"traceutil/trace.go:171","msg":"trace[1830852011] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4950; }","duration":"167.39262ms","start":"2026-06-16T00:26:17.052872Z","end":"2026-06-16T00:26:17.220265Z","steps":["trace[1830852011] 'agreement among raft nodes before linearized reading' (duration: 167.149455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.220298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.120493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b9681300d43fc7\" ","response":"range_response_count:1 size:740"} {"level":"info","ts":"2026-06-16T00:26:17.220354Z","caller":"traceutil/trace.go:171","msg":"trace[1229339220] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b9681300d43fc7; range_end:; response_count:1; response_revision:4950; }","duration":"168.211385ms","start":"2026-06-16T00:26:17.052128Z","end":"2026-06-16T00:26:17.220339Z","steps":["trace[1229339220] 'agreement among raft nodes before linearized reading' (duration: 167.909538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:17.221726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.578123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-16T00:26:17.221854Z","caller":"traceutil/trace.go:171","msg":"trace[607897077] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf; range_end:; response_count:1; response_revision:4950; }","duration":"170.164291ms","start":"2026-06-16T00:26:17.05165Z","end":"2026-06-16T00:26:17.221814Z","steps":["trace[607897077] 'agreement among raft nodes before linearized reading' (duration: 168.225705ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:51.31669Z","caller":"traceutil/trace.go:171","msg":"trace[800158987] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"118.420337ms","start":"2026-06-16T00:26:51.198209Z","end":"2026-06-16T00:26:51.31663Z","steps":["trace[800158987] 'process raft request' (duration: 118.101742ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:51.431103Z","caller":"traceutil/trace.go:171","msg":"trace[2092995999] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"232.086935ms","start":"2026-06-16T00:26:51.198987Z","end":"2026-06-16T00:26:51.431073Z","steps":["trace[2092995999] 'process raft request' (duration: 226.783334ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:26:51.431304Z","caller":"traceutil/trace.go:171","msg":"trace[59003514] linearizableReadLoop","detail":"{readStateIndex:5445; appliedIndex:5442; }","duration":"159.234557ms","start":"2026-06-16T00:26:51.272058Z","end":"2026-06-16T00:26:51.431293Z","steps":["trace[59003514] 'read index received' (duration: 44.209887ms)","trace[59003514] 'applied index is now lower than readState.Index' (duration: 115.02373ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:26:51.431435Z","caller":"traceutil/trace.go:171","msg":"trace[1983651216] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"223.161902ms","start":"2026-06-16T00:26:51.208263Z","end":"2026-06-16T00:26:51.431425Z","steps":["trace[1983651216] 'process raft request' (duration: 222.757095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:26:51.431576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.489892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:26:51.431615Z","caller":"traceutil/trace.go:171","msg":"trace[532527047] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:5249; }","duration":"159.594554ms","start":"2026-06-16T00:26:51.27201Z","end":"2026-06-16T00:26:51.431605Z","steps":["trace[532527047] 'agreement among raft nodes before linearized reading' (duration: 159.500752ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.410061Z","caller":"traceutil/trace.go:171","msg":"trace[2076288096] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"134.618932ms","start":"2026-06-16T00:27:03.275408Z","end":"2026-06-16T00:27:03.410027Z","steps":["trace[2076288096] 'process raft request' (duration: 134.385378ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.60145Z","caller":"traceutil/trace.go:171","msg":"trace[1390256161] linearizableReadLoop","detail":"{readStateIndex:5531; appliedIndex:5530; }","duration":"128.275227ms","start":"2026-06-16T00:27:03.47314Z","end":"2026-06-16T00:27:03.601415Z","steps":["trace[1390256161] 'read index received' (duration: 84.159505ms)","trace[1390256161] 'applied index is now lower than readState.Index' (duration: 44.113862ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:27:03.601876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.706133ms","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-16T00:27:03.601928Z","caller":"traceutil/trace.go:171","msg":"trace[1880661563] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5332; }","duration":"128.826525ms","start":"2026-06-16T00:27:03.473089Z","end":"2026-06-16T00:27:03.601916Z","steps":["trace[1880661563] 'agreement among raft nodes before linearized reading' (duration: 128.607361ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.602012Z","caller":"traceutil/trace.go:171","msg":"trace[1384969766] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"124.427581ms","start":"2026-06-16T00:27:03.477551Z","end":"2026-06-16T00:27:03.601978Z","steps":["trace[1384969766] 'process raft request' (duration: 124.114876ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.602129Z","caller":"traceutil/trace.go:171","msg":"trace[816880846] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"183.178919ms","start":"2026-06-16T00:27:03.418917Z","end":"2026-06-16T00:27:03.602096Z","steps":["trace[816880846] 'process raft request' (duration: 138.363366ms)","trace[816880846] 'compare' (duration: 43.797436ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:27:03.602284Z","caller":"traceutil/trace.go:171","msg":"trace[337350203] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"113.283225ms","start":"2026-06-16T00:27:03.488983Z","end":"2026-06-16T00:27:03.602266Z","steps":["trace[337350203] 'process raft request' (duration: 112.928438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:27:03.602381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.757473ms","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-16T00:27:03.605327Z","caller":"traceutil/trace.go:171","msg":"trace[1712551112] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5336; }","duration":"119.751673ms","start":"2026-06-16T00:27:03.485553Z","end":"2026-06-16T00:27:03.605305Z","steps":["trace[1712551112] 'agreement among raft nodes before linearized reading' (duration: 116.741872ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.602411Z","caller":"traceutil/trace.go:171","msg":"trace[1081350614] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"107.294014ms","start":"2026-06-16T00:27:03.495099Z","end":"2026-06-16T00:27:03.602393Z","steps":["trace[1081350614] 'process raft request' (duration: 107.034169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:27:03.602498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.207242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:27:03.605652Z","caller":"traceutil/trace.go:171","msg":"trace[62355021] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5336; }","duration":"107.400526ms","start":"2026-06-16T00:27:03.498228Z","end":"2026-06-16T00:27:03.605629Z","steps":["trace[62355021] 'agreement among raft nodes before linearized reading' (duration: 104.182982ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.800079Z","caller":"traceutil/trace.go:171","msg":"trace[1890700178] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"143.093365ms","start":"2026-06-16T00:27:03.656952Z","end":"2026-06-16T00:27:03.800045Z","steps":["trace[1890700178] 'process raft request' (duration: 120.389784ms)","trace[1890700178] 'compare' (duration: 22.398546ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:27:03.800459Z","caller":"traceutil/trace.go:171","msg":"trace[1542500187] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"141.997506ms","start":"2026-06-16T00:27:03.658425Z","end":"2026-06-16T00:27:03.800423Z","steps":["trace[1542500187] 'process raft request' (duration: 141.576609ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.801305Z","caller":"traceutil/trace.go:171","msg":"trace[1858363967] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"139.308141ms","start":"2026-06-16T00:27:03.661968Z","end":"2026-06-16T00:27:03.801276Z","steps":["trace[1858363967] 'process raft request' (duration: 139.270661ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.801311Z","caller":"traceutil/trace.go:171","msg":"trace[682672882] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"142.702378ms","start":"2026-06-16T00:27:03.658578Z","end":"2026-06-16T00:27:03.80128Z","steps":["trace[682672882] 'process raft request' (duration: 141.6505ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:03.801516Z","caller":"traceutil/trace.go:171","msg":"trace[105620493] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"139.609826ms","start":"2026-06-16T00:27:03.661896Z","end":"2026-06-16T00:27:03.801506Z","steps":["trace[105620493] 'process raft request' (duration: 139.290001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:27:17.739515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.160499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T00:27:17.739648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.112969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:1 size:5922"} {"level":"info","ts":"2026-06-16T00:27:17.740151Z","caller":"traceutil/trace.go:171","msg":"trace[379562644] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:1; response_revision:5436; }","duration":"103.627496ms","start":"2026-06-16T00:27:17.636457Z","end":"2026-06-16T00:27:17.740084Z","steps":["trace[379562644] 'range keys from in-memory index tree' (duration: 102.940265ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:17.739765Z","caller":"traceutil/trace.go:171","msg":"trace[127431324] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5436; }","duration":"103.404023ms","start":"2026-06-16T00:27:17.636268Z","end":"2026-06-16T00:27:17.739672Z","steps":["trace[127431324] 'range keys from in-memory index tree' (duration: 103.056317ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:26.929956Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2860} {"level":"info","ts":"2026-06-16T00:27:27.034382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2860,"took":"102.894914ms","hash":1776259549,"current-db-size-bytes":53264384,"current-db-size":"53 MB","current-db-size-in-use-bytes":28975104,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-16T00:27:27.034536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1776259549,"revision":2860,"compact-revision":-1} {"level":"warn","ts":"2026-06-16T00:27:36.42718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.230754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:27:36.427283Z","caller":"traceutil/trace.go:171","msg":"trace[1175770337] linearizableReadLoop","detail":"{readStateIndex:5779; appliedIndex:5778; }","duration":"355.839847ms","start":"2026-06-16T00:27:36.071426Z","end":"2026-06-16T00:27:36.427266Z","steps":["trace[1175770337] 'read index received' (duration: 251.486101ms)","trace[1175770337] 'applied index is now lower than readState.Index' (duration: 104.352596ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:27:36.427528Z","caller":"traceutil/trace.go:171","msg":"trace[1890462675] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"407.876362ms","start":"2026-06-16T00:27:36.01961Z","end":"2026-06-16T00:27:36.427486Z","steps":["trace[1890462675] 'process raft request' (duration: 303.250802ms)","trace[1890462675] 'compare' (duration: 104.116132ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:27:36.427679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:27:36.019599Z","time spent":"408.005654ms","remote":"127.0.0.1:55890","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-16T00:27:36.427734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.858707ms","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-16T00:27:36.427758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.050829ms","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-16T00:27:36.427776Z","caller":"traceutil/trace.go:171","msg":"trace[1592213298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5572; }","duration":"355.922408ms","start":"2026-06-16T00:27:36.071842Z","end":"2026-06-16T00:27:36.427764Z","steps":["trace[1592213298] 'agreement among raft nodes before linearized reading' (duration: 355.820696ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:27:36.427809Z","caller":"traceutil/trace.go:171","msg":"trace[1036860402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5572; }","duration":"356.126971ms","start":"2026-06-16T00:27:36.071669Z","end":"2026-06-16T00:27:36.427796Z","steps":["trace[1036860402] 'agreement among raft nodes before linearized reading' (duration: 355.995529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:27:36.427852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:27:36.071652Z","time spent":"356.192452ms","remote":"127.0.0.1:55890","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-16T00:27:36.42797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:27:36.071832Z","time spent":"356.123151ms","remote":"127.0.0.1:55890","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-16T00:27:36.427619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.168702ms","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-16T00:27:36.42845Z","caller":"traceutil/trace.go:171","msg":"trace[1462534064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5572; }","duration":"357.055237ms","start":"2026-06-16T00:27:36.071376Z","end":"2026-06-16T00:27:36.428431Z","steps":["trace[1462534064] 'agreement among raft nodes before linearized reading' (duration: 356.153732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:27:36.42849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:27:36.071355Z","time spent":"357.122128ms","remote":"127.0.0.1:55890","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-16T00:27:36.603136Z","caller":"traceutil/trace.go:171","msg":"trace[888049414] transaction","detail":"{read_only:false; response_revision:5575; number_of_response:1; }","duration":"169.92285ms","start":"2026-06-16T00:27:36.433182Z","end":"2026-06-16T00:27:36.603105Z","steps":["trace[888049414] 'process raft request' (duration: 154.245187ms)","trace[888049414] 'compare' (duration: 15.340227ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:28:42.812636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.203864ms","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-16T00:28:42.813389Z","caller":"traceutil/trace.go:171","msg":"trace[800815356] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5956; }","duration":"402.929374ms","start":"2026-06-16T00:28:42.410407Z","end":"2026-06-16T00:28:42.813336Z","steps":["trace[800815356] 'range keys from in-memory index tree' (duration: 402.188343ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:26.603698Z","caller":"traceutil/trace.go:171","msg":"trace[1638874547] transaction","detail":"{read_only:false; response_revision:6215; number_of_response:1; }","duration":"269.211653ms","start":"2026-06-16T00:29:26.334454Z","end":"2026-06-16T00:29:26.603666Z","steps":["trace[1638874547] 'process raft request' (duration: 268.99832ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:26.607868Z","caller":"traceutil/trace.go:171","msg":"trace[534114154] linearizableReadLoop","detail":"{readStateIndex:6447; appliedIndex:6444; }","duration":"185.348928ms","start":"2026-06-16T00:29:26.422502Z","end":"2026-06-16T00:29:26.607851Z","steps":["trace[534114154] 'read index received' (duration: 181.046895ms)","trace[534114154] 'applied index is now lower than readState.Index' (duration: 4.300913ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:29:26.60797Z","caller":"traceutil/trace.go:171","msg":"trace[1890566031] transaction","detail":"{read_only:false; response_revision:6217; number_of_response:1; }","duration":"250.414918ms","start":"2026-06-16T00:29:26.357541Z","end":"2026-06-16T00:29:26.607956Z","steps":["trace[1890566031] 'process raft request' (duration: 250.269986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:29:26.608051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.507111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:29:26.608096Z","caller":"traceutil/trace.go:171","msg":"trace[461214209] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:6217; }","duration":"185.616492ms","start":"2026-06-16T00:29:26.422469Z","end":"2026-06-16T00:29:26.608086Z","steps":["trace[461214209] 'agreement among raft nodes before linearized reading' (duration: 185.45516ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:26.607913Z","caller":"traceutil/trace.go:171","msg":"trace[974006949] transaction","detail":"{read_only:false; response_revision:6216; number_of_response:1; }","duration":"253.621245ms","start":"2026-06-16T00:29:26.354253Z","end":"2026-06-16T00:29:26.607874Z","steps":["trace[974006949] 'process raft request' (duration: 253.464243ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:28.810589Z","caller":"traceutil/trace.go:171","msg":"trace[840203721] linearizableReadLoop","detail":"{readStateIndex:6462; appliedIndex:6461; }","duration":"122.849243ms","start":"2026-06-16T00:29:28.687716Z","end":"2026-06-16T00:29:28.810565Z","steps":["trace[840203721] 'read index received' (duration: 122.6332ms)","trace[840203721] 'applied index is now lower than readState.Index' (duration: 215.023µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:29:28.810799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.063847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T00:29:28.81084Z","caller":"traceutil/trace.go:171","msg":"trace[944047642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6232; }","duration":"123.146227ms","start":"2026-06-16T00:29:28.687681Z","end":"2026-06-16T00:29:28.810827Z","steps":["trace[944047642] 'agreement among raft nodes before linearized reading' (duration: 122.977005ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:28.811183Z","caller":"traceutil/trace.go:171","msg":"trace[920070920] transaction","detail":"{read_only:false; response_revision:6232; number_of_response:1; }","duration":"155.464899ms","start":"2026-06-16T00:29:28.655706Z","end":"2026-06-16T00:29:28.811171Z","steps":["trace[920070920] 'process raft request' (duration: 154.715969ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:07.684714Z","caller":"traceutil/trace.go:171","msg":"trace[1958551428] linearizableReadLoop","detail":"{readStateIndex:6829; appliedIndex:6828; }","duration":"210.737079ms","start":"2026-06-16T00:30:07.473947Z","end":"2026-06-16T00:30:07.684684Z","steps":["trace[1958551428] 'read index received' (duration: 147.729086ms)","trace[1958551428] 'applied index is now lower than readState.Index' (duration: 63.005932ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:30:07.684886Z","caller":"traceutil/trace.go:171","msg":"trace[1910139396] transaction","detail":"{read_only:false; response_revision:6587; number_of_response:1; }","duration":"229.852761ms","start":"2026-06-16T00:30:07.455016Z","end":"2026-06-16T00:30:07.684868Z","steps":["trace[1910139396] 'process raft request' (duration: 166.724887ms)","trace[1910139396] 'compare' (duration: 62.594156ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:30:07.685151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.186525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-16T00:30:07.685195Z","caller":"traceutil/trace.go:171","msg":"trace[884278630] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6587; }","duration":"211.268206ms","start":"2026-06-16T00:30:07.473912Z","end":"2026-06-16T00:30:07.68518Z","steps":["trace[884278630] 'agreement among raft nodes before linearized reading' (duration: 211.091014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:30:07.68521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.238033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T00:30:07.685307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.843159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:30:07.685338Z","caller":"traceutil/trace.go:171","msg":"trace[642558256] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:6587; }","duration":"101.910879ms","start":"2026-06-16T00:30:07.583417Z","end":"2026-06-16T00:30:07.685328Z","steps":["trace[642558256] 'agreement among raft nodes before linearized reading' (duration: 101.864439ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:07.685342Z","caller":"traceutil/trace.go:171","msg":"trace[1941116728] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:6587; }","duration":"125.405706ms","start":"2026-06-16T00:30:07.55989Z","end":"2026-06-16T00:30:07.685296Z","steps":["trace[1941116728] 'agreement among raft nodes before linearized reading' (duration: 125.227864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:30:07.68551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.937431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:30:07.68566Z","caller":"traceutil/trace.go:171","msg":"trace[1621828744] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:6587; }","duration":"102.114193ms","start":"2026-06-16T00:30:07.583524Z","end":"2026-06-16T00:30:07.685639Z","steps":["trace[1621828744] 'agreement among raft nodes before linearized reading' (duration: 101.636406ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:07.81813Z","caller":"traceutil/trace.go:171","msg":"trace[661527766] transaction","detail":"{read_only:false; response_revision:6588; number_of_response:1; }","duration":"127.744399ms","start":"2026-06-16T00:30:07.690354Z","end":"2026-06-16T00:30:07.818099Z","steps":["trace[661527766] 'process raft request' (duration: 127.589317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:30:07.818782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.326649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-16T00:30:07.818982Z","caller":"traceutil/trace.go:171","msg":"trace[949162091] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2319c7c4-ec7c-4004-b69a-0e56d03886cf; range_end:; response_count:1; response_revision:6588; }","duration":"126.558242ms","start":"2026-06-16T00:30:07.692401Z","end":"2026-06-16T00:30:07.818959Z","steps":["trace[949162091] 'agreement among raft nodes before linearized reading' (duration: 126.182896ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:07.818533Z","caller":"traceutil/trace.go:171","msg":"trace[925040232] linearizableReadLoop","detail":"{readStateIndex:6830; appliedIndex:6830; }","duration":"126.086105ms","start":"2026-06-16T00:30:07.692425Z","end":"2026-06-16T00:30:07.818511Z","steps":["trace[925040232] 'read index received' (duration: 126.056335ms)","trace[925040232] 'applied index is now lower than readState.Index' (duration: 27.87µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:30:41.131138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.621394ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:30:41.13147Z","caller":"traceutil/trace.go:171","msg":"trace[1943816220] transaction","detail":"{read_only:false; response_revision:6816; number_of_response:1; }","duration":"104.787241ms","start":"2026-06-16T00:30:41.026665Z","end":"2026-06-16T00:30:41.131452Z","steps":["trace[1943816220] 'process raft request' (duration: 104.71732ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:41.131531Z","caller":"traceutil/trace.go:171","msg":"trace[1379017029] transaction","detail":"{read_only:false; response_revision:6815; number_of_response:1; }","duration":"208.820833ms","start":"2026-06-16T00:30:40.922679Z","end":"2026-06-16T00:30:41.131499Z","steps":["trace[1379017029] 'process raft request' (duration: 68.751182ms)","trace[1379017029] 'compare' (duration: 139.30751ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:31:19.415741Z","caller":"traceutil/trace.go:171","msg":"trace[589036827] transaction","detail":"{read_only:false; response_revision:7027; number_of_response:1; }","duration":"131.837455ms","start":"2026-06-16T00:31:19.283871Z","end":"2026-06-16T00:31:19.415709Z","steps":["trace[589036827] 'process raft request' (duration: 131.297607ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:31:57.742353Z","caller":"traceutil/trace.go:171","msg":"trace[2091143691] transaction","detail":"{read_only:false; response_revision:7221; number_of_response:1; }","duration":"185.875598ms","start":"2026-06-16T00:31:57.556439Z","end":"2026-06-16T00:31:57.742314Z","steps":["trace[2091143691] 'process raft request' (duration: 185.613219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:31:57.742522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.192788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T00:31:57.742608Z","caller":"traceutil/trace.go:171","msg":"trace[309633125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7221; }","duration":"132.334944ms","start":"2026-06-16T00:31:57.610256Z","end":"2026-06-16T00:31:57.742591Z","steps":["trace[309633125] 'agreement among raft nodes before linearized reading' (duration: 132.151648ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:31:57.742615Z","caller":"traceutil/trace.go:171","msg":"trace[705281819] linearizableReadLoop","detail":"{readStateIndex:7487; appliedIndex:7486; }","duration":"131.950191ms","start":"2026-06-16T00:31:57.610297Z","end":"2026-06-16T00:31:57.742248Z","steps":["trace[705281819] 'read index received' (duration: 131.61467ms)","trace[705281819] 'applied index is now lower than readState.Index' (duration: 334.161µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:32:26.936254Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5504} {"level":"info","ts":"2026-06-16T00:32:27.032649Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5504,"took":"94.88135ms","hash":578157479,"current-db-size-bytes":53264384,"current-db-size":"53 MB","current-db-size-in-use-bytes":18374656,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-16T00:32:27.032724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":578157479,"revision":5504,"compact-revision":2860}