{"level":"warn","ts":"2026-05-12T11:23:02.392881Z","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-12T11:23:02.392977Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.195: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.195:2380","--initial-cluster=instance=https://199.19.213.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.195: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-12T11:23:02.393057Z","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-12T11:23:02.393077Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.195:2380"]} {"level":"info","ts":"2026-05-12T11:23:02.393098Z","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-12T11:23:02.394755Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"]} {"level":"info","ts":"2026-05-12T11:23:02.394861Z","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.195:2380"],"listen-peer-urls":["https://199.19.213.195:2380"],"advertise-client-urls":["https://199.19.213.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.195: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-12T11:23:02.396947Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.817404ms"} {"level":"info","ts":"2026-05-12T11:23:02.404887Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2808ca5e53a916c4","cluster-id":"b7ef986abcd4d0b8"} {"level":"info","ts":"2026-05-12T11:23:02.404943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T11:23:02.404963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became follower at term 0"} {"level":"info","ts":"2026-05-12T11:23:02.404971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2808ca5e53a916c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T11:23:02.40498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became follower at term 1"} {"level":"info","ts":"2026-05-12T11:23:02.40501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 switched to configuration voters=(2884778067810129604)"} {"level":"warn","ts":"2026-05-12T11:23:02.417183Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T11:23:02.418723Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T11:23:02.419866Z","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-12T11:23:02.42297Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2808ca5e53a916c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T11:23:02.424763Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2808ca5e53a916c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T11:23:02.425633Z","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-12T11:23:02.425778Z","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-12T11:23:02.425796Z","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-12T11:23:02.427137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 switched to configuration voters=(2884778067810129604)"} {"level":"info","ts":"2026-05-12T11:23:02.427271Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b7ef986abcd4d0b8","local-member-id":"2808ca5e53a916c4","added-peer-id":"2808ca5e53a916c4","added-peer-peer-urls":["https://199.19.213.195:2380"]} {"level":"info","ts":"2026-05-12T11:23:02.427651Z","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-12T11:23:02.427933Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2808ca5e53a916c4","initial-advertise-peer-urls":["https://199.19.213.195:2380"],"listen-peer-urls":["https://199.19.213.195:2380"],"advertise-client-urls":["https://199.19.213.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T11:23:02.427978Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T11:23:02.428115Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.195:2380"} {"level":"info","ts":"2026-05-12T11:23:02.428139Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.195:2380"} {"level":"info","ts":"2026-05-12T11:23:02.607141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T11:23:02.607197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T11:23:02.60723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 received MsgPreVoteResp from 2808ca5e53a916c4 at term 1"} {"level":"info","ts":"2026-05-12T11:23:02.607249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became candidate at term 2"} {"level":"info","ts":"2026-05-12T11:23:02.607261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 received MsgVoteResp from 2808ca5e53a916c4 at term 2"} {"level":"info","ts":"2026-05-12T11:23:02.607277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became leader at term 2"} {"level":"info","ts":"2026-05-12T11:23:02.607296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2808ca5e53a916c4 elected leader 2808ca5e53a916c4 at term 2"} {"level":"info","ts":"2026-05-12T11:23:02.619106Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2808ca5e53a916c4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.195:2379]}","request-path":"/0/members/2808ca5e53a916c4/attributes","cluster-id":"b7ef986abcd4d0b8","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T11:23:02.619207Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:23:02.619276Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:23:02.619622Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:02.619921Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T11:23:02.619969Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T11:23:02.622455Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T11:23:02.622926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.195:2379"} {"level":"info","ts":"2026-05-12T11:23:02.635683Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b7ef986abcd4d0b8","local-member-id":"2808ca5e53a916c4","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:02.635847Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:02.635884Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:31.444443Z","caller":"traceutil/trace.go:171","msg":"trace[1330168556] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"152.589404ms","start":"2026-05-12T11:23:31.291826Z","end":"2026-05-12T11:23:31.444415Z","steps":["trace[1330168556] 'process raft request' (duration: 152.418491ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:31.444411Z","caller":"traceutil/trace.go:171","msg":"trace[1594777376] transaction","detail":"{read_only:false; number_of_response:0; response_revision:476; }","duration":"154.344811ms","start":"2026-05-12T11:23:31.289997Z","end":"2026-05-12T11:23:31.444342Z","steps":["trace[1594777376] 'process raft request' (duration: 154.208299ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:31.444531Z","caller":"traceutil/trace.go:171","msg":"trace[1041804281] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"120.73731ms","start":"2026-05-12T11:23:31.323772Z","end":"2026-05-12T11:23:31.444509Z","steps":["trace[1041804281] 'process raft request' (duration: 120.685909ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:31.444678Z","caller":"traceutil/trace.go:171","msg":"trace[1520864499] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"139.531019ms","start":"2026-05-12T11:23:31.305121Z","end":"2026-05-12T11:23:31.444652Z","steps":["trace[1520864499] 'process raft request' (duration: 139.217334ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:31.444615Z","caller":"traceutil/trace.go:171","msg":"trace[1976168024] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"154.713308ms","start":"2026-05-12T11:23:31.289891Z","end":"2026-05-12T11:23:31.444604Z","steps":["trace[1976168024] 'process raft request' (duration: 154.188339ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:31.444672Z","caller":"traceutil/trace.go:171","msg":"trace[706528420] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"138.625665ms","start":"2026-05-12T11:23:31.306038Z","end":"2026-05-12T11:23:31.444664Z","steps":["trace[706528420] 'process raft request' (duration: 138.36401ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:31.444717Z","caller":"traceutil/trace.go:171","msg":"trace[894687484] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"143.359441ms","start":"2026-05-12T11:23:31.301329Z","end":"2026-05-12T11:23:31.444688Z","steps":["trace[894687484] 'process raft request' (duration: 142.966015ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:32.179717Z","caller":"traceutil/trace.go:171","msg":"trace[568027192] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"124.760791ms","start":"2026-05-12T11:23:32.05493Z","end":"2026-05-12T11:23:32.17969Z","steps":["trace[568027192] 'process raft request' (duration: 79.020912ms)","trace[568027192] 'compare' (duration: 45.546436ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:23:37.669969Z","caller":"traceutil/trace.go:171","msg":"trace[2070301783] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"226.604379ms","start":"2026-05-12T11:23:37.443344Z","end":"2026-05-12T11:23:37.669948Z","steps":["trace[2070301783] 'process raft request' (duration: 226.171092ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:38.060642Z","caller":"traceutil/trace.go:171","msg":"trace[463242360] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"214.013929ms","start":"2026-05-12T11:23:37.846601Z","end":"2026-05-12T11:23:38.060615Z","steps":["trace[463242360] 'read index received' (duration: 213.803104ms)","trace[463242360] 'applied index is now lower than readState.Index' (duration: 209.825µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:23:38.060693Z","caller":"traceutil/trace.go:171","msg":"trace[1896968997] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"338.249579ms","start":"2026-05-12T11:23:37.722402Z","end":"2026-05-12T11:23:38.060652Z","steps":["trace[1896968997] 'process raft request' (duration: 338.020494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:38.06092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.291353ms","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-12T11:23:38.061001Z","caller":"traceutil/trace.go:171","msg":"trace[1255472087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"214.439576ms","start":"2026-05-12T11:23:37.846546Z","end":"2026-05-12T11:23:38.060985Z","steps":["trace[1255472087] 'agreement among raft nodes before linearized reading' (duration: 214.210622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:38.061038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:37.722385Z","time spent":"338.368812ms","remote":"127.0.0.1:36278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:23:38.061084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.259156ms","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-05-12T11:23:38.061264Z","caller":"traceutil/trace.go:171","msg":"trace[1830463027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"180.520561ms","start":"2026-05-12T11:23:37.880722Z","end":"2026-05-12T11:23:38.061243Z","steps":["trace[1830463027] 'agreement among raft nodes before linearized reading' (duration: 180.095933ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:38.375129Z","caller":"traceutil/trace.go:171","msg":"trace[71629076] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"203.625852ms","start":"2026-05-12T11:23:38.17148Z","end":"2026-05-12T11:23:38.375106Z","steps":["trace[71629076] 'process raft request' (duration: 178.632089ms)","trace[71629076] 'compare' (duration: 24.898842ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:23:39.025989Z","caller":"traceutil/trace.go:171","msg":"trace[1078257563] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"526.540315ms","start":"2026-05-12T11:23:38.49942Z","end":"2026-05-12T11:23:39.02596Z","steps":["trace[1078257563] 'process raft request' (duration: 525.826843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:39.02635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:38.499388Z","time spent":"526.680198ms","remote":"127.0.0.1:35850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:23:39.031734Z","caller":"traceutil/trace.go:171","msg":"trace[1135944751] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"353.928054ms","start":"2026-05-12T11:23:38.677764Z","end":"2026-05-12T11:23:39.031692Z","steps":["trace[1135944751] 'process raft request' (duration: 353.71936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:39.031954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:38.67774Z","time spent":"354.105658ms","remote":"127.0.0.1:35934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:23:40.311164Z","caller":"traceutil/trace.go:171","msg":"trace[1500695501] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"209.606753ms","start":"2026-05-12T11:23:40.101525Z","end":"2026-05-12T11:23:40.311132Z","steps":["trace[1500695501] 'process raft request' (duration: 206.969455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:55.580666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.260925ms","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-12T11:23:55.580791Z","caller":"traceutil/trace.go:171","msg":"trace[180890346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:742; }","duration":"320.476309ms","start":"2026-05-12T11:23:55.260291Z","end":"2026-05-12T11:23:55.580767Z","steps":["trace[180890346] 'range keys from in-memory index tree' (duration: 319.99148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:55.58085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:55.260264Z","time spent":"320.567121ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T11:24:49.968848Z","caller":"traceutil/trace.go:171","msg":"trace[1253298214] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"115.418137ms","start":"2026-05-12T11:24:49.853388Z","end":"2026-05-12T11:24:49.968806Z","steps":["trace[1253298214] 'process raft request' (duration: 60.800907ms)","trace[1253298214] 'compare' (duration: 54.387584ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:24:51.592248Z","caller":"traceutil/trace.go:171","msg":"trace[1160729452] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"127.945231ms","start":"2026-05-12T11:24:51.464277Z","end":"2026-05-12T11:24:51.592222Z","steps":["trace[1160729452] 'process raft request' (duration: 127.668054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:14.915356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.193585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-60b53a97-b11e-44ca-8a4b-9da6ef64bee0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-12T11:25:14.915452Z","caller":"traceutil/trace.go:171","msg":"trace[552151481] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-60b53a97-b11e-44ca-8a4b-9da6ef64bee0; range_end:; response_count:1; response_revision:1811; }","duration":"454.298267ms","start":"2026-05-12T11:25:14.461132Z","end":"2026-05-12T11:25:14.91543Z","steps":["trace[552151481] 'range keys from in-memory index tree' (duration: 454.0278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:14.915502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:14.461076Z","time spent":"454.41187ms","remote":"127.0.0.1:35938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-60b53a97-b11e-44ca-8a4b-9da6ef64bee0\" "} {"level":"warn","ts":"2026-05-12T11:25:14.915708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.232571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-60b53a97-b11e-44ca-8a4b-9da6ef64bee0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-12T11:25:14.915858Z","caller":"traceutil/trace.go:171","msg":"trace[1104803507] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-60b53a97-b11e-44ca-8a4b-9da6ef64bee0; range_end:; response_count:1; response_revision:1811; }","duration":"254.445446ms","start":"2026-05-12T11:25:14.661385Z","end":"2026-05-12T11:25:14.91583Z","steps":["trace[1104803507] 'range keys from in-memory index tree' (duration: 253.991215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:14.916106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.027712ms","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-12T11:25:14.916173Z","caller":"traceutil/trace.go:171","msg":"trace[1567042770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1811; }","duration":"258.156315ms","start":"2026-05-12T11:25:14.658001Z","end":"2026-05-12T11:25:14.916157Z","steps":["trace[1567042770] 'range keys from in-memory index tree' (duration: 257.833647ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:15.102482Z","caller":"traceutil/trace.go:171","msg":"trace[1865871860] linearizableReadLoop","detail":"{readStateIndex:1882; appliedIndex:1880; }","duration":"141.052536ms","start":"2026-05-12T11:25:14.961396Z","end":"2026-05-12T11:25:15.102449Z","steps":["trace[1865871860] 'read index received' (duration: 126.815956ms)","trace[1865871860] 'applied index is now lower than readState.Index' (duration: 14.23513ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:15.102553Z","caller":"traceutil/trace.go:171","msg":"trace[1819582862] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"180.285492ms","start":"2026-05-12T11:25:14.92223Z","end":"2026-05-12T11:25:15.102515Z","steps":["trace[1819582862] 'process raft request' (duration: 180.066757ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:15.102498Z","caller":"traceutil/trace.go:171","msg":"trace[628153683] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"180.884088ms","start":"2026-05-12T11:25:14.921571Z","end":"2026-05-12T11:25:15.102455Z","steps":["trace[628153683] 'process raft request' (duration: 166.684279ms)","trace[628153683] 'compare' (duration: 13.805698ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:15.102746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.334503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-12T11:25:15.102787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.795842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-12T11:25:15.102831Z","caller":"traceutil/trace.go:171","msg":"trace[1043238586] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1814; }","duration":"141.562369ms","start":"2026-05-12T11:25:14.961246Z","end":"2026-05-12T11:25:15.102808Z","steps":["trace[1043238586] 'agreement among raft nodes before linearized reading' (duration: 141.341103ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:15.102836Z","caller":"traceutil/trace.go:171","msg":"trace[1365784234] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1814; }","duration":"127.867103ms","start":"2026-05-12T11:25:14.974955Z","end":"2026-05-12T11:25:15.102822Z","steps":["trace[1365784234] 'agreement among raft nodes before linearized reading' (duration: 127.73912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:15.102893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.137421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-12T11:25:15.102963Z","caller":"traceutil/trace.go:171","msg":"trace[408276826] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1814; }","duration":"134.261594ms","start":"2026-05-12T11:25:14.968684Z","end":"2026-05-12T11:25:15.102945Z","steps":["trace[408276826] 'agreement among raft nodes before linearized reading' (duration: 134.000707ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:15.420863Z","caller":"traceutil/trace.go:171","msg":"trace[93550521] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"312.211029ms","start":"2026-05-12T11:25:15.108623Z","end":"2026-05-12T11:25:15.420834Z","steps":["trace[93550521] 'process raft request' (duration: 311.929852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:15.421016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:15.10859Z","time spent":"312.342723ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:25:15.426488Z","caller":"traceutil/trace.go:171","msg":"trace[1514666164] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1883; }","duration":"216.880823ms","start":"2026-05-12T11:25:15.209586Z","end":"2026-05-12T11:25:15.426467Z","steps":["trace[1514666164] 'read index received' (duration: 211.316834ms)","trace[1514666164] 'applied index is now lower than readState.Index' (duration: 5.563009ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:15.426559Z","caller":"traceutil/trace.go:171","msg":"trace[1403901147] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"310.800301ms","start":"2026-05-12T11:25:15.115721Z","end":"2026-05-12T11:25:15.426522Z","steps":["trace[1403901147] 'process raft request' (duration: 310.629867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:15.426695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:15.115715Z","time spent":"310.902595ms","remote":"127.0.0.1:35938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:25:15.426913Z","caller":"traceutil/trace.go:171","msg":"trace[930267783] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"316.840273ms","start":"2026-05-12T11:25:15.11006Z","end":"2026-05-12T11:25:15.426901Z","steps":["trace[930267783] 'process raft request' (duration: 316.147725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:15.426974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:15.110038Z","time spent":"316.906734ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:25:15.428058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.456125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:25:15.428124Z","caller":"traceutil/trace.go:171","msg":"trace[1316505499] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1818; }","duration":"218.594059ms","start":"2026-05-12T11:25:15.209517Z","end":"2026-05-12T11:25:15.428111Z","steps":["trace[1316505499] 'agreement among raft nodes before linearized reading' (duration: 217.435967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:15.427982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.259418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:25:15.428518Z","caller":"traceutil/trace.go:171","msg":"trace[1272472120] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1818; }","duration":"112.833744ms","start":"2026-05-12T11:25:15.315631Z","end":"2026-05-12T11:25:15.428465Z","steps":["trace[1272472120] 'agreement among raft nodes before linearized reading' (duration: 111.709444ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:27.157697Z","caller":"traceutil/trace.go:171","msg":"trace[571626142] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"182.633186ms","start":"2026-05-12T11:25:26.975046Z","end":"2026-05-12T11:25:27.157679Z","steps":["trace[571626142] 'process raft request' (duration: 182.362738ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:43.788859Z","caller":"traceutil/trace.go:171","msg":"trace[433297003] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"151.006058ms","start":"2026-05-12T11:25:43.637824Z","end":"2026-05-12T11:25:43.788831Z","steps":["trace[433297003] 'process raft request' (duration: 114.357716ms)","trace[433297003] 'compare' (duration: 36.528769ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:45.637812Z","caller":"traceutil/trace.go:171","msg":"trace[1762705391] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"190.879957ms","start":"2026-05-12T11:25:45.446904Z","end":"2026-05-12T11:25:45.637784Z","steps":["trace[1762705391] 'process raft request' (duration: 190.715923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.11343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.849683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:25:46.113521Z","caller":"traceutil/trace.go:171","msg":"trace[148156013] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"474.099471ms","start":"2026-05-12T11:25:45.639398Z","end":"2026-05-12T11:25:46.113497Z","steps":["trace[148156013] 'process raft request' (duration: 314.004811ms)","trace[148156013] 'compare' (duration: 159.75967ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:46.113649Z","caller":"traceutil/trace.go:171","msg":"trace[530460190] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"162.702471ms","start":"2026-05-12T11:25:45.950827Z","end":"2026-05-12T11:25:46.11353Z","steps":["trace[530460190] 'process raft request' (duration: 162.670011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.113673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:45.639376Z","time spent":"474.225243ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:25:46.113896Z","caller":"traceutil/trace.go:171","msg":"trace[457248033] linearizableReadLoop","detail":"{readStateIndex:2108; appliedIndex:2107; }","duration":"321.615984ms","start":"2026-05-12T11:25:45.792272Z","end":"2026-05-12T11:25:46.113888Z","steps":["trace[457248033] 'read index received' (duration: 161.143275ms)","trace[457248033] 'applied index is now lower than readState.Index' (duration: 160.472039ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:46.114272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.766462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-05-12T11:25:46.114304Z","caller":"traceutil/trace.go:171","msg":"trace[1757134752] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2035; }","duration":"120.827704ms","start":"2026-05-12T11:25:45.993468Z","end":"2026-05-12T11:25:46.114296Z","steps":["trace[1757134752] 'agreement among raft nodes before linearized reading' (duration: 120.735821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.11428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.001014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-12T11:25:46.114357Z","caller":"traceutil/trace.go:171","msg":"trace[123167010] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2035; }","duration":"322.130569ms","start":"2026-05-12T11:25:45.792206Z","end":"2026-05-12T11:25:46.114336Z","steps":["trace[123167010] 'agreement among raft nodes before linearized reading' (duration: 321.909712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.114408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:45.792182Z","time spent":"322.214451ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-12T11:25:46.11469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.493725ms","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-12T11:25:46.114714Z","caller":"traceutil/trace.go:171","msg":"trace[1150702125] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2035; }","duration":"260.544547ms","start":"2026-05-12T11:25:45.854165Z","end":"2026-05-12T11:25:46.114709Z","steps":["trace[1150702125] 'agreement among raft nodes before linearized reading' (duration: 259.999701ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:46.389385Z","caller":"traceutil/trace.go:171","msg":"trace[232591674] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"270.613228ms","start":"2026-05-12T11:25:46.118741Z","end":"2026-05-12T11:25:46.389354Z","steps":["trace[232591674] 'process raft request' (duration: 176.405541ms)","trace[232591674] 'compare' (duration: 94.018902ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:46.637492Z","caller":"traceutil/trace.go:171","msg":"trace[61889517] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"518.380584ms","start":"2026-05-12T11:25:46.119087Z","end":"2026-05-12T11:25:46.637468Z","steps":["trace[61889517] 'process raft request' (duration: 517.083599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.63766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.119077Z","time spent":"518.488117ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:25:46.637834Z","caller":"traceutil/trace.go:171","msg":"trace[1961078641] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"517.865058ms","start":"2026-05-12T11:25:46.119942Z","end":"2026-05-12T11:25:46.637807Z","steps":["trace[1961078641] 'process raft request' (duration: 517.473738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.637992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.119918Z","time spent":"517.995512ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:25:46.638224Z","caller":"traceutil/trace.go:171","msg":"trace[607197743] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"385.383374ms","start":"2026-05-12T11:25:46.252824Z","end":"2026-05-12T11:25:46.638207Z","steps":["trace[607197743] 'process raft request' (duration: 384.861399ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:46.63822Z","caller":"traceutil/trace.go:171","msg":"trace[1490974264] linearizableReadLoop","detail":"{readStateIndex:2112; appliedIndex:2109; }","duration":"511.995998ms","start":"2026-05-12T11:25:46.126189Z","end":"2026-05-12T11:25:46.638185Z","steps":["trace[1490974264] 'read index received' (duration: 168.966375ms)","trace[1490974264] 'applied index is now lower than readState.Index' (duration: 343.028263ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:46.638303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.252798Z","time spent":"385.467986ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:25:46.63864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.44337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.195\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-12T11:25:46.638686Z","caller":"traceutil/trace.go:171","msg":"trace[1639047515] range","detail":"{range_begin:/registry/masterleases/199.19.213.195; range_end:; response_count:1; response_revision:2039; }","duration":"512.509432ms","start":"2026-05-12T11:25:46.126164Z","end":"2026-05-12T11:25:46.638673Z","steps":["trace[1639047515] 'agreement among raft nodes before linearized reading' (duration: 512.318427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.638728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.126157Z","time spent":"512.564653ms","remote":"127.0.0.1:35780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.195\" "} {"level":"warn","ts":"2026-05-12T11:25:46.638895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.519458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-05-12T11:25:46.639089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.749997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-12T11:25:46.639138Z","caller":"traceutil/trace.go:171","msg":"trace[427918244] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2039; }","duration":"315.83093ms","start":"2026-05-12T11:25:46.323295Z","end":"2026-05-12T11:25:46.639126Z","steps":["trace[427918244] 'agreement among raft nodes before linearized reading' (duration: 315.717356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.639193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.323276Z","time spent":"315.905711ms","remote":"127.0.0.1:45014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-12T11:25:46.638962Z","caller":"traceutil/trace.go:171","msg":"trace[126601857] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2039; }","duration":"492.623392ms","start":"2026-05-12T11:25:46.146321Z","end":"2026-05-12T11:25:46.638945Z","steps":["trace[126601857] 'agreement among raft nodes before linearized reading' (duration: 492.305373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.639385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.146312Z","time spent":"493.062243ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":580,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-12T11:25:46.639481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.02426ms","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-12T11:25:46.639541Z","caller":"traceutil/trace.go:171","msg":"trace[959172790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2039; }","duration":"361.199945ms","start":"2026-05-12T11:25:46.278326Z","end":"2026-05-12T11:25:46.639526Z","steps":["trace[959172790] 'agreement among raft nodes before linearized reading' (duration: 360.790494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:46.639854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:46.278308Z","time spent":"361.453592ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T11:26:54.062333Z","caller":"traceutil/trace.go:171","msg":"trace[179594183] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"123.662676ms","start":"2026-05-12T11:26:53.938643Z","end":"2026-05-12T11:26:54.062306Z","steps":["trace[179594183] 'process raft request' (duration: 123.511062ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:26:54.859703Z","caller":"traceutil/trace.go:171","msg":"trace[1994660455] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"129.696688ms","start":"2026-05-12T11:26:54.72999Z","end":"2026-05-12T11:26:54.859686Z","steps":["trace[1994660455] 'process raft request' (duration: 129.601056ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:25.460163Z","caller":"traceutil/trace.go:171","msg":"trace[1330537134] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"410.919976ms","start":"2026-05-12T11:27:25.049218Z","end":"2026-05-12T11:27:25.460138Z","steps":["trace[1330537134] 'process raft request' (duration: 409.617298ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:25.46028Z","caller":"traceutil/trace.go:171","msg":"trace[308201971] linearizableReadLoop","detail":"{readStateIndex:2774; appliedIndex:2772; }","duration":"374.637849ms","start":"2026-05-12T11:27:25.085619Z","end":"2026-05-12T11:27:25.460257Z","steps":["trace[308201971] 'read index received' (duration: 42.94572ms)","trace[308201971] 'applied index is now lower than readState.Index' (duration: 331.691289ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:27:25.460403Z","caller":"traceutil/trace.go:171","msg":"trace[540178631] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"402.121293ms","start":"2026-05-12T11:27:25.05827Z","end":"2026-05-12T11:27:25.460391Z","steps":["trace[540178631] 'process raft request' (duration: 401.789063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:25.460516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:25.058256Z","time spent":"402.177114ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:27:25.460631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.133957ms","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-05-12T11:27:25.460713Z","caller":"traceutil/trace.go:171","msg":"trace[1990110758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2677; }","duration":"353.25407ms","start":"2026-05-12T11:27:25.107443Z","end":"2026-05-12T11:27:25.460697Z","steps":["trace[1990110758] 'agreement among raft nodes before linearized reading' (duration: 353.072215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:25.460756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:25.107427Z","time spent":"353.320973ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-12T11:27:25.460876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.608426ms","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-05-12T11:27:25.46092Z","caller":"traceutil/trace.go:171","msg":"trace[1719316377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2677; }","duration":"340.675808ms","start":"2026-05-12T11:27:25.120232Z","end":"2026-05-12T11:27:25.460908Z","steps":["trace[1719316377] 'agreement among raft nodes before linearized reading' (duration: 340.552545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:25.460954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.813159ms","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-12T11:27:25.460991Z","caller":"traceutil/trace.go:171","msg":"trace[378271164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2677; }","duration":"351.878171ms","start":"2026-05-12T11:27:25.109104Z","end":"2026-05-12T11:27:25.460982Z","steps":["trace[378271164] 'agreement among raft nodes before linearized reading' (duration: 351.793529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:25.460997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.37995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:27:25.461023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:25.10909Z","time spent":"351.928092ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-12T11:27:25.461027Z","caller":"traceutil/trace.go:171","msg":"trace[1759756384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2677; }","duration":"375.444372ms","start":"2026-05-12T11:27:25.085576Z","end":"2026-05-12T11:27:25.46102Z","steps":["trace[1759756384] 'agreement among raft nodes before linearized reading' (duration: 375.40053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:25.461052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:25.085558Z","time spent":"375.488852ms","remote":"127.0.0.1:35774","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-05-12T11:27:25.460957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:25.120218Z","time spent":"340.73253ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-12T11:27:25.461699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:25.049189Z","time spent":"411.111451ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:27:30.597867Z","caller":"traceutil/trace.go:171","msg":"trace[1904265625] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"101.118143ms","start":"2026-05-12T11:27:30.496716Z","end":"2026-05-12T11:27:30.597834Z","steps":["trace[1904265625] 'process raft request' (duration: 54.731502ms)","trace[1904265625] 'compare' (duration: 46.109652ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:27:30.829461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.927506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-12T11:27:30.829549Z","caller":"traceutil/trace.go:171","msg":"trace[222580883] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2705; }","duration":"129.079ms","start":"2026-05-12T11:27:30.700453Z","end":"2026-05-12T11:27:30.829532Z","steps":["trace[222580883] 'range keys from in-memory index tree' (duration: 128.782602ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:31.011268Z","caller":"traceutil/trace.go:171","msg":"trace[497328091] linearizableReadLoop","detail":"{readStateIndex:2804; appliedIndex:2803; }","duration":"133.781087ms","start":"2026-05-12T11:27:30.877465Z","end":"2026-05-12T11:27:31.011246Z","steps":["trace[497328091] 'read index received' (duration: 133.624412ms)","trace[497328091] 'applied index is now lower than readState.Index' (duration: 156.025µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:27:31.01145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.971163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:27:31.011508Z","caller":"traceutil/trace.go:171","msg":"trace[1368240108] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:2706; }","duration":"134.048635ms","start":"2026-05-12T11:27:30.877447Z","end":"2026-05-12T11:27:31.011495Z","steps":["trace[1368240108] 'agreement among raft nodes before linearized reading' (duration: 133.931821ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:31.011593Z","caller":"traceutil/trace.go:171","msg":"trace[923939359] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"176.903333ms","start":"2026-05-12T11:27:30.834669Z","end":"2026-05-12T11:27:31.011572Z","steps":["trace[923939359] 'process raft request' (duration: 176.470611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:04.995519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.308834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-12T11:31:04.995605Z","caller":"traceutil/trace.go:171","msg":"trace[401217988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4313; }","duration":"105.438287ms","start":"2026-05-12T11:31:04.890147Z","end":"2026-05-12T11:31:04.995586Z","steps":["trace[401217988] 'agreement among raft nodes before linearized reading' (duration: 105.211642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:07.376876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.300551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-12T11:31:07.377329Z","caller":"traceutil/trace.go:171","msg":"trace[554324698] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4439; }","duration":"124.432363ms","start":"2026-05-12T11:31:07.252501Z","end":"2026-05-12T11:31:07.376934Z","steps":["trace[554324698] 'range keys from in-memory index tree' (duration: 124.070356ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:13.95984Z","caller":"traceutil/trace.go:171","msg":"trace[1220093913] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"101.949714ms","start":"2026-05-12T11:31:13.857855Z","end":"2026-05-12T11:31:13.959805Z","steps":["trace[1220093913] 'process raft request' (duration: 101.701758ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:14.188129Z","caller":"traceutil/trace.go:171","msg":"trace[1432591420] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"156.165985ms","start":"2026-05-12T11:31:14.031925Z","end":"2026-05-12T11:31:14.188091Z","steps":["trace[1432591420] 'process raft request' (duration: 144.630207ms)","trace[1432591420] 'compare' (duration: 11.308413ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:31:14.188264Z","caller":"traceutil/trace.go:171","msg":"trace[1298767317] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"155.53226ms","start":"2026-05-12T11:31:14.032704Z","end":"2026-05-12T11:31:14.188236Z","steps":["trace[1298767317] 'process raft request' (duration: 155.286895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:19.535012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.03093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:31:19.535176Z","caller":"traceutil/trace.go:171","msg":"trace[1302699021] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:4625; }","duration":"122.323057ms","start":"2026-05-12T11:31:19.412826Z","end":"2026-05-12T11:31:19.535149Z","steps":["trace[1302699021] 'count revisions from in-memory index tree' (duration: 121.948248ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:20.112177Z","caller":"traceutil/trace.go:171","msg":"trace[400263692] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"108.908227ms","start":"2026-05-12T11:31:20.003239Z","end":"2026-05-12T11:31:20.112147Z","steps":["trace[400263692] 'process raft request' (duration: 108.759044ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:20.383273Z","caller":"traceutil/trace.go:171","msg":"trace[1165907371] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"104.162156ms","start":"2026-05-12T11:31:20.27909Z","end":"2026-05-12T11:31:20.383253Z","steps":["trace[1165907371] 'process raft request' (duration: 104.109975ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:20.383293Z","caller":"traceutil/trace.go:171","msg":"trace[1613919885] linearizableReadLoop","detail":"{readStateIndex:4805; appliedIndex:4803; }","duration":"300.731812ms","start":"2026-05-12T11:31:20.082535Z","end":"2026-05-12T11:31:20.383267Z","steps":["trace[1613919885] 'read index received' (duration: 29.549041ms)","trace[1613919885] 'applied index is now lower than readState.Index' (duration: 271.180231ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:31:20.383395Z","caller":"traceutil/trace.go:171","msg":"trace[1979552755] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"350.25574ms","start":"2026-05-12T11:31:20.03313Z","end":"2026-05-12T11:31:20.383386Z","steps":["trace[1979552755] 'process raft request' (duration: 317.627367ms)","trace[1979552755] 'compare' (duration: 32.280105ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:20.383468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:20.033108Z","time spent":"350.306052ms","remote":"127.0.0.1:35824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:31:20.383508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.454391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1579"} {"level":"info","ts":"2026-05-12T11:31:20.383542Z","caller":"traceutil/trace.go:171","msg":"trace[727195584] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4631; }","duration":"266.551522ms","start":"2026-05-12T11:31:20.116981Z","end":"2026-05-12T11:31:20.383533Z","steps":["trace[727195584] 'agreement among raft nodes before linearized reading' (duration: 266.423589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:20.383685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.010742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-12T11:31:20.383705Z","caller":"traceutil/trace.go:171","msg":"trace[1979187135] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4631; }","duration":"178.033123ms","start":"2026-05-12T11:31:20.205665Z","end":"2026-05-12T11:31:20.383698Z","steps":["trace[1979187135] 'agreement among raft nodes before linearized reading' (duration: 177.971982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:20.383744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.124976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1579"} {"level":"warn","ts":"2026-05-12T11:31:20.383758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.393093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-12T11:31:20.383767Z","caller":"traceutil/trace.go:171","msg":"trace[485056553] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4631; }","duration":"261.161467ms","start":"2026-05-12T11:31:20.122598Z","end":"2026-05-12T11:31:20.383759Z","steps":["trace[485056553] 'agreement among raft nodes before linearized reading' (duration: 261.089255ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:20.383793Z","caller":"traceutil/trace.go:171","msg":"trace[247585064] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4631; }","duration":"128.485364ms","start":"2026-05-12T11:31:20.255298Z","end":"2026-05-12T11:31:20.383783Z","steps":["trace[247585064] 'agreement among raft nodes before linearized reading' (duration: 128.329701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:20.383931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.399747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:31:20.383949Z","caller":"traceutil/trace.go:171","msg":"trace[777341198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4631; }","duration":"301.445699ms","start":"2026-05-12T11:31:20.082497Z","end":"2026-05-12T11:31:20.383943Z","steps":["trace[777341198] 'agreement among raft nodes before linearized reading' (duration: 301.413858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:20.383957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.209637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-05-12T11:31:20.383966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:20.08248Z","time spent":"301.481099ms","remote":"127.0.0.1:35774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-12T11:31:20.383978Z","caller":"traceutil/trace.go:171","msg":"trace[1568752489] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4631; }","duration":"119.249408ms","start":"2026-05-12T11:31:20.264721Z","end":"2026-05-12T11:31:20.383971Z","steps":["trace[1568752489] 'agreement among raft nodes before linearized reading' (duration: 119.190586ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:20.576581Z","caller":"traceutil/trace.go:171","msg":"trace[1491817095] linearizableReadLoop","detail":"{readStateIndex:4810; appliedIndex:4809; }","duration":"134.670639ms","start":"2026-05-12T11:31:20.441884Z","end":"2026-05-12T11:31:20.576555Z","steps":["trace[1491817095] 'read index received' (duration: 108.313412ms)","trace[1491817095] 'applied index is now lower than readState.Index' (duration: 26.356347ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:31:20.577011Z","caller":"traceutil/trace.go:171","msg":"trace[648058845] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"182.963428ms","start":"2026-05-12T11:31:20.394032Z","end":"2026-05-12T11:31:20.576995Z","steps":["trace[648058845] 'process raft request' (duration: 156.068809ms)","trace[648058845] 'compare' (duration: 26.311836ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:20.577372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.466087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-dbf76945-2bad-4179-801b-2c78d38e28b1\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-12T11:31:20.577578Z","caller":"traceutil/trace.go:171","msg":"trace[811138363] range","detail":"{range_begin:/registry/persistentvolumes/pvc-dbf76945-2bad-4179-801b-2c78d38e28b1; range_end:; response_count:1; response_revision:4635; }","duration":"135.60126ms","start":"2026-05-12T11:31:20.441841Z","end":"2026-05-12T11:31:20.577442Z","steps":["trace[811138363] 'agreement among raft nodes before linearized reading' (duration: 135.318594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:20.590808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.600617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:31:20.590919Z","caller":"traceutil/trace.go:171","msg":"trace[1703466922] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4636; }","duration":"137.726121ms","start":"2026-05-12T11:31:20.453142Z","end":"2026-05-12T11:31:20.590868Z","steps":["trace[1703466922] 'agreement among raft nodes before linearized reading' (duration: 137.565537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:32.805189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.232739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:31:32.805331Z","caller":"traceutil/trace.go:171","msg":"trace[1862835709] linearizableReadLoop","detail":"{readStateIndex:5034; appliedIndex:5033; }","duration":"360.151483ms","start":"2026-05-12T11:31:32.445142Z","end":"2026-05-12T11:31:32.805294Z","steps":["trace[1862835709] 'read index received' (duration: 150.673979ms)","trace[1862835709] 'applied index is now lower than readState.Index' (duration: 209.476504ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:32.805451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.306127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-12T11:31:32.805477Z","caller":"traceutil/trace.go:171","msg":"trace[1452338713] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4851; }","duration":"360.368598ms","start":"2026-05-12T11:31:32.4451Z","end":"2026-05-12T11:31:32.805469Z","steps":["trace[1452338713] 'agreement among raft nodes before linearized reading' (duration: 360.259985ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:32.805431Z","caller":"traceutil/trace.go:171","msg":"trace[1552051278] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"384.667464ms","start":"2026-05-12T11:31:32.420725Z","end":"2026-05-12T11:31:32.805392Z","steps":["trace[1552051278] 'process raft request' (duration: 175.164939ms)","trace[1552051278] 'compare' (duration: 209.126416ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:32.805502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:32.445087Z","time spent":"360.41027ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-05-12T11:31:32.805609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:32.4207Z","time spent":"384.819098ms","remote":"127.0.0.1:36024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:31:32.941684Z","caller":"traceutil/trace.go:171","msg":"trace[202898756] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"129.994291ms","start":"2026-05-12T11:31:32.811662Z","end":"2026-05-12T11:31:32.941656Z","steps":["trace[202898756] 'process raft request' (duration: 129.812466ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:32.947902Z","caller":"traceutil/trace.go:171","msg":"trace[2064451948] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"131.457145ms","start":"2026-05-12T11:31:32.816421Z","end":"2026-05-12T11:31:32.947878Z","steps":["trace[2064451948] 'process raft request' (duration: 131.380014ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:32:07.958316Z","caller":"traceutil/trace.go:171","msg":"trace[142550084] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"101.122173ms","start":"2026-05-12T11:32:07.857163Z","end":"2026-05-12T11:32:07.958285Z","steps":["trace[142550084] 'read index received' (duration: 14.932315ms)","trace[142550084] 'applied index is now lower than readState.Index' (duration: 86.188818ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:32:07.958466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.283406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:32:07.958503Z","caller":"traceutil/trace.go:171","msg":"trace[39031349] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5177; }","duration":"101.367839ms","start":"2026-05-12T11:32:07.857126Z","end":"2026-05-12T11:32:07.958494Z","steps":["trace[39031349] 'agreement among raft nodes before linearized reading' (duration: 101.253746ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:32:07.958546Z","caller":"traceutil/trace.go:171","msg":"trace[1129238750] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"161.332025ms","start":"2026-05-12T11:32:07.797187Z","end":"2026-05-12T11:32:07.958519Z","steps":["trace[1129238750] 'process raft request' (duration: 74.964663ms)","trace[1129238750] 'compare' (duration: 85.8352ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:33:03.3078Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-05-12T11:33:03.409913Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"100.570145ms","hash":4058684581,"current-db-size-bytes":53125120,"current-db-size":"53 MB","current-db-size-in-use-bytes":29241344,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-12T11:33:03.409989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4058684581,"revision":2878,"compact-revision":-1} {"level":"info","ts":"2026-05-12T11:35:08.490731Z","caller":"traceutil/trace.go:171","msg":"trace[256047959] transaction","detail":"{read_only:false; response_revision:6431; number_of_response:1; }","duration":"106.854117ms","start":"2026-05-12T11:35:08.383848Z","end":"2026-05-12T11:35:08.490702Z","steps":["trace[256047959] 'process raft request' (duration: 106.699443ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:38:03.314036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5597} {"level":"info","ts":"2026-05-12T11:38:03.385754Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5597,"took":"70.468338ms","hash":151287489,"current-db-size-bytes":53125120,"current-db-size":"53 MB","current-db-size-in-use-bytes":18235392,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-12T11:38:03.38581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":151287489,"revision":5597,"compact-revision":2878}