{"level":"warn","ts":"2026-05-05T06:43:52.483628Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T06:43:52.48371Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-05-05T06:43:52.483768Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T06:43:52.483779Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-05T06:43:52.483794Z","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-05-05T06:43:52.484434Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-05-05T06:43:52.4845Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-05-05T06:43:52.488131Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.447172ms"} {"level":"info","ts":"2026-05-05T06:43:52.495242Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-05-05T06:43:52.495317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T06:43:52.495347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-05-05T06:43:52.495364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T06:43:52.495377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-05-05T06:43:52.495416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-05-05T06:43:52.502304Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T06:43:52.504576Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T06:43:52.506054Z","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-05-05T06:43:52.50854Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T06:43:52.508683Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T06:43:52.509Z","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-05-05T06:43:52.509181Z","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-05-05T06:43:52.509194Z","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-05-05T06:43:52.511184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-05-05T06:43:52.511313Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-05T06:43:52.513145Z","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-05-05T06:43:52.513233Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-05T06:43:52.513293Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-05T06:43:52.513353Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T06:43:52.513397Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T06:43:52.996084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T06:43:52.996152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T06:43:52.996212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-05-05T06:43:52.99624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-05-05T06:43:52.996261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-05T06:43:52.996294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-05-05T06:43:52.996309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-05T06:43:52.997294Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:43:52.997562Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:43:52.997581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:43:52.997686Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T06:43:52.998124Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:43:52.998288Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:43:52.998364Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:43:52.998517Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T06:43:52.998557Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T06:43:53.000997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-05-05T06:43:53.001381Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T06:44:09.496375Z","caller":"traceutil/trace.go:171","msg":"trace[1812051797] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"206.557214ms","start":"2026-05-05T06:44:09.289787Z","end":"2026-05-05T06:44:09.496344Z","steps":["trace[1812051797] 'read index received' (duration: 206.301798ms)","trace[1812051797] 'applied index is now lower than readState.Index' (duration: 254.156µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:44:09.496466Z","caller":"traceutil/trace.go:171","msg":"trace[859660539] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"224.131896ms","start":"2026-05-05T06:44:09.272298Z","end":"2026-05-05T06:44:09.49643Z","steps":["trace[859660539] 'process raft request' (duration: 223.839489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:09.496587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.776179ms","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-05-05T06:44:09.496655Z","caller":"traceutil/trace.go:171","msg":"trace[1884681021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:403; }","duration":"206.916303ms","start":"2026-05-05T06:44:09.28973Z","end":"2026-05-05T06:44:09.496646Z","steps":["trace[1884681021] 'agreement among raft nodes before linearized reading' (duration: 206.78563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:09.496804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.057222ms","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-05-05T06:44:09.496879Z","caller":"traceutil/trace.go:171","msg":"trace[2056828062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:403; }","duration":"204.177915ms","start":"2026-05-05T06:44:09.292681Z","end":"2026-05-05T06:44:09.496859Z","steps":["trace[2056828062] 'agreement among raft nodes before linearized reading' (duration: 204.053862ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:09.674143Z","caller":"traceutil/trace.go:171","msg":"trace[1199316619] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:418; }","duration":"169.493214ms","start":"2026-05-05T06:44:09.504596Z","end":"2026-05-05T06:44:09.674089Z","steps":["trace[1199316619] 'read index received' (duration: 83.707887ms)","trace[1199316619] 'applied index is now lower than readState.Index' (duration: 85.784107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:44:09.674309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.680139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:44:09.674348Z","caller":"traceutil/trace.go:171","msg":"trace[786763751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"169.76029ms","start":"2026-05-05T06:44:09.504577Z","end":"2026-05-05T06:44:09.674338Z","steps":["trace[786763751] 'agreement among raft nodes before linearized reading' (duration: 169.656268ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:09.674379Z","caller":"traceutil/trace.go:171","msg":"trace[1874422679] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"169.941414ms","start":"2026-05-05T06:44:09.504411Z","end":"2026-05-05T06:44:09.674352Z","steps":["trace[1874422679] 'process raft request' (duration: 83.872561ms)","trace[1874422679] 'compare' (duration: 85.356006ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:44:09.911064Z","caller":"traceutil/trace.go:171","msg":"trace[1289216160] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"404.046106ms","start":"2026-05-05T06:44:09.506991Z","end":"2026-05-05T06:44:09.911037Z","steps":["trace[1289216160] 'process raft request' (duration: 389.694024ms)","trace[1289216160] 'compare' (duration: 13.995843ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:44:09.911195Z","caller":"traceutil/trace.go:171","msg":"trace[1729164073] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"401.743029ms","start":"2026-05-05T06:44:09.509428Z","end":"2026-05-05T06:44:09.911171Z","steps":["trace[1729164073] 'process raft request' (duration: 401.515983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:09.911697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:44:09.506967Z","time spent":"404.168698ms","remote":"127.0.0.1:52564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:44:09.912149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:44:09.509415Z","time spent":"401.885033ms","remote":"127.0.0.1:52502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:44:21.253665Z","caller":"traceutil/trace.go:171","msg":"trace[474277885] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"146.539777ms","start":"2026-05-05T06:44:21.107095Z","end":"2026-05-05T06:44:21.253635Z","steps":["trace[474277885] 'read index received' (duration: 142.304954ms)","trace[474277885] 'applied index is now lower than readState.Index' (duration: 4.233063ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:44:21.253823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.704522ms","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-05-05T06:44:21.253867Z","caller":"traceutil/trace.go:171","msg":"trace[1859556650] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:465; }","duration":"146.815514ms","start":"2026-05-05T06:44:21.107036Z","end":"2026-05-05T06:44:21.253852Z","steps":["trace[1859556650] 'agreement among raft nodes before linearized reading' (duration: 146.719812ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:27.707144Z","caller":"traceutil/trace.go:171","msg":"trace[513271666] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"204.259685ms","start":"2026-05-05T06:44:27.502822Z","end":"2026-05-05T06:44:27.707082Z","steps":["trace[513271666] 'read index received' (duration: 197.156407ms)","trace[513271666] 'applied index is now lower than readState.Index' (duration: 7.102168ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:44:27.707318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.46688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:44:27.707358Z","caller":"traceutil/trace.go:171","msg":"trace[1050240261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"204.566962ms","start":"2026-05-05T06:44:27.502774Z","end":"2026-05-05T06:44:27.707341Z","steps":["trace[1050240261] 'agreement among raft nodes before linearized reading' (duration: 204.44901ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:27.707411Z","caller":"traceutil/trace.go:171","msg":"trace[450139962] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"458.82951ms","start":"2026-05-05T06:44:27.248537Z","end":"2026-05-05T06:44:27.707367Z","steps":["trace[450139962] 'process raft request' (duration: 452.556368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:27.707594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:44:27.248501Z","time spent":"458.993412ms","remote":"127.0.0.1:52424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:44:28.170437Z","caller":"traceutil/trace.go:171","msg":"trace[885086173] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"369.194371ms","start":"2026-05-05T06:44:27.801214Z","end":"2026-05-05T06:44:28.170408Z","steps":["trace[885086173] 'read index received' (duration: 368.988737ms)","trace[885086173] 'applied index is now lower than readState.Index' (duration: 204.134µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:44:28.170502Z","caller":"traceutil/trace.go:171","msg":"trace[1380777328] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"408.226755ms","start":"2026-05-05T06:44:27.76223Z","end":"2026-05-05T06:44:28.170457Z","steps":["trace[1380777328] 'process raft request' (duration: 408.029251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:28.17065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.421777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f6chq\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-05-05T06:44:28.170669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:44:27.762196Z","time spent":"408.387379ms","remote":"127.0.0.1:52630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T06:44:28.170689Z","caller":"traceutil/trace.go:171","msg":"trace[1609869892] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f6chq; range_end:; response_count:1; response_revision:571; }","duration":"369.511679ms","start":"2026-05-05T06:44:27.801166Z","end":"2026-05-05T06:44:28.170677Z","steps":["trace[1609869892] 'agreement among raft nodes before linearized reading' (duration: 369.387935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:28.170728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:44:27.801145Z","time spent":"369.57443ms","remote":"127.0.0.1:52502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-f6chq\" "} {"level":"warn","ts":"2026-05-05T06:44:28.170885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.685967ms","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-05-05T06:44:28.170972Z","caller":"traceutil/trace.go:171","msg":"trace[2026386756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"170.84596ms","start":"2026-05-05T06:44:28.000104Z","end":"2026-05-05T06:44:28.17095Z","steps":["trace[2026386756] 'agreement among raft nodes before linearized reading' (duration: 170.574305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:28.171034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.763743ms","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-05-05T06:44:28.171171Z","caller":"traceutil/trace.go:171","msg":"trace[1716263551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:571; }","duration":"368.973198ms","start":"2026-05-05T06:44:27.802169Z","end":"2026-05-05T06:44:28.171142Z","steps":["trace[1716263551] 'agreement among raft nodes before linearized reading' (duration: 368.504678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:28.171248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:44:27.802135Z","time spent":"369.08674ms","remote":"127.0.0.1:52564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T06:44:28.425856Z","caller":"traceutil/trace.go:171","msg":"trace[1550468474] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"249.753669ms","start":"2026-05-05T06:44:28.176066Z","end":"2026-05-05T06:44:28.42582Z","steps":["trace[1550468474] 'process raft request' (duration: 219.679578ms)","trace[1550468474] 'compare' (duration: 29.901348ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:44:28.428392Z","caller":"traceutil/trace.go:171","msg":"trace[442221502] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:594; }","duration":"245.792717ms","start":"2026-05-05T06:44:28.182577Z","end":"2026-05-05T06:44:28.428369Z","steps":["trace[442221502] 'read index received' (duration: 213.127252ms)","trace[442221502] 'applied index is now lower than readState.Index' (duration: 32.664505ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:44:28.428483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.896999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:44:28.428511Z","caller":"traceutil/trace.go:171","msg":"trace[337133507] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:575; }","duration":"245.93506ms","start":"2026-05-05T06:44:28.182566Z","end":"2026-05-05T06:44:28.428501Z","steps":["trace[337133507] 'agreement among raft nodes before linearized reading' (duration: 245.882259ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:28.428504Z","caller":"traceutil/trace.go:171","msg":"trace[1411478796] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"131.843934ms","start":"2026-05-05T06:44:28.296641Z","end":"2026-05-05T06:44:28.428485Z","steps":["trace[1411478796] 'process raft request' (duration: 131.67076ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:28.428483Z","caller":"traceutil/trace.go:171","msg":"trace[1323543213] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"250.836101ms","start":"2026-05-05T06:44:28.177488Z","end":"2026-05-05T06:44:28.428324Z","steps":["trace[1323543213] 'process raft request' (duration: 250.614426ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:28.428607Z","caller":"traceutil/trace.go:171","msg":"trace[1884322084] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"240.966187ms","start":"2026-05-05T06:44:28.187631Z","end":"2026-05-05T06:44:28.428597Z","steps":["trace[1884322084] 'process raft request' (duration: 240.60454ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:42.692364Z","caller":"traceutil/trace.go:171","msg":"trace[903789363] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"186.342685ms","start":"2026-05-05T06:44:42.505981Z","end":"2026-05-05T06:44:42.692324Z","steps":["trace[903789363] 'process raft request' (duration: 186.109811ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:44:42.755453Z","caller":"traceutil/trace.go:171","msg":"trace[492465601] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:764; }","duration":"130.408064ms","start":"2026-05-05T06:44:42.624939Z","end":"2026-05-05T06:44:42.755347Z","steps":["trace[492465601] 'read index received' (duration: 67.117658ms)","trace[492465601] 'applied index is now lower than readState.Index' (duration: 63.289306ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:44:42.755478Z","caller":"traceutil/trace.go:171","msg":"trace[1491152408] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"245.940973ms","start":"2026-05-05T06:44:42.509494Z","end":"2026-05-05T06:44:42.755435Z","steps":["trace[1491152408] 'process raft request' (duration: 245.715299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:44:42.755662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.720159ms","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-05-05T06:44:42.755704Z","caller":"traceutil/trace.go:171","msg":"trace[1853707446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:739; }","duration":"130.801471ms","start":"2026-05-05T06:44:42.624894Z","end":"2026-05-05T06:44:42.755696Z","steps":["trace[1853707446] 'agreement among raft nodes before linearized reading' (duration: 130.649778ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:45:00.558928Z","caller":"traceutil/trace.go:171","msg":"trace[771350579] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"106.289954ms","start":"2026-05-05T06:45:00.452611Z","end":"2026-05-05T06:45:00.558901Z","steps":["trace[771350579] 'process raft request' (duration: 105.970079ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:45:34.379328Z","caller":"traceutil/trace.go:171","msg":"trace[1524511795] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"113.140587ms","start":"2026-05-05T06:45:34.266161Z","end":"2026-05-05T06:45:34.379302Z","steps":["trace[1524511795] 'process raft request' (duration: 112.971195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:45:56.193349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.554776ms","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-05-05T06:45:56.193448Z","caller":"traceutil/trace.go:171","msg":"trace[299554310] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1785; }","duration":"124.711167ms","start":"2026-05-05T06:45:56.068717Z","end":"2026-05-05T06:45:56.193429Z","steps":["trace[299554310] 'count revisions from in-memory index tree' (duration: 124.477215ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:45:56.43983Z","caller":"traceutil/trace.go:171","msg":"trace[1550497038] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"150.067388ms","start":"2026-05-05T06:45:56.289732Z","end":"2026-05-05T06:45:56.4398Z","steps":["trace[1550497038] 'process raft request' (duration: 149.817335ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:45:56.726499Z","caller":"traceutil/trace.go:171","msg":"trace[551002647] linearizableReadLoop","detail":"{readStateIndex:1846; appliedIndex:1845; }","duration":"126.499989ms","start":"2026-05-05T06:45:56.59997Z","end":"2026-05-05T06:45:56.72647Z","steps":["trace[551002647] 'read index received' (duration: 126.172755ms)","trace[551002647] 'applied index is now lower than readState.Index' (duration: 325.794µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:45:56.726762Z","caller":"traceutil/trace.go:171","msg":"trace[2138702356] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"130.078093ms","start":"2026-05-05T06:45:56.596648Z","end":"2026-05-05T06:45:56.726726Z","steps":["trace[2138702356] 'process raft request' (duration: 129.603728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:45:56.727075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.059795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fac70432-6523-4ef8-9d73-0794a625abba\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-05-05T06:45:56.727122Z","caller":"traceutil/trace.go:171","msg":"trace[1893017778] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fac70432-6523-4ef8-9d73-0794a625abba; range_end:; response_count:1; response_revision:1789; }","duration":"127.163226ms","start":"2026-05-05T06:45:56.599945Z","end":"2026-05-05T06:45:56.727109Z","steps":["trace[1893017778] 'agreement among raft nodes before linearized reading' (duration: 126.63742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:03.352539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.619639ms","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-05-05T06:46:03.35262Z","caller":"traceutil/trace.go:171","msg":"trace[1336903448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1865; }","duration":"155.73249ms","start":"2026-05-05T06:46:03.196868Z","end":"2026-05-05T06:46:03.352601Z","steps":["trace[1336903448] 'range keys from in-memory index tree' (duration: 155.474577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:03.352919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.347912ms","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-05-05T06:46:03.352946Z","caller":"traceutil/trace.go:171","msg":"trace[1457280685] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1865; }","duration":"163.374792ms","start":"2026-05-05T06:46:03.189565Z","end":"2026-05-05T06:46:03.35294Z","steps":["trace[1457280685] 'range keys from in-memory index tree' (duration: 163.21873ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:03.353025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.939796ms","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-05-05T06:46:03.353094Z","caller":"traceutil/trace.go:171","msg":"trace[120387917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1865; }","duration":"162.038486ms","start":"2026-05-05T06:46:03.191039Z","end":"2026-05-05T06:46:03.353078Z","steps":["trace[120387917] 'range keys from in-memory index tree' (duration: 161.824014ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:03.534719Z","caller":"traceutil/trace.go:171","msg":"trace[1826604401] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"105.226838ms","start":"2026-05-05T06:46:03.429467Z","end":"2026-05-05T06:46:03.534694Z","steps":["trace[1826604401] 'process raft request' (duration: 105.131407ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:03.534969Z","caller":"traceutil/trace.go:171","msg":"trace[2004329788] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"105.952637ms","start":"2026-05-05T06:46:03.428991Z","end":"2026-05-05T06:46:03.534944Z","steps":["trace[2004329788] 'process raft request' (duration: 51.448305ms)","trace[2004329788] 'compare' (duration: 54.027025ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:46:03.535152Z","caller":"traceutil/trace.go:171","msg":"trace[273596868] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"105.530102ms","start":"2026-05-05T06:46:03.429518Z","end":"2026-05-05T06:46:03.535048Z","steps":["trace[273596868] 'process raft request' (duration: 105.140266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:06.198663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.511209ms","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-05-05T06:46:06.198797Z","caller":"traceutil/trace.go:171","msg":"trace[214043909] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1895; }","duration":"192.722991ms","start":"2026-05-05T06:46:06.006041Z","end":"2026-05-05T06:46:06.198764Z","steps":["trace[214043909] 'range keys from in-memory index tree' (duration: 192.248686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:29.895842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.465519ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:46:29.896006Z","caller":"traceutil/trace.go:171","msg":"trace[296585892] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2133; }","duration":"347.270008ms","start":"2026-05-05T06:46:29.548713Z","end":"2026-05-05T06:46:29.895983Z","steps":["trace[296585892] 'read index received' (duration: 117.314533ms)","trace[296585892] 'applied index is now lower than readState.Index' (duration: 229.953865ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:46:29.896134Z","caller":"traceutil/trace.go:171","msg":"trace[1164202494] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"390.506718ms","start":"2026-05-05T06:46:29.505602Z","end":"2026-05-05T06:46:29.896109Z","steps":["trace[1164202494] 'process raft request' (duration: 160.457253ms)","trace[1164202494] 'compare' (duration: 229.300918ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:46:29.896817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:46:29.505588Z","time spent":"391.181776ms","remote":"127.0.0.1:52564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:46:29.896275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.571323ms","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-05-05T06:46:29.896343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.358661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:46:29.897284Z","caller":"traceutil/trace.go:171","msg":"trace[453457964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2063; }","duration":"241.331401ms","start":"2026-05-05T06:46:29.655934Z","end":"2026-05-05T06:46:29.897265Z","steps":["trace[453457964] 'agreement among raft nodes before linearized reading' (duration: 240.381782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:29.896413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.468458ms","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-05-05T06:46:29.897449Z","caller":"traceutil/trace.go:171","msg":"trace[2071694332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2063; }","duration":"346.5349ms","start":"2026-05-05T06:46:29.550893Z","end":"2026-05-05T06:46:29.897428Z","steps":["trace[2071694332] 'agreement among raft nodes before linearized reading' (duration: 345.370888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:29.897531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:46:29.550883Z","time spent":"346.629861ms","remote":"127.0.0.1:52564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T06:46:29.897276Z","caller":"traceutil/trace.go:171","msg":"trace[471782155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2063; }","duration":"348.495242ms","start":"2026-05-05T06:46:29.548637Z","end":"2026-05-05T06:46:29.897132Z","steps":["trace[471782155] 'agreement among raft nodes before linearized reading' (duration: 347.46709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:46:29.899608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:46:29.548606Z","time spent":"350.95779ms","remote":"127.0.0.1:52564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T06:46:30.090903Z","caller":"traceutil/trace.go:171","msg":"trace[489494577] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"187.403969ms","start":"2026-05-05T06:46:29.903471Z","end":"2026-05-05T06:46:30.090875Z","steps":["trace[489494577] 'process raft request' (duration: 163.089169ms)","trace[489494577] 'compare' (duration: 24.100417ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:46:30.091578Z","caller":"traceutil/trace.go:171","msg":"trace[465401736] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"186.65351ms","start":"2026-05-05T06:46:29.90491Z","end":"2026-05-05T06:46:30.091564Z","steps":["trace[465401736] 'process raft request' (duration: 185.902392ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:30.2847Z","caller":"traceutil/trace.go:171","msg":"trace[672839315] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"105.087445ms","start":"2026-05-05T06:46:30.179584Z","end":"2026-05-05T06:46:30.284671Z","steps":["trace[672839315] 'process raft request' (duration: 99.374472ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:24.935578Z","caller":"traceutil/trace.go:171","msg":"trace[402388988] transaction","detail":"{read_only:false; response_revision:2548; number_of_response:1; }","duration":"227.870562ms","start":"2026-05-05T06:47:24.707634Z","end":"2026-05-05T06:47:24.935504Z","steps":["trace[402388988] 'process raft request' (duration: 227.473618ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:24.937123Z","caller":"traceutil/trace.go:171","msg":"trace[1385182989] transaction","detail":"{read_only:false; response_revision:2549; number_of_response:1; }","duration":"130.666805ms","start":"2026-05-05T06:47:24.806438Z","end":"2026-05-05T06:47:24.937104Z","steps":["trace[1385182989] 'process raft request' (duration: 130.572704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.217691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.58671ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:47:52.218142Z","caller":"traceutil/trace.go:171","msg":"trace[814791112] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"186.411784ms","start":"2026-05-05T06:47:52.031683Z","end":"2026-05-05T06:47:52.218095Z","steps":["trace[814791112] 'process raft request' (duration: 42.331409ms)","trace[814791112] 'compare' (duration: 143.428138ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:47:52.523772Z","caller":"traceutil/trace.go:171","msg":"trace[1705762769] linearizableReadLoop","detail":"{readStateIndex:2844; appliedIndex:2843; }","duration":"223.497962ms","start":"2026-05-05T06:47:52.300244Z","end":"2026-05-05T06:47:52.523742Z","steps":["trace[1705762769] 'read index received' (duration: 190.221452ms)","trace[1705762769] 'applied index is now lower than readState.Index' (duration: 33.2751ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:47:52.523813Z","caller":"traceutil/trace.go:171","msg":"trace[1527789329] transaction","detail":"{read_only:false; response_revision:2735; number_of_response:1; }","duration":"253.72891ms","start":"2026-05-05T06:47:52.270024Z","end":"2026-05-05T06:47:52.523753Z","steps":["trace[1527789329] 'process raft request' (duration: 220.517761ms)","trace[1527789329] 'compare' (duration: 33.031147ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:47:52.524012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.760224ms","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-05-05T06:47:52.524061Z","caller":"traceutil/trace.go:171","msg":"trace[2016205512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2735; }","duration":"223.912396ms","start":"2026-05-05T06:47:52.300135Z","end":"2026-05-05T06:47:52.524047Z","steps":["trace[2016205512] 'agreement among raft nodes before linearized reading' (duration: 223.753324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.524268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.964252ms","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-05-05T06:47:52.524279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.145337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:47:52.524334Z","caller":"traceutil/trace.go:171","msg":"trace[785478725] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2735; }","duration":"158.079443ms","start":"2026-05-05T06:47:52.366233Z","end":"2026-05-05T06:47:52.524313Z","steps":["trace[785478725] 'agreement among raft nodes before linearized reading' (duration: 157.832261ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:52.524364Z","caller":"traceutil/trace.go:171","msg":"trace[1629765806] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2735; }","duration":"133.304148ms","start":"2026-05-05T06:47:52.391039Z","end":"2026-05-05T06:47:52.524343Z","steps":["trace[1629765806] 'agreement among raft nodes before linearized reading' (duration: 133.124697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.524512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.55993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"} {"level":"info","ts":"2026-05-05T06:47:52.524623Z","caller":"traceutil/trace.go:171","msg":"trace[2100369426] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2735; }","duration":"153.709761ms","start":"2026-05-05T06:47:52.370894Z","end":"2026-05-05T06:47:52.524604Z","steps":["trace[2100369426] 'agreement among raft nodes before linearized reading' (duration: 153.394567ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:52.650173Z","caller":"traceutil/trace.go:171","msg":"trace[307604642] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"116.511823ms","start":"2026-05-05T06:47:52.533639Z","end":"2026-05-05T06:47:52.650151Z","steps":["trace[307604642] 'process raft request' (duration: 116.440102ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:52.650285Z","caller":"traceutil/trace.go:171","msg":"trace[2100586853] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"117.23772ms","start":"2026-05-05T06:47:52.532946Z","end":"2026-05-05T06:47:52.650184Z","steps":["trace[2100586853] 'process raft request' (duration: 117.086439ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:52.650609Z","caller":"traceutil/trace.go:171","msg":"trace[1384452685] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2739; }","duration":"116.749387ms","start":"2026-05-05T06:47:52.533825Z","end":"2026-05-05T06:47:52.650575Z","steps":["trace[1384452685] 'process raft request' (duration: 116.293121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.650702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.30217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1247"} {"level":"info","ts":"2026-05-05T06:47:52.650977Z","caller":"traceutil/trace.go:171","msg":"trace[1281836748] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2739; }","duration":"119.380832ms","start":"2026-05-05T06:47:52.531359Z","end":"2026-05-05T06:47:52.650739Z","steps":["trace[1281836748] 'agreement among raft nodes before linearized reading' (duration: 119.19193ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:52.650985Z","caller":"traceutil/trace.go:171","msg":"trace[1270820946] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"118.116879ms","start":"2026-05-05T06:47:52.532816Z","end":"2026-05-05T06:47:52.650933Z","steps":["trace[1270820946] 'process raft request' (duration: 104.007469ms)","trace[1270820946] 'compare' (duration: 13.10076ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:47:52.844424Z","caller":"traceutil/trace.go:171","msg":"trace[1732183497] linearizableReadLoop","detail":"{readStateIndex:2850; appliedIndex:2849; }","duration":"191.174321ms","start":"2026-05-05T06:47:52.653222Z","end":"2026-05-05T06:47:52.844396Z","steps":["trace[1732183497] 'read index received' (duration: 139.839042ms)","trace[1732183497] 'applied index is now lower than readState.Index' (duration: 51.333759ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:47:52.844539Z","caller":"traceutil/trace.go:171","msg":"trace[1432779935] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"231.163137ms","start":"2026-05-05T06:47:52.613326Z","end":"2026-05-05T06:47:52.844489Z","steps":["trace[1432779935] 'process raft request' (duration: 179.772118ms)","trace[1432779935] 'compare' (duration: 51.076646ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:47:52.844779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.545794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:13485"} {"level":"info","ts":"2026-05-05T06:47:52.844838Z","caller":"traceutil/trace.go:171","msg":"trace[353485572] range","detail":"{range_begin:/registry/statefulsets/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:2740; }","duration":"191.675517ms","start":"2026-05-05T06:47:52.653153Z","end":"2026-05-05T06:47:52.844829Z","steps":["trace[353485572] 'agreement among raft nodes before linearized reading' (duration: 191.451765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.845018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.325042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:5904"} {"level":"info","ts":"2026-05-05T06:47:52.845069Z","caller":"traceutil/trace.go:171","msg":"trace[313145170] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2740; }","duration":"190.401634ms","start":"2026-05-05T06:47:52.654655Z","end":"2026-05-05T06:47:52.845057Z","steps":["trace[313145170] 'agreement among raft nodes before linearized reading' (duration: 190.15372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.845213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.479373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T06:47:52.845463Z","caller":"traceutil/trace.go:171","msg":"trace[1469068756] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2740; }","duration":"106.733347ms","start":"2026-05-05T06:47:52.738555Z","end":"2026-05-05T06:47:52.845288Z","steps":["trace[1469068756] 'agreement among raft nodes before linearized reading' (duration: 106.436274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:52.845732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.77562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ac9886cf39a59c\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-05T06:47:52.845974Z","caller":"traceutil/trace.go:171","msg":"trace[791335535] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ac9886cf39a59c; range_end:; response_count:1; response_revision:2740; }","duration":"169.047753ms","start":"2026-05-05T06:47:52.676911Z","end":"2026-05-05T06:47:52.845959Z","steps":["trace[791335535] 'agreement among raft nodes before linearized reading' (duration: 168.113644ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:49:26.306903Z","caller":"traceutil/trace.go:171","msg":"trace[1044847365] transaction","detail":"{read_only:false; response_revision:3527; number_of_response:1; }","duration":"119.221116ms","start":"2026-05-05T06:49:26.187661Z","end":"2026-05-05T06:49:26.306882Z","steps":["trace[1044847365] 'process raft request' (duration: 72.347941ms)","trace[1044847365] 'compare' (duration: 46.482876ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:19.785248Z","caller":"traceutil/trace.go:171","msg":"trace[1153677110] transaction","detail":"{read_only:false; response_revision:4409; number_of_response:1; }","duration":"152.38683ms","start":"2026-05-05T06:50:19.632827Z","end":"2026-05-05T06:50:19.785214Z","steps":["trace[1153677110] 'process raft request' (duration: 139.5805ms)","trace[1153677110] 'compare' (duration: 12.25297ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:23.545305Z","caller":"traceutil/trace.go:171","msg":"trace[593415823] linearizableReadLoop","detail":"{readStateIndex:4702; appliedIndex:4701; }","duration":"155.071766ms","start":"2026-05-05T06:50:23.390202Z","end":"2026-05-05T06:50:23.545274Z","steps":["trace[593415823] 'read index received' (duration: 154.72573ms)","trace[593415823] 'applied index is now lower than readState.Index' (duration: 344.886µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:23.545397Z","caller":"traceutil/trace.go:171","msg":"trace[801918219] transaction","detail":"{read_only:false; response_revision:4504; number_of_response:1; }","duration":"161.95443ms","start":"2026-05-05T06:50:23.383407Z","end":"2026-05-05T06:50:23.545362Z","steps":["trace[801918219] 'process raft request' (duration: 161.628994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:23.54557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.347961ms","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-05-05T06:50:23.545592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.717135ms","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-05-05T06:50:23.545622Z","caller":"traceutil/trace.go:171","msg":"trace[504248680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4504; }","duration":"155.427414ms","start":"2026-05-05T06:50:23.39018Z","end":"2026-05-05T06:50:23.545608Z","steps":["trace[504248680] 'agreement among raft nodes before linearized reading' (duration: 155.24337ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:23.545655Z","caller":"traceutil/trace.go:171","msg":"trace[226304859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4504; }","duration":"146.816257ms","start":"2026-05-05T06:50:23.398823Z","end":"2026-05-05T06:50:23.545639Z","steps":["trace[226304859] 'agreement among raft nodes before linearized reading' (duration: 146.635714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:23.545767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.277585ms","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-05-05T06:50:23.545859Z","caller":"traceutil/trace.go:171","msg":"trace[2000471011] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4504; }","duration":"133.422998ms","start":"2026-05-05T06:50:23.412417Z","end":"2026-05-05T06:50:23.54584Z","steps":["trace[2000471011] 'agreement among raft nodes before linearized reading' (duration: 133.137823ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:23.65616Z","caller":"traceutil/trace.go:171","msg":"trace[30845298] transaction","detail":"{read_only:false; response_revision:4506; number_of_response:1; }","duration":"104.714214ms","start":"2026-05-05T06:50:23.551425Z","end":"2026-05-05T06:50:23.65614Z","steps":["trace[30845298] 'process raft request' (duration: 99.688416ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:23.65639Z","caller":"traceutil/trace.go:171","msg":"trace[1942278922] transaction","detail":"{read_only:false; response_revision:4507; number_of_response:1; }","duration":"104.731694ms","start":"2026-05-05T06:50:23.551651Z","end":"2026-05-05T06:50:23.656383Z","steps":["trace[1942278922] 'process raft request' (duration: 104.450149ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:35.001007Z","caller":"traceutil/trace.go:171","msg":"trace[1321634728] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"281.648686ms","start":"2026-05-05T06:50:34.719321Z","end":"2026-05-05T06:50:35.00097Z","steps":["trace[1321634728] 'process raft request' (duration: 220.571302ms)","trace[1321634728] 'compare' (duration: 60.569964ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:50:35.001708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.766481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-05T06:50:35.001809Z","caller":"traceutil/trace.go:171","msg":"trace[826017316] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4673; }","duration":"239.967824ms","start":"2026-05-05T06:50:34.76182Z","end":"2026-05-05T06:50:35.001788Z","steps":["trace[826017316] 'agreement among raft nodes before linearized reading' (duration: 239.701619ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:35.000955Z","caller":"traceutil/trace.go:171","msg":"trace[879279698] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4876; }","duration":"239.007957ms","start":"2026-05-05T06:50:34.761913Z","end":"2026-05-05T06:50:35.000921Z","steps":["trace[879279698] 'read index received' (duration: 178.040695ms)","trace[879279698] 'applied index is now lower than readState.Index' (duration: 60.965522ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:35.413484Z","caller":"traceutil/trace.go:171","msg":"trace[568607970] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"405.137267ms","start":"2026-05-05T06:50:35.008274Z","end":"2026-05-05T06:50:35.413412Z","steps":["trace[568607970] 'process raft request' (duration: 404.796791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:35.414361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:35.008255Z","time spent":"405.392511ms","remote":"127.0.0.1:52472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:35.441885Z","caller":"traceutil/trace.go:171","msg":"trace[1864647038] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"433.014948ms","start":"2026-05-05T06:50:35.008837Z","end":"2026-05-05T06:50:35.441852Z","steps":["trace[1864647038] 'process raft request' (duration: 432.920946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:35.442089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:35.008825Z","time spent":"433.164951ms","remote":"127.0.0.1:52576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:35.442285Z","caller":"traceutil/trace.go:171","msg":"trace[1358177733] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"433.776582ms","start":"2026-05-05T06:50:35.008466Z","end":"2026-05-05T06:50:35.442243Z","steps":["trace[1358177733] 'process raft request' (duration: 433.16418ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:35.442591Z","caller":"traceutil/trace.go:171","msg":"trace[1486752906] linearizableReadLoop","detail":"{readStateIndex:4881; appliedIndex:4877; }","duration":"267.051068ms","start":"2026-05-05T06:50:35.175317Z","end":"2026-05-05T06:50:35.442368Z","steps":["trace[1486752906] 'read index received' (duration: 237.822712ms)","trace[1486752906] 'applied index is now lower than readState.Index' (duration: 29.226246ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:35.442956Z","caller":"traceutil/trace.go:171","msg":"trace[24328367] transaction","detail":"{read_only:false; response_revision:4677; number_of_response:1; }","duration":"433.438105ms","start":"2026-05-05T06:50:35.009502Z","end":"2026-05-05T06:50:35.44294Z","steps":["trace[24328367] 'process raft request' (duration: 432.308534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:35.442977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.637698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-05-05T06:50:35.443049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:35.00949Z","time spent":"433.514556ms","remote":"127.0.0.1:52576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:35.443148Z","caller":"traceutil/trace.go:171","msg":"trace[791650375] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4677; }","duration":"267.732191ms","start":"2026-05-05T06:50:35.175282Z","end":"2026-05-05T06:50:35.443014Z","steps":["trace[791650375] 'agreement among raft nodes before linearized reading' (duration: 267.460856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:35.443511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:35.008431Z","time spent":"433.983326ms","remote":"127.0.0.1:52472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:35.85483Z","caller":"traceutil/trace.go:171","msg":"trace[1337268541] linearizableReadLoop","detail":"{readStateIndex:4885; appliedIndex:4883; }","duration":"140.544235ms","start":"2026-05-05T06:50:35.714255Z","end":"2026-05-05T06:50:35.854799Z","steps":["trace[1337268541] 'read index received' (duration: 105.908049ms)","trace[1337268541] 'applied index is now lower than readState.Index' (duration: 34.634676ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:35.855085Z","caller":"traceutil/trace.go:171","msg":"trace[1478911710] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"160.957536ms","start":"2026-05-05T06:50:35.694055Z","end":"2026-05-05T06:50:35.855013Z","steps":["trace[1478911710] 'process raft request' (duration: 160.623029ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:35.855074Z","caller":"traceutil/trace.go:171","msg":"trace[142635866] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"183.132451ms","start":"2026-05-05T06:50:35.671893Z","end":"2026-05-05T06:50:35.855025Z","steps":["trace[142635866] 'process raft request' (duration: 148.189749ms)","trace[142635866] 'compare' (duration: 34.297609ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:50:35.855374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.103736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-05-05T06:50:35.855438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.281803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-05T06:50:35.855436Z","caller":"traceutil/trace.go:171","msg":"trace[1211269710] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4681; }","duration":"141.212887ms","start":"2026-05-05T06:50:35.71421Z","end":"2026-05-05T06:50:35.855423Z","steps":["trace[1211269710] 'agreement among raft nodes before linearized reading' (duration: 141.025504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:35.855346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.665659ms","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-05-05T06:50:35.855494Z","caller":"traceutil/trace.go:171","msg":"trace[340141720] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4681; }","duration":"138.349424ms","start":"2026-05-05T06:50:35.717133Z","end":"2026-05-05T06:50:35.855483Z","steps":["trace[340141720] 'agreement among raft nodes before linearized reading' (duration: 138.236062ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:35.855535Z","caller":"traceutil/trace.go:171","msg":"trace[711262399] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4681; }","duration":"138.875264ms","start":"2026-05-05T06:50:35.716636Z","end":"2026-05-05T06:50:35.855511Z","steps":["trace[711262399] 'agreement among raft nodes before linearized reading' (duration: 138.583539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:51:11.171711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.338266ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-05T06:53:53.035396Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3238} {"level":"info","ts":"2026-05-05T06:53:53.139562Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3238,"took":"102.402115ms","hash":91131119,"current-db-size-bytes":59150336,"current-db-size":"59 MB","current-db-size-in-use-bytes":32346112,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-05T06:53:53.139614Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":91131119,"revision":3238,"compact-revision":-1} {"level":"warn","ts":"2026-05-05T06:54:31.456766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.333342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:54:31.457452Z","caller":"traceutil/trace.go:171","msg":"trace[1689714763] transaction","detail":"{read_only:false; response_revision:6765; number_of_response:1; }","duration":"241.980866ms","start":"2026-05-05T06:54:31.215442Z","end":"2026-05-05T06:54:31.457423Z","steps":["trace[1689714763] 'process raft request' (duration: 241.439998ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:31.457452Z","caller":"traceutil/trace.go:171","msg":"trace[1022301839] transaction","detail":"{read_only:false; response_revision:6764; number_of_response:1; }","duration":"242.492113ms","start":"2026-05-05T06:54:31.214929Z","end":"2026-05-05T06:54:31.457421Z","steps":["trace[1022301839] 'process raft request' (duration: 112.416391ms)","trace[1022301839] 'compare' (duration: 128.966877ms)"],"step_count":2}