{"level":"warn","ts":"2026-10-13T14:59:31.926237Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T14:59:31.92637Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.191:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.191:2380","--initial-cluster=instance=https://199.204.45.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.191:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-13T14:59:31.926452Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T14:59:31.926468Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.191:2380"]} {"level":"info","ts":"2026-10-13T14:59:31.926568Z","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-10-13T14:59:31.927471Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.191:2379"]} {"level":"info","ts":"2026-10-13T14:59:31.927571Z","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.191:2380"],"listen-peer-urls":["https://199.204.45.191:2380"],"advertise-client-urls":["https://199.204.45.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.191:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-13T14:59:31.931636Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.767587ms"} {"level":"info","ts":"2026-10-13T14:59:31.938375Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"83a9604c9968587e","cluster-id":"f613939668f64c12"} {"level":"info","ts":"2026-10-13T14:59:31.938439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T14:59:31.938459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e became follower at term 0"} {"level":"info","ts":"2026-10-13T14:59:31.938467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 83a9604c9968587e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T14:59:31.938475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e became follower at term 1"} {"level":"info","ts":"2026-10-13T14:59:31.938518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e switched to configuration voters=(9487219972140193918)"} {"level":"warn","ts":"2026-10-13T14:59:31.951284Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T14:59:31.952922Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T14:59:31.954286Z","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-10-13T14:59:31.957451Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"83a9604c9968587e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T14:59:31.95789Z","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-10-13T14:59:31.957976Z","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-10-13T14:59:31.957993Z","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-10-13T14:59:31.958603Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"83a9604c9968587e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T14:59:31.959567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e switched to configuration voters=(9487219972140193918)"} {"level":"info","ts":"2026-10-13T14:59:31.95974Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f613939668f64c12","local-member-id":"83a9604c9968587e","added-peer-id":"83a9604c9968587e","added-peer-peer-urls":["https://199.204.45.191:2380"]} {"level":"info","ts":"2026-10-13T14:59:31.961814Z","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-10-13T14:59:31.962027Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"83a9604c9968587e","initial-advertise-peer-urls":["https://199.204.45.191:2380"],"listen-peer-urls":["https://199.204.45.191:2380"],"advertise-client-urls":["https://199.204.45.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T14:59:31.962062Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T14:59:31.96265Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.191:2380"} {"level":"info","ts":"2026-10-13T14:59:31.962697Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.191:2380"} {"level":"info","ts":"2026-10-13T14:59:32.739441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T14:59:32.739538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T14:59:32.739567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e received MsgPreVoteResp from 83a9604c9968587e at term 1"} {"level":"info","ts":"2026-10-13T14:59:32.739587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e became candidate at term 2"} {"level":"info","ts":"2026-10-13T14:59:32.739597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e received MsgVoteResp from 83a9604c9968587e at term 2"} {"level":"info","ts":"2026-10-13T14:59:32.739677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83a9604c9968587e became leader at term 2"} {"level":"info","ts":"2026-10-13T14:59:32.739693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 83a9604c9968587e elected leader 83a9604c9968587e at term 2"} {"level":"info","ts":"2026-10-13T14:59:32.748355Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T14:59:32.748811Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"83a9604c9968587e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.191:2379]}","request-path":"/0/members/83a9604c9968587e/attributes","cluster-id":"f613939668f64c12","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T14:59:32.748775Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T14:59:32.748794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T14:59:32.749192Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T14:59:32.749284Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T14:59:32.753317Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T14:59:32.753632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.191:2379"} {"level":"info","ts":"2026-10-13T14:59:32.760895Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f613939668f64c12","local-member-id":"83a9604c9968587e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T14:59:32.76105Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T14:59:32.761118Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T14:59:35.589409Z","caller":"traceutil/trace.go:171","msg":"trace[1935910763] transaction","detail":"{read_only:false; response_revision:131; number_of_response:1; }","duration":"127.711516ms","start":"2026-10-13T14:59:35.461654Z","end":"2026-10-13T14:59:35.589366Z","steps":["trace[1935910763] 'process raft request' (duration: 61.736486ms)","trace[1935910763] 'compare' (duration: 65.799637ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T14:59:41.051296Z","caller":"traceutil/trace.go:171","msg":"trace[483483092] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"107.91992ms","start":"2026-10-13T14:59:40.943348Z","end":"2026-10-13T14:59:41.051268Z","steps":["trace[483483092] 'process raft request' (duration: 107.699626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T14:59:41.415903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.681443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T14:59:41.416087Z","caller":"traceutil/trace.go:171","msg":"trace[1195424449] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"321.523411ms","start":"2026-10-13T14:59:41.094534Z","end":"2026-10-13T14:59:41.416057Z","steps":["trace[1195424449] 'process raft request' (duration: 175.802441ms)","trace[1195424449] 'compare' (duration: 144.488119ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T14:59:41.416235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T14:59:41.094479Z","time spent":"321.664384ms","remote":"127.0.0.1:34494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T14:59:41.765784Z","caller":"traceutil/trace.go:171","msg":"trace[1785528525] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:336; }","duration":"138.18311ms","start":"2026-10-13T14:59:41.627562Z","end":"2026-10-13T14:59:41.765745Z","steps":["trace[1785528525] 'read index received' (duration: 137.859904ms)","trace[1785528525] 'applied index is now lower than readState.Index' (duration: 321.796µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T14:59:41.76602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.431215ms","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-10-13T14:59:41.766064Z","caller":"traceutil/trace.go:171","msg":"trace[2073826333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:327; }","duration":"138.544986ms","start":"2026-10-13T14:59:41.627508Z","end":"2026-10-13T14:59:41.766053Z","steps":["trace[2073826333] 'agreement among raft nodes before linearized reading' (duration: 138.382003ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T14:59:41.766072Z","caller":"traceutil/trace.go:171","msg":"trace[380282586] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"339.228588ms","start":"2026-10-13T14:59:41.426807Z","end":"2026-10-13T14:59:41.766035Z","steps":["trace[380282586] 'process raft request' (duration: 338.711829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T14:59:41.766181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T14:59:41.42678Z","time spent":"339.34301ms","remote":"127.0.0.1:34494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":184,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.008535Z","caller":"traceutil/trace.go:171","msg":"trace[2095120866] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"160.771437ms","start":"2026-10-13T15:00:17.84774Z","end":"2026-10-13T15:00:18.008511Z","steps":["trace[2095120866] 'process raft request' (duration: 160.602805ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.270054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.438739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T15:00:18.270657Z","caller":"traceutil/trace.go:171","msg":"trace[1999172510] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"376.165902ms","start":"2026-10-13T15:00:17.894432Z","end":"2026-10-13T15:00:18.270598Z","steps":["trace[1999172510] 'process raft request' (duration: 375.806997ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.270697Z","caller":"traceutil/trace.go:171","msg":"trace[269985730] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"381.846884ms","start":"2026-10-13T15:00:17.888821Z","end":"2026-10-13T15:00:18.270668Z","steps":["trace[269985730] 'process raft request' (duration: 381.346016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.270793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.888801Z","time spent":"381.952786ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T15:00:18.270866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.894419Z","time spent":"376.330645ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.27071Z","caller":"traceutil/trace.go:171","msg":"trace[955506125] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"399.588328ms","start":"2026-10-13T15:00:17.871104Z","end":"2026-10-13T15:00:18.270692Z","steps":["trace[955506125] 'process raft request' (duration: 211.185613ms)","trace[955506125] 'compare' (duration: 187.295997ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:00:18.27096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.87108Z","time spent":"399.857373ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.271044Z","caller":"traceutil/trace.go:171","msg":"trace[1717505452] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"375.556532ms","start":"2026-10-13T15:00:17.895478Z","end":"2026-10-13T15:00:18.271035Z","steps":["trace[1717505452] 'process raft request' (duration: 374.841681ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.271063Z","caller":"traceutil/trace.go:171","msg":"trace[1644873926] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"373.333068ms","start":"2026-10-13T15:00:17.89772Z","end":"2026-10-13T15:00:18.271053Z","steps":["trace[1644873926] 'process raft request' (duration: 372.650827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.271086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.895472Z","time spent":"375.594714ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T15:00:18.271124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.897713Z","time spent":"373.378018ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.271162Z","caller":"traceutil/trace.go:171","msg":"trace[174744586] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"376.66786ms","start":"2026-10-13T15:00:17.894484Z","end":"2026-10-13T15:00:18.271152Z","steps":["trace[174744586] 'process raft request' (duration: 375.796536ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.271219Z","caller":"traceutil/trace.go:171","msg":"trace[1379772788] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"371.506688ms","start":"2026-10-13T15:00:17.899705Z","end":"2026-10-13T15:00:18.271212Z","steps":["trace[1379772788] 'process raft request' (duration: 370.729646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.271215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.89448Z","time spent":"376.707131ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T15:00:18.271263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.899699Z","time spent":"371.543219ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.271483Z","caller":"traceutil/trace.go:171","msg":"trace[922479004] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"359.971953ms","start":"2026-10-13T15:00:17.9115Z","end":"2026-10-13T15:00:18.271471Z","steps":["trace[922479004] 'process raft request' (duration: 358.983218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.271546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.911487Z","time spent":"360.030064ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.271693Z","caller":"traceutil/trace.go:171","msg":"trace[794598038] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:558; }","duration":"290.281056ms","start":"2026-10-13T15:00:17.9814Z","end":"2026-10-13T15:00:18.271681Z","steps":["trace[794598038] 'read index received' (duration: 27.767495ms)","trace[794598038] 'applied index is now lower than readState.Index' (duration: 262.512711ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:00:18.271732Z","caller":"traceutil/trace.go:171","msg":"trace[1538439523] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"357.061856ms","start":"2026-10-13T15:00:17.914657Z","end":"2026-10-13T15:00:18.271719Z","steps":["trace[1538439523] 'process raft request' (duration: 355.915938ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.271761Z","caller":"traceutil/trace.go:171","msg":"trace[1524739667] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"342.491053ms","start":"2026-10-13T15:00:17.929263Z","end":"2026-10-13T15:00:18.271754Z","steps":["trace[1524739667] 'process raft request' (duration: 342.350321ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.271778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.914644Z","time spent":"357.111497ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T15:00:18.271805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:17.929242Z","time spent":"342.535503ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T15:00:18.271984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.595211ms","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-10-13T15:00:18.272011Z","caller":"traceutil/trace.go:171","msg":"trace[1297322878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"290.653332ms","start":"2026-10-13T15:00:17.981348Z","end":"2026-10-13T15:00:18.272002Z","steps":["trace[1297322878] 'agreement among raft nodes before linearized reading' (duration: 290.50249ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.58348Z","caller":"traceutil/trace.go:171","msg":"trace[1001593387] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"567.96639ms","start":"2026-10-13T15:00:18.015469Z","end":"2026-10-13T15:00:18.583435Z","steps":["trace[1001593387] 'process raft request' (duration: 490.892147ms)","trace[1001593387] 'compare' (duration: 76.773398ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:00:18.583549Z","caller":"traceutil/trace.go:171","msg":"trace[1854229581] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"566.028378ms","start":"2026-10-13T15:00:18.017491Z","end":"2026-10-13T15:00:18.583519Z","steps":["trace[1854229581] 'process raft request' (duration: 565.849365ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.583658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.015442Z","time spent":"568.132902ms","remote":"127.0.0.1:34786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.583849Z","caller":"traceutil/trace.go:171","msg":"trace[269827862] transaction","detail":"{read_only:false; number_of_response:1; response_revision:551; }","duration":"565.654073ms","start":"2026-10-13T15:00:18.018153Z","end":"2026-10-13T15:00:18.583807Z","steps":["trace[269827862] 'process raft request' (duration: 565.323948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.583987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.017484Z","time spent":"566.14512ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T15:00:18.584034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.018148Z","time spent":"565.780645ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6938,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T15:00:18.584171Z","caller":"traceutil/trace.go:171","msg":"trace[1006633793] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:568; }","duration":"312.43054ms","start":"2026-10-13T15:00:18.271724Z","end":"2026-10-13T15:00:18.584154Z","steps":["trace[1006633793] 'read index received' (duration: 233.457357ms)","trace[1006633793] 'applied index is now lower than readState.Index' (duration: 78.971913ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:00:18.584197Z","caller":"traceutil/trace.go:171","msg":"trace[2078991015] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"540.646512ms","start":"2026-10-13T15:00:18.043539Z","end":"2026-10-13T15:00:18.584186Z","steps":["trace[2078991015] 'process raft request' (duration: 540.295366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.584242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.043514Z","time spent":"540.706913ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.584426Z","caller":"traceutil/trace.go:171","msg":"trace[520052614] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"302.776035ms","start":"2026-10-13T15:00:18.28163Z","end":"2026-10-13T15:00:18.584406Z","steps":["trace[520052614] 'process raft request' (duration: 302.41942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.584468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.578203ms","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-10-13T15:00:18.584509Z","caller":"traceutil/trace.go:171","msg":"trace[1889115699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"537.677815ms","start":"2026-10-13T15:00:18.046821Z","end":"2026-10-13T15:00:18.584499Z","steps":["trace[1889115699] 'agreement among raft nodes before linearized reading' (duration: 537.432021ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.584519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.281603Z","time spent":"302.865996ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T15:00:18.584538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.046794Z","time spent":"537.736635ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-13T15:00:18.584634Z","caller":"traceutil/trace.go:171","msg":"trace[5881294] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"294.406692ms","start":"2026-10-13T15:00:18.290212Z","end":"2026-10-13T15:00:18.584619Z","steps":["trace[5881294] 'process raft request' (duration: 294.225729ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.584637Z","caller":"traceutil/trace.go:171","msg":"trace[1841850952] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"300.818574ms","start":"2026-10-13T15:00:18.283779Z","end":"2026-10-13T15:00:18.584598Z","steps":["trace[1841850952] 'process raft request' (duration: 300.337426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.584798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:18.283747Z","time spent":"300.970616ms","remote":"127.0.0.1:34786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T15:00:18.584808Z","caller":"traceutil/trace.go:171","msg":"trace[1219998769] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"291.81285ms","start":"2026-10-13T15:00:18.292981Z","end":"2026-10-13T15:00:18.584794Z","steps":["trace[1219998769] 'process raft request' (duration: 291.508065ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.584864Z","caller":"traceutil/trace.go:171","msg":"trace[1359583344] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"281.886412ms","start":"2026-10-13T15:00:18.302966Z","end":"2026-10-13T15:00:18.584852Z","steps":["trace[1359583344] 'process raft request' (duration: 281.581007ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.584871Z","caller":"traceutil/trace.go:171","msg":"trace[1537293289] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"294.90868ms","start":"2026-10-13T15:00:18.289948Z","end":"2026-10-13T15:00:18.584857Z","steps":["trace[1537293289] 'process raft request' (duration: 294.382811ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.584972Z","caller":"traceutil/trace.go:171","msg":"trace[1417360056] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"278.73242ms","start":"2026-10-13T15:00:18.306229Z","end":"2026-10-13T15:00:18.584962Z","steps":["trace[1417360056] 'process raft request' (duration: 278.451666ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.585044Z","caller":"traceutil/trace.go:171","msg":"trace[1189326086] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"273.780922ms","start":"2026-10-13T15:00:18.311249Z","end":"2026-10-13T15:00:18.58503Z","steps":["trace[1189326086] 'process raft request' (duration: 273.518447ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:18.585162Z","caller":"traceutil/trace.go:171","msg":"trace[1082976957] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"259.105076ms","start":"2026-10-13T15:00:18.326047Z","end":"2026-10-13T15:00:18.585152Z","steps":["trace[1082976957] 'process raft request' (duration: 258.885573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:18.5852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.074519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T15:00:18.585452Z","caller":"traceutil/trace.go:171","msg":"trace[1871128905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"118.472946ms","start":"2026-10-13T15:00:18.466949Z","end":"2026-10-13T15:00:18.585421Z","steps":["trace[1871128905] 'agreement among raft nodes before linearized reading' (duration: 118.075579ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:00:25.281953Z","caller":"traceutil/trace.go:171","msg":"trace[1288260198] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"109.421702ms","start":"2026-10-13T15:00:25.172501Z","end":"2026-10-13T15:00:25.281923Z","steps":["trace[1288260198] 'process raft request' (duration: 109.269319ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:26.061039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.732931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T15:00:26.061358Z","caller":"traceutil/trace.go:171","msg":"trace[930009046] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"536.828088ms","start":"2026-10-13T15:00:25.524473Z","end":"2026-10-13T15:00:26.061301Z","steps":["trace[930009046] 'process raft request' (duration: 367.684071ms)","trace[930009046] 'compare' (duration: 168.498617ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:00:26.061456Z","caller":"traceutil/trace.go:171","msg":"trace[1187206558] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:666; }","duration":"325.200038ms","start":"2026-10-13T15:00:25.736241Z","end":"2026-10-13T15:00:26.061441Z","steps":["trace[1187206558] 'read index received' (duration: 155.906908ms)","trace[1187206558] 'applied index is now lower than readState.Index' (duration: 169.29184ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:00:26.06147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:25.524443Z","time spent":"536.97606ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T15:00:26.061509Z","caller":"traceutil/trace.go:171","msg":"trace[1049640615] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"512.373091ms","start":"2026-10-13T15:00:25.549111Z","end":"2026-10-13T15:00:26.061484Z","steps":["trace[1049640615] 'process raft request' (duration: 512.078187ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:26.061652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:25.549081Z","time spent":"512.504463ms","remote":"127.0.0.1:34612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T15:00:26.061642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.36032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T15:00:26.061765Z","caller":"traceutil/trace.go:171","msg":"trace[628736378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"325.542383ms","start":"2026-10-13T15:00:25.736187Z","end":"2026-10-13T15:00:26.06173Z","steps":["trace[628736378] 'agreement among raft nodes before linearized reading' (duration: 325.31792ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:00:26.061836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:00:25.736163Z","time spent":"325.657936ms","remote":"127.0.0.1:34276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-13T15:00:41.797058Z","caller":"traceutil/trace.go:171","msg":"trace[776719780] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"126.106235ms","start":"2026-10-13T15:00:41.670917Z","end":"2026-10-13T15:00:41.797023Z","steps":["trace[776719780] 'process raft request' (duration: 125.76064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:01:13.899525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.194519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-13T15:01:13.899641Z","caller":"traceutil/trace.go:171","msg":"trace[977766619] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1225; }","duration":"116.380072ms","start":"2026-10-13T15:01:13.783239Z","end":"2026-10-13T15:01:13.899619Z","steps":["trace[977766619] 'count revisions from in-memory index tree' (duration: 116.075388ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:01:13.899692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.999874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T15:01:13.8998Z","caller":"traceutil/trace.go:171","msg":"trace[655850762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1225; }","duration":"163.180327ms","start":"2026-10-13T15:01:13.736594Z","end":"2026-10-13T15:01:13.899774Z","steps":["trace[655850762] 'range keys from in-memory index tree' (duration: 162.851311ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:01:14.576015Z","caller":"traceutil/trace.go:171","msg":"trace[14994093] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"127.954185ms","start":"2026-10-13T15:01:14.448034Z","end":"2026-10-13T15:01:14.575988Z","steps":["trace[14994093] 'process raft request' (duration: 127.762862ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:01:44.67313Z","caller":"traceutil/trace.go:171","msg":"trace[1267861257] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"101.713597ms","start":"2026-10-13T15:01:44.571372Z","end":"2026-10-13T15:01:44.673085Z","steps":["trace[1267861257] 'process raft request' (duration: 43.263634ms)","trace[1267861257] 'compare' (duration: 58.233956ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:02:03.818026Z","caller":"traceutil/trace.go:171","msg":"trace[2055431508] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1949; }","duration":"125.193482ms","start":"2026-10-13T15:02:03.692788Z","end":"2026-10-13T15:02:03.817982Z","steps":["trace[2055431508] 'read index received' (duration: 124.823049ms)","trace[2055431508] 'applied index is now lower than readState.Index' (duration: 369.083µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:02:03.818164Z","caller":"traceutil/trace.go:171","msg":"trace[1900377351] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"130.039123ms","start":"2026-10-13T15:02:03.688059Z","end":"2026-10-13T15:02:03.818098Z","steps":["trace[1900377351] 'process raft request' (duration: 129.681371ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:02:03.818641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.826752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd5de33f-f1c0-4d3b-862e-5a5b765af9af\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-13T15:02:03.818757Z","caller":"traceutil/trace.go:171","msg":"trace[737387524] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd5de33f-f1c0-4d3b-862e-5a5b765af9af; range_end:; response_count:1; response_revision:1892; }","duration":"126.012749ms","start":"2026-10-13T15:02:03.692721Z","end":"2026-10-13T15:02:03.818734Z","steps":["trace[737387524] 'agreement among raft nodes before linearized reading' (duration: 125.649957ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:02:04.16009Z","caller":"traceutil/trace.go:171","msg":"trace[1185036060] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"333.66431ms","start":"2026-10-13T15:02:03.826389Z","end":"2026-10-13T15:02:04.160053Z","steps":["trace[1185036060] 'process raft request' (duration: 333.392341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:02:04.160306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:02:03.826356Z","time spent":"333.836816ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T15:02:04.220761Z","caller":"traceutil/trace.go:171","msg":"trace[827966422] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1950; }","duration":"352.69856ms","start":"2026-10-13T15:02:03.868035Z","end":"2026-10-13T15:02:04.220734Z","steps":["trace[827966422] 'read index received' (duration: 291.83313ms)","trace[827966422] 'applied index is now lower than readState.Index' (duration: 60.86449ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:02:04.220967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.324196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T15:02:04.221011Z","caller":"traceutil/trace.go:171","msg":"trace[1826036482] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1894; }","duration":"254.445591ms","start":"2026-10-13T15:02:03.966553Z","end":"2026-10-13T15:02:04.220998Z","steps":["trace[1826036482] 'agreement among raft nodes before linearized reading' (duration: 254.309936ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:02:04.221131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.055891ms","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-10-13T15:02:04.221248Z","caller":"traceutil/trace.go:171","msg":"trace[371125713] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1894; }","duration":"353.252118ms","start":"2026-10-13T15:02:03.867967Z","end":"2026-10-13T15:02:04.221219Z","steps":["trace[371125713] 'agreement among raft nodes before linearized reading' (duration: 352.897966ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:02:04.221294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:02:03.867938Z","time spent":"353.346281ms","remote":"127.0.0.1:56372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4615,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-13T15:02:04.221452Z","caller":"traceutil/trace.go:171","msg":"trace[1196694125] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"393.33203ms","start":"2026-10-13T15:02:03.827485Z","end":"2026-10-13T15:02:04.220817Z","steps":["trace[1196694125] 'process raft request' (duration: 393.105822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:02:04.221665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:02:03.827476Z","time spent":"394.074834ms","remote":"127.0.0.1:34482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T15:02:13.026182Z","caller":"traceutil/trace.go:171","msg":"trace[1022992303] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"191.142569ms","start":"2026-10-13T15:02:12.835009Z","end":"2026-10-13T15:02:13.026151Z","steps":["trace[1022992303] 'process raft request' (duration: 190.88659ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:02:36.995595Z","caller":"traceutil/trace.go:171","msg":"trace[1438063673] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"261.152141ms","start":"2026-10-13T15:02:36.734418Z","end":"2026-10-13T15:02:36.99557Z","steps":["trace[1438063673] 'read index received' (duration: 260.936794ms)","trace[1438063673] 'applied index is now lower than readState.Index' (duration: 214.377µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:02:36.995854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.423849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T15:02:36.995828Z","caller":"traceutil/trace.go:171","msg":"trace[530687836] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"354.170912ms","start":"2026-10-13T15:02:36.641568Z","end":"2026-10-13T15:02:36.995739Z","steps":["trace[530687836] 'process raft request' (duration: 353.849582ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:02:36.996162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:02:36.641536Z","time spent":"354.45638ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T15:02:36.9962Z","caller":"traceutil/trace.go:171","msg":"trace[845985612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2166; }","duration":"261.844421ms","start":"2026-10-13T15:02:36.734339Z","end":"2026-10-13T15:02:36.996183Z","steps":["trace[845985612] 'agreement among raft nodes before linearized reading' (duration: 261.332826ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:02:37.305968Z","caller":"traceutil/trace.go:171","msg":"trace[861115623] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"109.638273ms","start":"2026-10-13T15:02:37.196299Z","end":"2026-10-13T15:02:37.305938Z","steps":["trace[861115623] 'process raft request' (duration: 109.456948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:03:41.628169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.585153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T15:03:41.62828Z","caller":"traceutil/trace.go:171","msg":"trace[1006401938] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2702; }","duration":"156.750237ms","start":"2026-10-13T15:03:41.471504Z","end":"2026-10-13T15:03:41.628254Z","steps":["trace[1006401938] 'count revisions from in-memory index tree' (duration: 156.482191ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:04:13.67396Z","caller":"traceutil/trace.go:171","msg":"trace[536983594] transaction","detail":"{read_only:false; response_revision:2924; number_of_response:1; }","duration":"105.391366ms","start":"2026-10-13T15:04:13.568529Z","end":"2026-10-13T15:04:13.673921Z","steps":["trace[536983594] 'process raft request' (duration: 40.73377ms)","trace[536983594] 'compare' (duration: 64.431481ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:06:45.523482Z","caller":"traceutil/trace.go:171","msg":"trace[2046760254] linearizableReadLoop","detail":"{readStateIndex:4839; appliedIndex:4838; }","duration":"116.195877ms","start":"2026-10-13T15:06:45.407263Z","end":"2026-10-13T15:06:45.523459Z","steps":["trace[2046760254] 'read index received' (duration: 115.982773ms)","trace[2046760254] 'applied index is now lower than readState.Index' (duration: 212.334µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:06:45.523549Z","caller":"traceutil/trace.go:171","msg":"trace[758596215] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"126.950197ms","start":"2026-10-13T15:06:45.396568Z","end":"2026-10-13T15:06:45.523519Z","steps":["trace[758596215] 'process raft request' (duration: 126.741893ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:06:45.523724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.422001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-10-13T15:06:45.52376Z","caller":"traceutil/trace.go:171","msg":"trace[1938615576] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4641; }","duration":"116.528963ms","start":"2026-10-13T15:06:45.40722Z","end":"2026-10-13T15:06:45.523749Z","steps":["trace[1938615576] 'agreement among raft nodes before linearized reading' (duration: 116.36247ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:06:45.701569Z","caller":"traceutil/trace.go:171","msg":"trace[1637154599] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"101.512503ms","start":"2026-10-13T15:06:45.600038Z","end":"2026-10-13T15:06:45.701551Z","steps":["trace[1637154599] 'process raft request' (duration: 101.415681ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:06:45.710866Z","caller":"traceutil/trace.go:171","msg":"trace[390459601] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"106.521857ms","start":"2026-10-13T15:06:45.604324Z","end":"2026-10-13T15:06:45.710846Z","steps":["trace[390459601] 'process raft request' (duration: 106.101029ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:06:51.175197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.751138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T15:06:51.175485Z","caller":"traceutil/trace.go:171","msg":"trace[428503174] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"175.286464ms","start":"2026-10-13T15:06:51.000183Z","end":"2026-10-13T15:06:51.175469Z","steps":["trace[428503174] 'process raft request' (duration: 17.159098ms)","trace[428503174] 'compare' (duration: 157.612876ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:06:51.175297Z","caller":"traceutil/trace.go:171","msg":"trace[208571348] linearizableReadLoop","detail":"{readStateIndex:4961; appliedIndex:4960; }","duration":"161.778923ms","start":"2026-10-13T15:06:51.013502Z","end":"2026-10-13T15:06:51.175281Z","steps":["trace[208571348] 'read index received' (duration: 3.829671ms)","trace[208571348] 'applied index is now lower than readState.Index' (duration: 157.948222ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:06:51.175724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.17389ms","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-10-13T15:06:51.175796Z","caller":"traceutil/trace.go:171","msg":"trace[124248556] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4760; }","duration":"162.306753ms","start":"2026-10-13T15:06:51.013447Z","end":"2026-10-13T15:06:51.175754Z","steps":["trace[124248556] 'agreement among raft nodes before linearized reading' (duration: 162.102549ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:06:51.425654Z","caller":"traceutil/trace.go:171","msg":"trace[991649153] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4961; }","duration":"243.970829ms","start":"2026-10-13T15:06:51.181664Z","end":"2026-10-13T15:06:51.425635Z","steps":["trace[991649153] 'read index received' (duration: 175.317285ms)","trace[991649153] 'applied index is now lower than readState.Index' (duration: 68.652684ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:06:51.425758Z","caller":"traceutil/trace.go:171","msg":"trace[156618278] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"245.345624ms","start":"2026-10-13T15:06:51.180368Z","end":"2026-10-13T15:06:51.425713Z","steps":["trace[156618278] 'process raft request' (duration: 176.68261ms)","trace[156618278] 'compare' (duration: 68.45902ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:06:51.425913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.225443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9952"} {"level":"info","ts":"2026-10-13T15:06:51.42625Z","caller":"traceutil/trace.go:171","msg":"trace[1170110341] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4761; }","duration":"244.58629ms","start":"2026-10-13T15:06:51.181642Z","end":"2026-10-13T15:06:51.426229Z","steps":["trace[1170110341] 'agreement among raft nodes before linearized reading' (duration: 244.137981ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:06:51.430629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.456285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0e8389fa-bcf2-4078-820e-4930ae791726\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-13T15:06:51.430722Z","caller":"traceutil/trace.go:171","msg":"trace[1461137478] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0e8389fa-bcf2-4078-820e-4930ae791726; range_end:; response_count:1; response_revision:4762; }","duration":"246.594587ms","start":"2026-10-13T15:06:51.18411Z","end":"2026-10-13T15:06:51.430704Z","steps":["trace[1461137478] 'agreement among raft nodes before linearized reading' (duration: 246.341652ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:06:51.431249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.369554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0e8389fa-bcf2-4078-820e-4930ae791726\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-13T15:06:51.431307Z","caller":"traceutil/trace.go:171","msg":"trace[444403010] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0e8389fa-bcf2-4078-820e-4930ae791726; range_end:; response_count:1; response_revision:4762; }","duration":"190.468965ms","start":"2026-10-13T15:06:51.240823Z","end":"2026-10-13T15:06:51.431292Z","steps":["trace[444403010] 'agreement among raft nodes before linearized reading' (duration: 190.303542ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:06:51.879348Z","caller":"traceutil/trace.go:171","msg":"trace[1051369960] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"271.752274ms","start":"2026-10-13T15:06:51.607565Z","end":"2026-10-13T15:06:51.879318Z","steps":["trace[1051369960] 'process raft request' (duration: 271.442468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:06:51.879535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.651926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T15:06:51.879715Z","caller":"traceutil/trace.go:171","msg":"trace[682010704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4766; }","duration":"143.888771ms","start":"2026-10-13T15:06:51.735805Z","end":"2026-10-13T15:06:51.879694Z","steps":["trace[682010704] 'agreement among raft nodes before linearized reading' (duration: 143.592995ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:06:51.879997Z","caller":"traceutil/trace.go:171","msg":"trace[560208524] linearizableReadLoop","detail":"{readStateIndex:4969; appliedIndex:4968; }","duration":"143.374801ms","start":"2026-10-13T15:06:51.735853Z","end":"2026-10-13T15:06:51.879228Z","steps":["trace[560208524] 'read index received' (duration: 142.990284ms)","trace[560208524] 'applied index is now lower than readState.Index' (duration: 380.027µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:06:55.412546Z","caller":"traceutil/trace.go:171","msg":"trace[1311229732] linearizableReadLoop","detail":"{readStateIndex:5029; appliedIndex:5028; }","duration":"141.111292ms","start":"2026-10-13T15:06:55.2714Z","end":"2026-10-13T15:06:55.412511Z","steps":["trace[1311229732] 'read index received' (duration: 140.921398ms)","trace[1311229732] 'applied index is now lower than readState.Index' (duration: 189.004µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:06:55.412793Z","caller":"traceutil/trace.go:171","msg":"trace[1184056855] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"182.869894ms","start":"2026-10-13T15:06:55.229875Z","end":"2026-10-13T15:06:55.412745Z","steps":["trace[1184056855] 'process raft request' (duration: 182.505097ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:06:55.413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.57658ms","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-10-13T15:06:55.413054Z","caller":"traceutil/trace.go:171","msg":"trace[1527096378] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4826; }","duration":"141.671562ms","start":"2026-10-13T15:06:55.271372Z","end":"2026-10-13T15:06:55.413044Z","steps":["trace[1527096378] 'agreement among raft nodes before linearized reading' (duration: 141.478608ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:04.811163Z","caller":"traceutil/trace.go:171","msg":"trace[227343405] linearizableReadLoop","detail":"{readStateIndex:5151; appliedIndex:5150; }","duration":"157.739001ms","start":"2026-10-13T15:07:04.653402Z","end":"2026-10-13T15:07:04.811141Z","steps":["trace[227343405] 'read index received' (duration: 157.526257ms)","trace[227343405] 'applied index is now lower than readState.Index' (duration: 211.864µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:07:04.811277Z","caller":"traceutil/trace.go:171","msg":"trace[1639781748] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"306.67876ms","start":"2026-10-13T15:07:04.504562Z","end":"2026-10-13T15:07:04.81124Z","steps":["trace[1639781748] 'process raft request' (duration: 306.440186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:04.811375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.78597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-10-13T15:07:04.811413Z","caller":"traceutil/trace.go:171","msg":"trace[1231287083] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4941; }","duration":"146.861031ms","start":"2026-10-13T15:07:04.664542Z","end":"2026-10-13T15:07:04.811403Z","steps":["trace[1231287083] 'agreement among raft nodes before linearized reading' (duration: 146.729539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:04.811433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:07:04.504535Z","time spent":"306.808733ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T15:07:04.811429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.971685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-10-13T15:07:04.811554Z","caller":"traceutil/trace.go:171","msg":"trace[2066956177] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4941; }","duration":"158.17726ms","start":"2026-10-13T15:07:04.653352Z","end":"2026-10-13T15:07:04.811529Z","steps":["trace[2066956177] 'agreement among raft nodes before linearized reading' (duration: 157.878324ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:04.811611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.814408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-13T15:07:04.811689Z","caller":"traceutil/trace.go:171","msg":"trace[1458734561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4941; }","duration":"141.961831ms","start":"2026-10-13T15:07:04.66971Z","end":"2026-10-13T15:07:04.811672Z","steps":["trace[1458734561] 'agreement among raft nodes before linearized reading' (duration: 141.704686ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.121185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.909626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-10-13T15:07:05.12127Z","caller":"traceutil/trace.go:171","msg":"trace[266621124] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4941; }","duration":"306.047848ms","start":"2026-10-13T15:07:04.815201Z","end":"2026-10-13T15:07:05.121249Z","steps":["trace[266621124] 'range keys from in-memory index tree' (duration: 305.711482ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.121313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:07:04.815179Z","time spent":"306.124969ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-13T15:07:05.121399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.495606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-10-13T15:07:05.12148Z","caller":"traceutil/trace.go:171","msg":"trace[1056808441] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4941; }","duration":"306.600798ms","start":"2026-10-13T15:07:04.814853Z","end":"2026-10-13T15:07:05.121453Z","steps":["trace[1056808441] 'range keys from in-memory index tree' (duration: 306.366113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.121517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:07:04.814842Z","time spent":"306.66604ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":592,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-10-13T15:07:05.12158Z","caller":"traceutil/trace.go:171","msg":"trace[1310599585] linearizableReadLoop","detail":"{readStateIndex:5152; appliedIndex:5151; }","duration":"204.549671ms","start":"2026-10-13T15:07:04.917008Z","end":"2026-10-13T15:07:05.121558Z","steps":["trace[1310599585] 'read index received' (duration: 165.697096ms)","trace[1310599585] 'applied index is now lower than readState.Index' (duration: 38.851565ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:07:05.121769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.766095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3198"} {"level":"info","ts":"2026-10-13T15:07:05.121799Z","caller":"traceutil/trace.go:171","msg":"trace[1561502619] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4942; }","duration":"204.842947ms","start":"2026-10-13T15:07:04.916943Z","end":"2026-10-13T15:07:05.121786Z","steps":["trace[1561502619] 'agreement among raft nodes before linearized reading' (duration: 204.749555ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:05.121807Z","caller":"traceutil/trace.go:171","msg":"trace[901803195] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"304.860066ms","start":"2026-10-13T15:07:04.816855Z","end":"2026-10-13T15:07:05.121715Z","steps":["trace[901803195] 'process raft request' (duration: 265.836679ms)","trace[901803195] 'compare' (duration: 38.550709ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:07:05.12199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T15:07:04.816835Z","time spent":"305.06493ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T15:07:05.122102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.238841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-13T15:07:05.12214Z","caller":"traceutil/trace.go:171","msg":"trace[2045499593] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4943; }","duration":"175.315313ms","start":"2026-10-13T15:07:04.946816Z","end":"2026-10-13T15:07:05.122131Z","steps":["trace[2045499593] 'agreement among raft nodes before linearized reading' (duration: 175.224701ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:05.121779Z","caller":"traceutil/trace.go:171","msg":"trace[1275527991] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"131.972246ms","start":"2026-10-13T15:07:04.989795Z","end":"2026-10-13T15:07:05.121767Z","steps":["trace[1275527991] 'process raft request' (duration: 131.703291ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.12242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.827881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-13T15:07:05.122455Z","caller":"traceutil/trace.go:171","msg":"trace[2012409411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4943; }","duration":"145.879592ms","start":"2026-10-13T15:07:04.976566Z","end":"2026-10-13T15:07:05.122446Z","steps":["trace[2012409411] 'agreement among raft nodes before linearized reading' (duration: 145.79084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.122891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.976406ms","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-10-13T15:07:05.122965Z","caller":"traceutil/trace.go:171","msg":"trace[889918483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4943; }","duration":"151.084757ms","start":"2026-10-13T15:07:04.971859Z","end":"2026-10-13T15:07:05.122943Z","steps":["trace[889918483] 'agreement among raft nodes before linearized reading' (duration: 150.895904ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:05.316334Z","caller":"traceutil/trace.go:171","msg":"trace[477659582] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"188.456844ms","start":"2026-10-13T15:07:05.127855Z","end":"2026-10-13T15:07:05.316312Z","steps":["trace[477659582] 'process raft request' (duration: 188.034546ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:05.317018Z","caller":"traceutil/trace.go:171","msg":"trace[1037057895] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"189.021755ms","start":"2026-10-13T15:07:05.127975Z","end":"2026-10-13T15:07:05.316997Z","steps":["trace[1037057895] 'process raft request' (duration: 188.054527ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:05.317151Z","caller":"traceutil/trace.go:171","msg":"trace[890920304] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"188.362462ms","start":"2026-10-13T15:07:05.128777Z","end":"2026-10-13T15:07:05.31714Z","steps":["trace[890920304] 'process raft request' (duration: 187.984415ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:05.317445Z","caller":"traceutil/trace.go:171","msg":"trace[1202386226] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5153; }","duration":"107.422515ms","start":"2026-10-13T15:07:05.21001Z","end":"2026-10-13T15:07:05.317432Z","steps":["trace[1202386226] 'read index received' (duration: 2.123979ms)","trace[1202386226] 'applied index is now lower than readState.Index' (duration: 105.297556ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:07:05.317498Z","caller":"traceutil/trace.go:171","msg":"trace[2139164160] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"188.642048ms","start":"2026-10-13T15:07:05.128847Z","end":"2026-10-13T15:07:05.317489Z","steps":["trace[2139164160] 'process raft request' (duration: 188.115438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.317675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.649609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3198"} {"level":"info","ts":"2026-10-13T15:07:05.318251Z","caller":"traceutil/trace.go:171","msg":"trace[657530861] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4948; }","duration":"108.27885ms","start":"2026-10-13T15:07:05.209956Z","end":"2026-10-13T15:07:05.318235Z","steps":["trace[657530861] 'agreement among raft nodes before linearized reading' (duration: 107.581848ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.31788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.403443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-10-13T15:07:05.318412Z","caller":"traceutil/trace.go:171","msg":"trace[1751448279] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4948; }","duration":"102.966533ms","start":"2026-10-13T15:07:05.215436Z","end":"2026-10-13T15:07:05.318403Z","steps":["trace[1751448279] 'agreement among raft nodes before linearized reading' (duration: 102.380832ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:05.553896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.648127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9761"} {"level":"info","ts":"2026-10-13T15:07:05.553964Z","caller":"traceutil/trace.go:171","msg":"trace[170562324] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4952; }","duration":"145.763849ms","start":"2026-10-13T15:07:05.408185Z","end":"2026-10-13T15:07:05.553949Z","steps":["trace[170562324] 'range keys from in-memory index tree' (duration: 145.521475ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:07.58397Z","caller":"traceutil/trace.go:171","msg":"trace[554864183] linearizableReadLoop","detail":"{readStateIndex:5193; appliedIndex:5191; }","duration":"231.287796ms","start":"2026-10-13T15:07:07.352663Z","end":"2026-10-13T15:07:07.58395Z","steps":["trace[554864183] 'read index received' (duration: 131.81497ms)","trace[554864183] 'applied index is now lower than readState.Index' (duration: 99.471746ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:07:07.584179Z","caller":"traceutil/trace.go:171","msg":"trace[1510802416] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"259.516224ms","start":"2026-10-13T15:07:07.324649Z","end":"2026-10-13T15:07:07.584165Z","steps":["trace[1510802416] 'process raft request' (duration: 159.813024ms)","trace[1510802416] 'compare' (duration: 99.194051ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:07:07.584435Z","caller":"traceutil/trace.go:171","msg":"trace[1808934076] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"259.746419ms","start":"2026-10-13T15:07:07.324678Z","end":"2026-10-13T15:07:07.584425Z","steps":["trace[1808934076] 'process raft request' (duration: 259.199729ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:07.584701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.021609ms","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-10-13T15:07:07.58474Z","caller":"traceutil/trace.go:171","msg":"trace[291528536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4981; }","duration":"232.184432ms","start":"2026-10-13T15:07:07.352546Z","end":"2026-10-13T15:07:07.58473Z","steps":["trace[291528536] 'agreement among raft nodes before linearized reading' (duration: 232.006389ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:07.585318Z","caller":"traceutil/trace.go:171","msg":"trace[641132313] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"221.487096ms","start":"2026-10-13T15:07:07.36382Z","end":"2026-10-13T15:07:07.585307Z","steps":["trace[641132313] 'process raft request' (duration: 221.427625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:07.5993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.243184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-10-13T15:07:07.599386Z","caller":"traceutil/trace.go:171","msg":"trace[1024156950] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4983; }","duration":"195.378087ms","start":"2026-10-13T15:07:07.40399Z","end":"2026-10-13T15:07:07.599368Z","steps":["trace[1024156950] 'agreement among raft nodes before linearized reading' (duration: 195.199913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:07.60014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.02917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10809"} {"level":"info","ts":"2026-10-13T15:07:07.600183Z","caller":"traceutil/trace.go:171","msg":"trace[1890803648] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4983; }","duration":"244.122341ms","start":"2026-10-13T15:07:07.356051Z","end":"2026-10-13T15:07:07.600173Z","steps":["trace[1890803648] 'agreement among raft nodes before linearized reading' (duration: 243.994929ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:07.599373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.039229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-10-13T15:07:07.600307Z","caller":"traceutil/trace.go:171","msg":"trace[997752120] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4983; }","duration":"227.002727ms","start":"2026-10-13T15:07:07.373256Z","end":"2026-10-13T15:07:07.600259Z","steps":["trace[997752120] 'agreement among raft nodes before linearized reading' (duration: 226.029989ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:07:07.600393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.627573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-10-13T15:07:07.60043Z","caller":"traceutil/trace.go:171","msg":"trace[321258520] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4983; }","duration":"230.695565ms","start":"2026-10-13T15:07:07.369726Z","end":"2026-10-13T15:07:07.600421Z","steps":["trace[321258520] 'agreement among raft nodes before linearized reading' (duration: 230.598333ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:07:51.597698Z","caller":"traceutil/trace.go:171","msg":"trace[1181193459] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"118.37236ms","start":"2026-10-13T15:07:51.479299Z","end":"2026-10-13T15:07:51.597672Z","steps":["trace[1181193459] 'process raft request' (duration: 118.101285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T15:08:05.468612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.192001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-13T15:08:05.46872Z","caller":"traceutil/trace.go:171","msg":"trace[1796752790] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5519; }","duration":"119.361524ms","start":"2026-10-13T15:08:05.349335Z","end":"2026-10-13T15:08:05.468697Z","steps":["trace[1796752790] 'range keys from in-memory index tree' (duration: 118.968407ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:08:09.230896Z","caller":"traceutil/trace.go:171","msg":"trace[1154273852] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"108.604489ms","start":"2026-10-13T15:08:09.122261Z","end":"2026-10-13T15:08:09.230865Z","steps":["trace[1154273852] 'process raft request' (duration: 57.780256ms)","trace[1154273852] 'compare' (duration: 50.565288ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T15:08:09.231034Z","caller":"traceutil/trace.go:171","msg":"trace[1620639838] linearizableReadLoop","detail":"{readStateIndex:5796; appliedIndex:5795; }","duration":"107.452098ms","start":"2026-10-13T15:08:09.123558Z","end":"2026-10-13T15:08:09.23101Z","steps":["trace[1620639838] 'read index received' (duration: 19.1458ms)","trace[1620639838] 'applied index is now lower than readState.Index' (duration: 88.305378ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T15:08:09.231534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.950797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-fernet-setup-nmbrh\" ","response":"range_response_count:1 size:6150"} {"level":"info","ts":"2026-10-13T15:08:09.2316Z","caller":"traceutil/trace.go:171","msg":"trace[1301083461] range","detail":"{range_begin:/registry/pods/openstack/keystone-fernet-setup-nmbrh; range_end:; response_count:1; response_revision:5561; }","duration":"108.05905ms","start":"2026-10-13T15:08:09.123523Z","end":"2026-10-13T15:08:09.231582Z","steps":["trace[1301083461] 'agreement among raft nodes before linearized reading' (duration: 107.581461ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T15:09:32.78374Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3052} {"level":"info","ts":"2026-10-13T15:09:32.896405Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3052,"took":"111.181815ms","hash":3285386286,"current-db-size-bytes":58314752,"current-db-size":"58 MB","current-db-size-in-use-bytes":30818304,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-13T15:09:32.896474Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3285386286,"revision":3052,"compact-revision":-1} {"level":"info","ts":"2026-10-13T15:10:49.285015Z","caller":"traceutil/trace.go:171","msg":"trace[1548375570] transaction","detail":"{read_only:false; response_revision:6889; number_of_response:1; }","duration":"164.00051ms","start":"2026-10-13T15:10:49.120974Z","end":"2026-10-13T15:10:49.284974Z","steps":["trace[1548375570] 'process raft request' (duration: 163.755363ms)"],"step_count":1}