{"level":"warn","ts":"2026-04-27T16:03:41.902294Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T16:03:41.902396Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.191:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.191:2380","--initial-cluster=instance=https://199.19.213.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.191: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-04-27T16:03:41.90247Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T16:03:41.902483Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-04-27T16:03:41.902505Z","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-04-27T16:03:41.903192Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"]} {"level":"info","ts":"2026-04-27T16:03:41.903275Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.191: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-04-27T16:03:41.910865Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.336317ms"} {"level":"info","ts":"2026-04-27T16:03:41.923007Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e892d50a3a4fc0f4","cluster-id":"21eccdda20ff4e92"} {"level":"info","ts":"2026-04-27T16:03:41.923101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T16:03:41.923132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 0"} {"level":"info","ts":"2026-04-27T16:03:41.923152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e892d50a3a4fc0f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T16:03:41.923165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 1"} {"level":"info","ts":"2026-04-27T16:03:41.923217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"warn","ts":"2026-04-27T16:03:41.931053Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T16:03:41.933899Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T16:03:41.936121Z","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-04-27T16:03:41.93841Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e892d50a3a4fc0f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T16:03:41.938745Z","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-04-27T16:03:41.938915Z","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-04-27T16:03:41.938933Z","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-04-27T16:03:41.938777Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e892d50a3a4fc0f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T16:03:41.943623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"info","ts":"2026-04-27T16:03:41.945601Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","added-peer-id":"e892d50a3a4fc0f4","added-peer-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-04-27T16:03:41.947659Z","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-04-27T16:03:41.947819Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-04-27T16:03:41.947903Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e892d50a3a4fc0f4","initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T16:03:41.947909Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-04-27T16:03:41.947954Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T16:03:42.923379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T16:03:42.923466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T16:03:42.9235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgPreVoteResp from e892d50a3a4fc0f4 at term 1"} {"level":"info","ts":"2026-04-27T16:03:42.923521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became candidate at term 2"} {"level":"info","ts":"2026-04-27T16:03:42.923532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgVoteResp from e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-04-27T16:03:42.923547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became leader at term 2"} {"level":"info","ts":"2026-04-27T16:03:42.92356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e892d50a3a4fc0f4 elected leader e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-04-27T16:03:43.005583Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:03:43.00643Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e892d50a3a4fc0f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.191:2379]}","request-path":"/0/members/e892d50a3a4fc0f4/attributes","cluster-id":"21eccdda20ff4e92","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T16:03:43.006428Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T16:03:43.006497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T16:03:43.00691Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T16:03:43.006945Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T16:03:43.007346Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:03:43.007561Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:03:43.007604Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:03:43.010448Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.191:2379"} {"level":"info","ts":"2026-04-27T16:03:43.010524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T16:03:50.898933Z","caller":"traceutil/trace.go:171","msg":"trace[1613989633] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"353.808481ms","start":"2026-04-27T16:03:50.545091Z","end":"2026-04-27T16:03:50.898899Z","steps":["trace[1613989633] 'process raft request' (duration: 339.798194ms)","trace[1613989633] 'compare' (duration: 13.889601ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:03:50.899506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:50.545036Z","time spent":"354.000359ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:51.044917Z","caller":"traceutil/trace.go:171","msg":"trace[1299289467] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:291; }","duration":"303.224547ms","start":"2026-04-27T16:03:50.741658Z","end":"2026-04-27T16:03:51.044883Z","steps":["trace[1299289467] 'read index received' (duration: 143.252381ms)","trace[1299289467] 'applied index is now lower than readState.Index' (duration: 159.971056ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:51.045044Z","caller":"traceutil/trace.go:171","msg":"trace[1283700529] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"459.18419ms","start":"2026-04-27T16:03:50.585814Z","end":"2026-04-27T16:03:51.044998Z","steps":["trace[1283700529] 'process raft request' (duration: 451.316485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:51.045224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:50.585797Z","time spent":"459.345167ms","remote":"127.0.0.1:55224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:03:51.045501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.793644ms","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-04-27T16:03:51.045597Z","caller":"traceutil/trace.go:171","msg":"trace[231628244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:282; }","duration":"303.962802ms","start":"2026-04-27T16:03:50.741616Z","end":"2026-04-27T16:03:51.045579Z","steps":["trace[231628244] 'agreement among raft nodes before linearized reading' (duration: 303.461928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:51.045512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.753235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T16:03:51.045724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:50.741597Z","time spent":"304.11322ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T16:03:51.045725Z","caller":"traceutil/trace.go:171","msg":"trace[346343329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:282; }","duration":"241.040449ms","start":"2026-04-27T16:03:50.804667Z","end":"2026-04-27T16:03:51.045707Z","steps":["trace[346343329] 'agreement among raft nodes before linearized reading' (duration: 240.567906ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:13.330567Z","caller":"traceutil/trace.go:171","msg":"trace[495410803] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"174.30149ms","start":"2026-04-27T16:04:13.156216Z","end":"2026-04-27T16:04:13.330517Z","steps":["trace[495410803] 'read index received' (duration: 173.978805ms)","trace[495410803] 'applied index is now lower than readState.Index' (duration: 321.635µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:04:13.331109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.20757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:04:13.331183Z","caller":"traceutil/trace.go:171","msg":"trace[42561887] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:466; }","duration":"169.334935ms","start":"2026-04-27T16:04:13.161832Z","end":"2026-04-27T16:04:13.331167Z","steps":["trace[42561887] 'agreement among raft nodes before linearized reading' (duration: 169.194698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:13.33123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.971503ms","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-04-27T16:04:13.331326Z","caller":"traceutil/trace.go:171","msg":"trace[606853980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"175.124659ms","start":"2026-04-27T16:04:13.156175Z","end":"2026-04-27T16:04:13.331299Z","steps":["trace[606853980] 'agreement among raft nodes before linearized reading' (duration: 174.909069ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:13.331598Z","caller":"traceutil/trace.go:171","msg":"trace[1778201879] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"176.566669ms","start":"2026-04-27T16:04:13.154995Z","end":"2026-04-27T16:04:13.331561Z","steps":["trace[1778201879] 'process raft request' (duration: 175.344711ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:14.01784Z","caller":"traceutil/trace.go:171","msg":"trace[1418198652] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"417.032704ms","start":"2026-04-27T16:04:13.600781Z","end":"2026-04-27T16:04:14.017814Z","steps":["trace[1418198652] 'process raft request' (duration: 390.388263ms)","trace[1418198652] 'compare' (duration: 26.225442ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:04:14.017973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.600771Z","time spent":"417.127328ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:04:14.018001Z","caller":"traceutil/trace.go:171","msg":"trace[29114034] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:501; }","duration":"408.454778ms","start":"2026-04-27T16:04:13.609517Z","end":"2026-04-27T16:04:14.017972Z","steps":["trace[29114034] 'read index received' (duration: 724.595µs)","trace[29114034] 'applied index is now lower than readState.Index' (duration: 407.728923ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:04:14.01809Z","caller":"traceutil/trace.go:171","msg":"trace[75738937] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"413.132189ms","start":"2026-04-27T16:04:13.604906Z","end":"2026-04-27T16:04:14.018038Z","steps":["trace[75738937] 'process raft request' (duration: 412.910609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.018248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.71366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:04:14.018296Z","caller":"traceutil/trace.go:171","msg":"trace[879471008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"408.802304ms","start":"2026-04-27T16:04:13.609479Z","end":"2026-04-27T16:04:14.018282Z","steps":["trace[879471008] 'agreement among raft nodes before linearized reading' (duration: 408.642287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.018335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.609458Z","time spent":"408.870488ms","remote":"127.0.0.1:55052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T16:04:14.01831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.604898Z","time spent":"413.247805ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:04:14.018087Z","caller":"traceutil/trace.go:171","msg":"trace[1994376074] transaction","detail":"{read_only:false; number_of_response:1; response_revision:486; }","duration":"409.418623ms","start":"2026-04-27T16:04:13.608646Z","end":"2026-04-27T16:04:14.018064Z","steps":["trace[1994376074] 'process raft request' (duration: 409.273306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.019075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.608639Z","time spent":"410.39825ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:04:14.02558Z","caller":"traceutil/trace.go:171","msg":"trace[1953757851] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"401.619094ms","start":"2026-04-27T16:04:13.623921Z","end":"2026-04-27T16:04:14.02554Z","steps":["trace[1953757851] 'process raft request' (duration: 401.230766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.025726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.623895Z","time spent":"401.75757ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:04:14.025908Z","caller":"traceutil/trace.go:171","msg":"trace[1344976181] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"386.084268ms","start":"2026-04-27T16:04:13.639801Z","end":"2026-04-27T16:04:14.025885Z","steps":["trace[1344976181] 'process raft request' (duration: 385.723621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.026008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.639762Z","time spent":"386.201323ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:04:14.026412Z","caller":"traceutil/trace.go:171","msg":"trace[1556207021] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"383.287285ms","start":"2026-04-27T16:04:13.643113Z","end":"2026-04-27T16:04:14.0264Z","steps":["trace[1556207021] 'process raft request' (duration: 382.682157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.026491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.643101Z","time spent":"383.364858ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:04:14.026499Z","caller":"traceutil/trace.go:171","msg":"trace[128845701] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"400.457809ms","start":"2026-04-27T16:04:13.625147Z","end":"2026-04-27T16:04:14.025605Z","steps":["trace[128845701] 'process raft request' (duration: 400.241539ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:14.026585Z","caller":"traceutil/trace.go:171","msg":"trace[883884988] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"295.349117ms","start":"2026-04-27T16:04:13.731229Z","end":"2026-04-27T16:04:14.026578Z","steps":["trace[883884988] 'process raft request' (duration: 294.944348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:14.026785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:13.625135Z","time spent":"401.512829ms","remote":"127.0.0.1:55126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:04:20.047701Z","caller":"traceutil/trace.go:171","msg":"trace[45593112] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"141.935939ms","start":"2026-04-27T16:04:19.905682Z","end":"2026-04-27T16:04:20.047618Z","steps":["trace[45593112] 'process raft request' (duration: 139.597788ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:20.527696Z","caller":"traceutil/trace.go:171","msg":"trace[172745946] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"456.558462ms","start":"2026-04-27T16:04:20.071108Z","end":"2026-04-27T16:04:20.527666Z","steps":["trace[172745946] 'process raft request' (duration: 456.368823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:20.528073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:20.071075Z","time spent":"456.711759ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:04:20.769068Z","caller":"traceutil/trace.go:171","msg":"trace[1219123803] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"665.651579ms","start":"2026-04-27T16:04:20.103393Z","end":"2026-04-27T16:04:20.769044Z","steps":["trace[1219123803] 'process raft request' (duration: 581.696915ms)","trace[1219123803] 'compare' (duration: 83.309574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:04:20.76919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:04:20.103374Z","time spent":"665.757674ms","remote":"127.0.0.1:55224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:04:22.326925Z","caller":"traceutil/trace.go:171","msg":"trace[697519479] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"150.849733ms","start":"2026-04-27T16:04:22.176052Z","end":"2026-04-27T16:04:22.326902Z","steps":["trace[697519479] 'process raft request' (duration: 150.693386ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:22.3504Z","caller":"traceutil/trace.go:171","msg":"trace[144138461] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"168.099285ms","start":"2026-04-27T16:04:22.182257Z","end":"2026-04-27T16:04:22.350356Z","steps":["trace[144138461] 'process raft request' (duration: 167.936997ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:22.350417Z","caller":"traceutil/trace.go:171","msg":"trace[1596996621] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"173.838434ms","start":"2026-04-27T16:04:22.176543Z","end":"2026-04-27T16:04:22.350382Z","steps":["trace[1596996621] 'process raft request' (duration: 166.015946ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:36.075205Z","caller":"traceutil/trace.go:171","msg":"trace[1121770625] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"237.208522ms","start":"2026-04-27T16:04:35.83798Z","end":"2026-04-27T16:04:36.075189Z","steps":["trace[1121770625] 'process raft request' (duration: 237.085487ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:11.459931Z","caller":"traceutil/trace.go:171","msg":"trace[18443728] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"146.94927ms","start":"2026-04-27T16:05:11.312957Z","end":"2026-04-27T16:05:11.459906Z","steps":["trace[18443728] 'process raft request' (duration: 146.790893ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:11.618117Z","caller":"traceutil/trace.go:171","msg":"trace[1539322905] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"228.775414ms","start":"2026-04-27T16:05:11.389301Z","end":"2026-04-27T16:05:11.618076Z","steps":["trace[1539322905] 'process raft request' (duration: 227.59863ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:55.903041Z","caller":"traceutil/trace.go:171","msg":"trace[1656075811] linearizableReadLoop","detail":"{readStateIndex:1855; appliedIndex:1854; }","duration":"222.951455ms","start":"2026-04-27T16:05:55.680062Z","end":"2026-04-27T16:05:55.903014Z","steps":["trace[1656075811] 'read index received' (duration: 222.705464ms)","trace[1656075811] 'applied index is now lower than readState.Index' (duration: 244.541µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:05:55.903175Z","caller":"traceutil/trace.go:171","msg":"trace[781333993] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"356.650489ms","start":"2026-04-27T16:05:55.546483Z","end":"2026-04-27T16:05:55.903134Z","steps":["trace[781333993] 'process raft request' (duration: 356.22849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:05:55.903374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.303472ms","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-04-27T16:05:55.903426Z","caller":"traceutil/trace.go:171","msg":"trace[893452242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1802; }","duration":"223.441088ms","start":"2026-04-27T16:05:55.679973Z","end":"2026-04-27T16:05:55.903414Z","steps":["trace[893452242] 'agreement among raft nodes before linearized reading' (duration: 223.214418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:05:55.903503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:05:55.546457Z","time spent":"356.815237ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:05:55.995627Z","caller":"traceutil/trace.go:171","msg":"trace[1560020288] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"220.920802ms","start":"2026-04-27T16:05:55.774649Z","end":"2026-04-27T16:05:55.99557Z","steps":["trace[1560020288] 'process raft request' (duration: 138.661773ms)","trace[1560020288] 'compare' (duration: 82.072921ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:05:55.996054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.022322ms","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-04-27T16:05:55.996164Z","caller":"traceutil/trace.go:171","msg":"trace[1083490749] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1804; }","duration":"138.2075ms","start":"2026-04-27T16:05:55.85793Z","end":"2026-04-27T16:05:55.996137Z","steps":["trace[1083490749] 'agreement among raft nodes before linearized reading' (duration: 137.724198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:05:55.9964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.515302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-27T16:05:55.996459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.841014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53749416-a08d-48c2-b615-a2ba42d0370e\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-27T16:05:55.996463Z","caller":"traceutil/trace.go:171","msg":"trace[1585749410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1804; }","duration":"109.652299ms","start":"2026-04-27T16:05:55.886789Z","end":"2026-04-27T16:05:55.996441Z","steps":["trace[1585749410] 'agreement among raft nodes before linearized reading' (duration: 108.833392ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:55.996517Z","caller":"traceutil/trace.go:171","msg":"trace[924161734] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53749416-a08d-48c2-b615-a2ba42d0370e; range_end:; response_count:1; response_revision:1804; }","duration":"253.920958ms","start":"2026-04-27T16:05:55.742581Z","end":"2026-04-27T16:05:55.996502Z","steps":["trace[924161734] 'agreement among raft nodes before linearized reading' (duration: 253.009296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:05:55.996403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.477531ms","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-04-27T16:05:55.99676Z","caller":"traceutil/trace.go:171","msg":"trace[908320537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1804; }","duration":"109.850969ms","start":"2026-04-27T16:05:55.886863Z","end":"2026-04-27T16:05:55.996714Z","steps":["trace[908320537] 'agreement among raft nodes before linearized reading' (duration: 108.80536ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:56.149875Z","caller":"traceutil/trace.go:171","msg":"trace[1140287819] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"148.592407ms","start":"2026-04-27T16:05:56.001246Z","end":"2026-04-27T16:05:56.149839Z","steps":["trace[1140287819] 'process raft request' (duration: 112.640415ms)","trace[1140287819] 'compare' (duration: 35.259541ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:05:56.1505Z","caller":"traceutil/trace.go:171","msg":"trace[1706046712] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"148.372858ms","start":"2026-04-27T16:05:56.002084Z","end":"2026-04-27T16:05:56.150457Z","steps":["trace[1706046712] 'process raft request' (duration: 147.700777ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:56.150819Z","caller":"traceutil/trace.go:171","msg":"trace[1684901091] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"148.326816ms","start":"2026-04-27T16:05:56.002468Z","end":"2026-04-27T16:05:56.150795Z","steps":["trace[1684901091] 'process raft request' (duration: 147.877744ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:00.820449Z","caller":"traceutil/trace.go:171","msg":"trace[48626115] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"125.650742ms","start":"2026-04-27T16:06:00.694742Z","end":"2026-04-27T16:06:00.820393Z","steps":["trace[48626115] 'process raft request' (duration: 67.953922ms)","trace[48626115] 'compare' (duration: 57.358355ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:06:00.820538Z","caller":"traceutil/trace.go:171","msg":"trace[2130877160] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1925; }","duration":"106.731454ms","start":"2026-04-27T16:06:00.713766Z","end":"2026-04-27T16:06:00.820497Z","steps":["trace[2130877160] 'read index received' (duration: 4.160192ms)","trace[2130877160] 'applied index is now lower than readState.Index' (duration: 102.569282ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:06:00.820646Z","caller":"traceutil/trace.go:171","msg":"trace[1535998906] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"125.15671ms","start":"2026-04-27T16:06:00.695449Z","end":"2026-04-27T16:06:00.820605Z","steps":["trace[1535998906] 'process raft request' (duration: 124.851226ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:00.820862Z","caller":"traceutil/trace.go:171","msg":"trace[675598651] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"123.740736ms","start":"2026-04-27T16:06:00.697047Z","end":"2026-04-27T16:06:00.820787Z","steps":["trace[675598651] 'process raft request' (duration: 123.337747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:06:00.821065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.28189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-04-27T16:06:00.821121Z","caller":"traceutil/trace.go:171","msg":"trace[1917994244] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1873; }","duration":"107.407206ms","start":"2026-04-27T16:06:00.713695Z","end":"2026-04-27T16:06:00.821102Z","steps":["trace[1917994244] 'agreement among raft nodes before linearized reading' (duration: 107.208156ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:03.336189Z","caller":"traceutil/trace.go:171","msg":"trace[816744090] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1952; }","duration":"139.798732ms","start":"2026-04-27T16:06:03.196358Z","end":"2026-04-27T16:06:03.336156Z","steps":["trace[816744090] 'read index received' (duration: 139.509559ms)","trace[816744090] 'applied index is now lower than readState.Index' (duration: 287.843µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:06:03.336435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.049784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-27T16:06:03.336487Z","caller":"traceutil/trace.go:171","msg":"trace[1548105059] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1896; }","duration":"140.1626ms","start":"2026-04-27T16:06:03.196308Z","end":"2026-04-27T16:06:03.336471Z","steps":["trace[1548105059] 'agreement among raft nodes before linearized reading' (duration: 139.96022ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:03.336436Z","caller":"traceutil/trace.go:171","msg":"trace[1436385631] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"155.516755ms","start":"2026-04-27T16:06:03.180891Z","end":"2026-04-27T16:06:03.336408Z","steps":["trace[1436385631] 'process raft request' (duration: 155.072864ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:27.103805Z","caller":"traceutil/trace.go:171","msg":"trace[1106766526] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2133; }","duration":"119.737017ms","start":"2026-04-27T16:06:26.984046Z","end":"2026-04-27T16:06:27.103783Z","steps":["trace[1106766526] 'read index received' (duration: 119.530477ms)","trace[1106766526] 'applied index is now lower than readState.Index' (duration: 205.66µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:06:27.104032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.975019ms","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-04-27T16:06:27.104068Z","caller":"traceutil/trace.go:171","msg":"trace[842385960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2067; }","duration":"120.065563ms","start":"2026-04-27T16:06:26.983992Z","end":"2026-04-27T16:06:27.104058Z","steps":["trace[842385960] 'agreement among raft nodes before linearized reading' (duration: 119.909506ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:27.104366Z","caller":"traceutil/trace.go:171","msg":"trace[1159947958] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"150.858967ms","start":"2026-04-27T16:06:26.953497Z","end":"2026-04-27T16:06:27.104356Z","steps":["trace[1159947958] 'process raft request' (duration: 150.147823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:06:27.438806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.389109ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:06:27.438947Z","caller":"traceutil/trace.go:171","msg":"trace[205192549] linearizableReadLoop","detail":"{readStateIndex:2135; appliedIndex:2134; }","duration":"316.65327ms","start":"2026-04-27T16:06:27.122275Z","end":"2026-04-27T16:06:27.438928Z","steps":["trace[205192549] 'read index received' (duration: 156.868213ms)","trace[205192549] 'applied index is now lower than readState.Index' (duration: 159.783647ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:06:27.439058Z","caller":"traceutil/trace.go:171","msg":"trace[1077401845] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"330.696925ms","start":"2026-04-27T16:06:27.108346Z","end":"2026-04-27T16:06:27.439043Z","steps":["trace[1077401845] 'process raft request' (duration: 170.778031ms)","trace[1077401845] 'compare' (duration: 159.058574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:06:27.439114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:06:27.108327Z","time spent":"330.759147ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:06:27.439364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.064119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-04-27T16:06:27.439707Z","caller":"traceutil/trace.go:171","msg":"trace[640633522] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2068; }","duration":"317.445286ms","start":"2026-04-27T16:06:27.122223Z","end":"2026-04-27T16:06:27.439669Z","steps":["trace[640633522] 'agreement among raft nodes before linearized reading' (duration: 316.973955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:06:27.439884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:06:27.122203Z","time spent":"317.655506ms","remote":"127.0.0.1:55168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-04-27T16:06:27.681383Z","caller":"traceutil/trace.go:171","msg":"trace[1828114024] linearizableReadLoop","detail":"{readStateIndex:2137; appliedIndex:2136; }","duration":"113.704471ms","start":"2026-04-27T16:06:27.567653Z","end":"2026-04-27T16:06:27.681358Z","steps":["trace[1828114024] 'read index received' (duration: 112.341628ms)","trace[1828114024] 'applied index is now lower than readState.Index' (duration: 1.361623ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:06:27.681503Z","caller":"traceutil/trace.go:171","msg":"trace[384323760] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"149.073456ms","start":"2026-04-27T16:06:27.5324Z","end":"2026-04-27T16:06:27.681473Z","steps":["trace[384323760] 'process raft request' (duration: 147.665871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:06:27.681765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.022545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"warn","ts":"2026-04-27T16:06:27.681825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.158562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-27T16:06:27.681843Z","caller":"traceutil/trace.go:171","msg":"trace[1188813020] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2070; }","duration":"102.13839ms","start":"2026-04-27T16:06:27.579682Z","end":"2026-04-27T16:06:27.68182Z","steps":["trace[1188813020] 'agreement among raft nodes before linearized reading' (duration: 101.940971ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:06:27.682678Z","caller":"traceutil/trace.go:171","msg":"trace[1958160840] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2070; }","duration":"114.275117ms","start":"2026-04-27T16:06:27.567584Z","end":"2026-04-27T16:06:27.681859Z","steps":["trace[1958160840] 'agreement among raft nodes before linearized reading' (duration: 113.91906ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:14.007184Z","caller":"traceutil/trace.go:171","msg":"trace[1651043912] transaction","detail":"{read_only:false; response_revision:2439; number_of_response:1; }","duration":"109.080007ms","start":"2026-04-27T16:07:13.898087Z","end":"2026-04-27T16:07:14.007167Z","steps":["trace[1651043912] 'process raft request' (duration: 108.975152ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:22.74229Z","caller":"traceutil/trace.go:171","msg":"trace[638487089] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"164.357153ms","start":"2026-04-27T16:07:22.577913Z","end":"2026-04-27T16:07:22.742271Z","steps":["trace[638487089] 'process raft request' (duration: 164.249568ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:22.757998Z","caller":"traceutil/trace.go:171","msg":"trace[1268007978] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"178.44848ms","start":"2026-04-27T16:07:22.579534Z","end":"2026-04-27T16:07:22.757982Z","steps":["trace[1268007978] 'process raft request' (duration: 178.286083ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:22.757992Z","caller":"traceutil/trace.go:171","msg":"trace[153591329] linearizableReadLoop","detail":"{readStateIndex:2645; appliedIndex:2642; }","duration":"149.608737ms","start":"2026-04-27T16:07:22.608351Z","end":"2026-04-27T16:07:22.75796Z","steps":["trace[153591329] 'read index received' (duration: 133.808702ms)","trace[153591329] 'applied index is now lower than readState.Index' (duration: 15.799095ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:07:22.758102Z","caller":"traceutil/trace.go:171","msg":"trace[68165027] transaction","detail":"{read_only:false; response_revision:2553; number_of_response:1; }","duration":"177.869464ms","start":"2026-04-27T16:07:22.580219Z","end":"2026-04-27T16:07:22.758088Z","steps":["trace[68165027] 'process raft request' (duration: 177.703507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:07:22.758382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.020576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:07:22.758425Z","caller":"traceutil/trace.go:171","msg":"trace[1840892337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2553; }","duration":"150.097339ms","start":"2026-04-27T16:07:22.608318Z","end":"2026-04-27T16:07:22.758415Z","steps":["trace[1840892337] 'agreement among raft nodes before linearized reading' (duration: 150.026406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:07:50.95563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.383725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:07:50.95574Z","caller":"traceutil/trace.go:171","msg":"trace[1253349392] linearizableReadLoop","detail":"{readStateIndex:2845; appliedIndex:2844; }","duration":"248.877445ms","start":"2026-04-27T16:07:50.706846Z","end":"2026-04-27T16:07:50.955724Z","steps":["trace[1253349392] 'read index received' (duration: 69.275005ms)","trace[1253349392] 'applied index is now lower than readState.Index' (duration: 179.6014ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:07:50.955847Z","caller":"traceutil/trace.go:171","msg":"trace[2001467372] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"301.118208ms","start":"2026-04-27T16:07:50.654642Z","end":"2026-04-27T16:07:50.95576Z","steps":["trace[2001467372] 'process raft request' (duration: 121.521158ms)","trace[2001467372] 'compare' (duration: 179.232043ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:07:50.956016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.683445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"} {"level":"info","ts":"2026-04-27T16:07:50.9561Z","caller":"traceutil/trace.go:171","msg":"trace[1001082076] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2741; }","duration":"302.784063ms","start":"2026-04-27T16:07:50.653298Z","end":"2026-04-27T16:07:50.956082Z","steps":["trace[1001082076] 'agreement among raft nodes before linearized reading' (duration: 302.500476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:07:50.956128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:07:50.654615Z","time spent":"301.396746ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:07:50.956146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:07:50.65323Z","time spent":"302.9049ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":590,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-04-27T16:07:51.022852Z","caller":"traceutil/trace.go:171","msg":"trace[15918988] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"311.954523ms","start":"2026-04-27T16:07:50.710874Z","end":"2026-04-27T16:07:51.022829Z","steps":["trace[15918988] 'process raft request' (duration: 311.767625ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:51.022959Z","caller":"traceutil/trace.go:171","msg":"trace[1509397939] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"315.051922ms","start":"2026-04-27T16:07:50.707867Z","end":"2026-04-27T16:07:51.022919Z","steps":["trace[1509397939] 'process raft request' (duration: 314.616491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:07:51.023012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.747894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T16:07:51.023086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:07:50.710855Z","time spent":"312.063091ms","remote":"127.0.0.1:55168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:07:51.023143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:07:50.707836Z","time spent":"315.213793ms","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":764,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:07:51.0231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.909285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T16:07:51.023218Z","caller":"traceutil/trace.go:171","msg":"trace[1833453727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2744; }","duration":"150.098153ms","start":"2026-04-27T16:07:50.8731Z","end":"2026-04-27T16:07:51.023198Z","steps":["trace[1833453727] 'agreement among raft nodes before linearized reading' (duration: 149.783959ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:51.023226Z","caller":"traceutil/trace.go:171","msg":"trace[278481423] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"251.634133ms","start":"2026-04-27T16:07:50.77158Z","end":"2026-04-27T16:07:51.023214Z","steps":["trace[278481423] 'process raft request' (duration: 251.105314ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:07:51.023231Z","caller":"traceutil/trace.go:171","msg":"trace[627417096] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2744; }","duration":"140.968949ms","start":"2026-04-27T16:07:50.882201Z","end":"2026-04-27T16:07:51.02317Z","steps":["trace[627417096] 'agreement among raft nodes before linearized reading' (duration: 140.644076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:07:51.023593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.48867ms","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-04-27T16:07:51.023687Z","caller":"traceutil/trace.go:171","msg":"trace[200782849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2744; }","duration":"157.627443ms","start":"2026-04-27T16:07:50.866045Z","end":"2026-04-27T16:07:51.023673Z","steps":["trace[200782849] 'agreement among raft nodes before linearized reading' (duration: 156.684313ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:14.9688Z","caller":"traceutil/trace.go:171","msg":"trace[276224122] transaction","detail":"{read_only:false; response_revision:4273; number_of_response:1; }","duration":"218.081619ms","start":"2026-04-27T16:10:14.750684Z","end":"2026-04-27T16:10:14.968765Z","steps":["trace[276224122] 'process raft request' (duration: 212.090865ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:14.968871Z","caller":"traceutil/trace.go:171","msg":"trace[1799589640] linearizableReadLoop","detail":"{readStateIndex:4459; appliedIndex:4456; }","duration":"185.855083ms","start":"2026-04-27T16:10:14.782993Z","end":"2026-04-27T16:10:14.968848Z","steps":["trace[1799589640] 'read index received' (duration: 179.748992ms)","trace[1799589640] 'applied index is now lower than readState.Index' (duration: 6.105031ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:10:14.969311Z","caller":"traceutil/trace.go:171","msg":"trace[1353693121] transaction","detail":"{read_only:false; response_revision:4274; number_of_response:1; }","duration":"213.348321ms","start":"2026-04-27T16:10:14.755948Z","end":"2026-04-27T16:10:14.969296Z","steps":["trace[1353693121] 'process raft request' (duration: 212.702533ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:14.969622Z","caller":"traceutil/trace.go:171","msg":"trace[492102523] transaction","detail":"{read_only:false; response_revision:4275; number_of_response:1; }","duration":"211.318549ms","start":"2026-04-27T16:10:14.75829Z","end":"2026-04-27T16:10:14.969608Z","steps":["trace[492102523] 'process raft request' (duration: 210.489066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:14.969916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.736543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:10:14.96998Z","caller":"traceutil/trace.go:171","msg":"trace[1458361514] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:4275; }","duration":"213.83393ms","start":"2026-04-27T16:10:14.75613Z","end":"2026-04-27T16:10:14.969964Z","steps":["trace[1458361514] 'agreement among raft nodes before linearized reading' (duration: 213.720193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:14.97027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.627178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18aa4295f2cb9d26\" ","response":"range_response_count:1 size:1203"} {"level":"info","ts":"2026-04-27T16:10:14.970329Z","caller":"traceutil/trace.go:171","msg":"trace[1612108298] range","detail":"{range_begin:/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18aa4295f2cb9d26; range_end:; response_count:1; response_revision:4275; }","duration":"219.723136ms","start":"2026-04-27T16:10:14.75059Z","end":"2026-04-27T16:10:14.970313Z","steps":["trace[1612108298] 'agreement among raft nodes before linearized reading' (duration: 219.54402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:14.983708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.320401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-27T16:10:14.983933Z","caller":"traceutil/trace.go:171","msg":"trace[897052985] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4276; }","duration":"196.594645ms","start":"2026-04-27T16:10:14.787315Z","end":"2026-04-27T16:10:14.98391Z","steps":["trace[897052985] 'agreement among raft nodes before linearized reading' (duration: 196.219702ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:14.983839Z","caller":"traceutil/trace.go:171","msg":"trace[1576823113] transaction","detail":"{read_only:false; response_revision:4276; number_of_response:1; }","duration":"194.212691ms","start":"2026-04-27T16:10:14.789593Z","end":"2026-04-27T16:10:14.983806Z","steps":["trace[1576823113] 'process raft request' (duration: 193.790929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:14.984388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.316708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:2109536"} {"level":"info","ts":"2026-04-27T16:10:14.98446Z","caller":"traceutil/trace.go:171","msg":"trace[321218267] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4276; }","duration":"124.423165ms","start":"2026-04-27T16:10:14.860024Z","end":"2026-04-27T16:10:14.984447Z","steps":["trace[321218267] 'agreement among raft nodes before linearized reading' (duration: 123.474004ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:25.874123Z","caller":"traceutil/trace.go:171","msg":"trace[612836638] transaction","detail":"{read_only:false; response_revision:4536; number_of_response:1; }","duration":"105.777064ms","start":"2026-04-27T16:10:25.768309Z","end":"2026-04-27T16:10:25.874087Z","steps":["trace[612836638] 'process raft request' (duration: 67.340662ms)","trace[612836638] 'compare' (duration: 38.262345ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:10:26.313806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.821346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:10:26.314092Z","caller":"traceutil/trace.go:171","msg":"trace[4324275] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"387.136938ms","start":"2026-04-27T16:10:25.926937Z","end":"2026-04-27T16:10:26.314074Z","steps":["trace[4324275] 'process raft request' (duration: 387.02374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:26.314189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:25.926915Z","time spent":"387.235487ms","remote":"127.0.0.1:55296","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-04-27T16:10:26.314454Z","caller":"traceutil/trace.go:171","msg":"trace[1686549540] linearizableReadLoop","detail":"{readStateIndex:4730; appliedIndex:4729; }","duration":"440.41071ms","start":"2026-04-27T16:10:25.874006Z","end":"2026-04-27T16:10:26.314416Z","steps":["trace[1686549540] 'read index received' (duration: 170.921854ms)","trace[1686549540] 'applied index is now lower than readState.Index' (duration: 269.486256ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:10:26.314539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.268875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:10:26.314559Z","caller":"traceutil/trace.go:171","msg":"trace[856704945] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"496.657434ms","start":"2026-04-27T16:10:25.817867Z","end":"2026-04-27T16:10:26.314524Z","steps":["trace[856704945] 'process raft request' (duration: 227.04521ms)","trace[856704945] 'compare' (duration: 268.545011ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:10:26.314605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.432604ms","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-04-27T16:10:26.314612Z","caller":"traceutil/trace.go:171","msg":"trace[1055876495] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4538; }","duration":"470.364274ms","start":"2026-04-27T16:10:25.84423Z","end":"2026-04-27T16:10:26.314594Z","steps":["trace[1055876495] 'agreement among raft nodes before linearized reading' (duration: 470.205516ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.314658Z","caller":"traceutil/trace.go:171","msg":"trace[782565730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4538; }","duration":"493.518513ms","start":"2026-04-27T16:10:25.821125Z","end":"2026-04-27T16:10:26.314644Z","steps":["trace[782565730] 'agreement among raft nodes before linearized reading' (duration: 493.358106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:26.314669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.293096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4febc64e-4f0f-470e-a2a4-9dee885aa7d2\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-04-27T16:10:26.314664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:25.844158Z","time spent":"470.496021ms","remote":"127.0.0.1:32872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:10:26.314686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.690156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4febc64e-4f0f-470e-a2a4-9dee885aa7d2\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-04-27T16:10:26.314694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:25.821108Z","time spent":"493.578492ms","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-27T16:10:26.3147Z","caller":"traceutil/trace.go:171","msg":"trace[808180177] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4febc64e-4f0f-470e-a2a4-9dee885aa7d2; range_end:; response_count:1; response_revision:4538; }","duration":"502.360215ms","start":"2026-04-27T16:10:25.81233Z","end":"2026-04-27T16:10:26.31469Z","steps":["trace[808180177] 'agreement among raft nodes before linearized reading' (duration: 502.218698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:26.314733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:25.812319Z","time spent":"502.408785ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4febc64e-4f0f-470e-a2a4-9dee885aa7d2\" "} {"level":"info","ts":"2026-04-27T16:10:26.314727Z","caller":"traceutil/trace.go:171","msg":"trace[1507574191] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4febc64e-4f0f-470e-a2a4-9dee885aa7d2; range_end:; response_count:1; response_revision:4538; }","duration":"413.768455ms","start":"2026-04-27T16:10:25.900945Z","end":"2026-04-27T16:10:26.314713Z","steps":["trace[1507574191] 'agreement among raft nodes before linearized reading' (duration: 413.634577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:26.314731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:25.817852Z","time spent":"496.795602ms","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:10:26.314761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:25.900923Z","time spent":"413.832053ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4febc64e-4f0f-470e-a2a4-9dee885aa7d2\" "} {"level":"warn","ts":"2026-04-27T16:10:26.314904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.777617ms","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-04-27T16:10:26.314855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.118249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T16:10:26.314934Z","caller":"traceutil/trace.go:171","msg":"trace[851070980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4538; }","duration":"268.859586ms","start":"2026-04-27T16:10:26.046066Z","end":"2026-04-27T16:10:26.314926Z","steps":["trace[851070980] 'agreement among raft nodes before linearized reading' (duration: 268.764747ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.314982Z","caller":"traceutil/trace.go:171","msg":"trace[896055305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4538; }","duration":"235.310586ms","start":"2026-04-27T16:10:26.079636Z","end":"2026-04-27T16:10:26.314947Z","steps":["trace[896055305] 'agreement among raft nodes before linearized reading' (duration: 235.08081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:26.315005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.069916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.191\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-27T16:10:26.315043Z","caller":"traceutil/trace.go:171","msg":"trace[577089311] range","detail":"{range_begin:/registry/masterleases/199.19.213.191; range_end:; response_count:1; response_revision:4538; }","duration":"146.147724ms","start":"2026-04-27T16:10:26.168884Z","end":"2026-04-27T16:10:26.315032Z","steps":["trace[577089311] 'agreement among raft nodes before linearized reading' (duration: 146.010766ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.493935Z","caller":"traceutil/trace.go:171","msg":"trace[916664230] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"174.920605ms","start":"2026-04-27T16:10:26.318979Z","end":"2026-04-27T16:10:26.4939Z","steps":["trace[916664230] 'process raft request' (duration: 174.509152ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.493967Z","caller":"traceutil/trace.go:171","msg":"trace[243722194] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"174.147748ms","start":"2026-04-27T16:10:26.319777Z","end":"2026-04-27T16:10:26.493924Z","steps":["trace[243722194] 'process raft request' (duration: 173.930851ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.494148Z","caller":"traceutil/trace.go:171","msg":"trace[1494964586] transaction","detail":"{read_only:false; response_revision:4542; number_of_response:1; }","duration":"172.498602ms","start":"2026-04-27T16:10:26.321619Z","end":"2026-04-27T16:10:26.494117Z","steps":["trace[1494964586] 'process raft request' (duration: 172.245756ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.494192Z","caller":"traceutil/trace.go:171","msg":"trace[554097916] transaction","detail":"{read_only:false; response_revision:4543; number_of_response:1; }","duration":"172.101519ms","start":"2026-04-27T16:10:26.322046Z","end":"2026-04-27T16:10:26.494148Z","steps":["trace[554097916] 'process raft request' (duration: 171.888132ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.49423Z","caller":"traceutil/trace.go:171","msg":"trace[1813331294] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"173.075315ms","start":"2026-04-27T16:10:26.321128Z","end":"2026-04-27T16:10:26.494204Z","steps":["trace[1813331294] 'process raft request' (duration: 172.681361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:26.494576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.478771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-27T16:10:26.49448Z","caller":"traceutil/trace.go:171","msg":"trace[1082671788] linearizableReadLoop","detail":"{readStateIndex:4737; appliedIndex:4731; }","duration":"157.393063ms","start":"2026-04-27T16:10:26.337069Z","end":"2026-04-27T16:10:26.494462Z","steps":["trace[1082671788] 'read index received' (duration: 65.132778ms)","trace[1082671788] 'applied index is now lower than readState.Index' (duration: 91.89451ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:10:26.494646Z","caller":"traceutil/trace.go:171","msg":"trace[1027029855] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4543; }","duration":"157.60398ms","start":"2026-04-27T16:10:26.337027Z","end":"2026-04-27T16:10:26.494631Z","steps":["trace[1027029855] 'agreement among raft nodes before linearized reading' (duration: 157.365364ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.517859Z","caller":"traceutil/trace.go:171","msg":"trace[1459611072] transaction","detail":"{read_only:false; response_revision:4544; number_of_response:1; }","duration":"114.196161ms","start":"2026-04-27T16:10:26.403626Z","end":"2026-04-27T16:10:26.517822Z","steps":["trace[1459611072] 'process raft request' (duration: 113.979375ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:26.646175Z","caller":"traceutil/trace.go:171","msg":"trace[1710741865] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"116.259238ms","start":"2026-04-27T16:10:26.529876Z","end":"2026-04-27T16:10:26.646135Z","steps":["trace[1710741865] 'process raft request' (duration: 83.104764ms)","trace[1710741865] 'compare' (duration: 32.604483ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:10:26.907282Z","caller":"traceutil/trace.go:171","msg":"trace[1201964021] transaction","detail":"{read_only:false; response_revision:4550; number_of_response:1; }","duration":"167.240864ms","start":"2026-04-27T16:10:26.74Z","end":"2026-04-27T16:10:26.907241Z","steps":["trace[1201964021] 'process raft request' (duration: 97.645824ms)","trace[1201964021] 'compare' (duration: 69.348574ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:10:27.274379Z","caller":"traceutil/trace.go:171","msg":"trace[520089494] linearizableReadLoop","detail":"{readStateIndex:4755; appliedIndex:4753; }","duration":"208.07433ms","start":"2026-04-27T16:10:27.066249Z","end":"2026-04-27T16:10:27.274324Z","steps":["trace[520089494] 'read index received' (duration: 21.704157ms)","trace[520089494] 'applied index is now lower than readState.Index' (duration: 186.369253ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:10:27.274418Z","caller":"traceutil/trace.go:171","msg":"trace[756139120] transaction","detail":"{read_only:false; response_revision:4561; number_of_response:1; }","duration":"208.817899ms","start":"2026-04-27T16:10:27.065583Z","end":"2026-04-27T16:10:27.274401Z","steps":["trace[756139120] 'process raft request' (duration: 207.241812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:27.274667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.399806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-04-27T16:10:27.274709Z","caller":"traceutil/trace.go:171","msg":"trace[245048544] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4562; }","duration":"208.495434ms","start":"2026-04-27T16:10:27.066203Z","end":"2026-04-27T16:10:27.274698Z","steps":["trace[245048544] 'agreement among raft nodes before linearized reading' (duration: 208.238268ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:27.274571Z","caller":"traceutil/trace.go:171","msg":"trace[723207367] transaction","detail":"{read_only:false; response_revision:4562; number_of_response:1; }","duration":"204.611281ms","start":"2026-04-27T16:10:27.069939Z","end":"2026-04-27T16:10:27.27455Z","steps":["trace[723207367] 'process raft request' (duration: 204.302846ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:29.021273Z","caller":"traceutil/trace.go:171","msg":"trace[31353468] transaction","detail":"{read_only:false; response_revision:4584; number_of_response:1; }","duration":"105.349629ms","start":"2026-04-27T16:10:28.915885Z","end":"2026-04-27T16:10:29.021234Z","steps":["trace[31353468] 'process raft request' (duration: 105.098793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:10:38.706656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.507182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:10:38.706764Z","caller":"traceutil/trace.go:171","msg":"trace[385416217] linearizableReadLoop","detail":"{readStateIndex:4936; appliedIndex:4935; }","duration":"161.01399ms","start":"2026-04-27T16:10:38.545732Z","end":"2026-04-27T16:10:38.706746Z","steps":["trace[385416217] 'read index received' (duration: 40.799µs)","trace[385416217] 'applied index is now lower than readState.Index' (duration: 160.970461ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:10:38.706864Z","caller":"traceutil/trace.go:171","msg":"trace[1304461237] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"588.974648ms","start":"2026-04-27T16:10:38.117879Z","end":"2026-04-27T16:10:38.706853Z","steps":["trace[1304461237] 'process raft request' (duration: 104.186319ms)","trace[1304461237] 'compare' (duration: 484.301734ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:10:38.706927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:10:38.117861Z","time spent":"589.039057ms","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":794,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:10:38.707655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.921649ms","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-04-27T16:10:38.70774Z","caller":"traceutil/trace.go:171","msg":"trace[1573944659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4734; }","duration":"162.011669ms","start":"2026-04-27T16:10:38.545682Z","end":"2026-04-27T16:10:38.707693Z","steps":["trace[1573944659] 'agreement among raft nodes before linearized reading' (duration: 161.410326ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:38.950413Z","caller":"traceutil/trace.go:171","msg":"trace[2084305233] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"166.920682ms","start":"2026-04-27T16:10:38.783462Z","end":"2026-04-27T16:10:38.950383Z","steps":["trace[2084305233] 'process raft request' (duration: 166.629295ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:10:39.148968Z","caller":"traceutil/trace.go:171","msg":"trace[1927334785] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"183.22233ms","start":"2026-04-27T16:10:38.965727Z","end":"2026-04-27T16:10:39.14895Z","steps":["trace[1927334785] 'process raft request' (duration: 182.898074ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:13:43.042628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3180} {"level":"info","ts":"2026-04-27T16:13:43.140163Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3180,"took":"96.248667ms","hash":2516274700,"current-db-size-bytes":59371520,"current-db-size":"59 MB","current-db-size-in-use-bytes":31395840,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-27T16:13:43.140222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2516274700,"revision":3180,"compact-revision":-1}