{"level":"warn","ts":"2026-08-11T12:59:10.685874Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T12:59:10.685966Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-11T12:59:10.686032Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T12:59:10.686046Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-08-11T12:59:10.686066Z","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-08-11T12:59:10.686706Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-08-11T12:59:10.686804Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-11T12:59:10.692708Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.707943ms"} {"level":"info","ts":"2026-08-11T12:59:10.700114Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-08-11T12:59:10.700205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T12:59:10.700231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-08-11T12:59:10.70025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T12:59:10.700269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-08-11T12:59:10.700547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-08-11T12:59:10.710305Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T12:59:10.713992Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T12:59:10.716332Z","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-08-11T12:59:10.718521Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T12:59:10.719047Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T12:59:10.719101Z","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-08-11T12:59:10.719187Z","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-08-11T12:59:10.719206Z","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-08-11T12:59:10.722221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-08-11T12:59:10.722326Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-08-11T12:59:10.724913Z","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-08-11T12:59:10.7251Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T12:59:10.725134Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T12:59:10.725277Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-08-11T12:59:10.725299Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-08-11T12:59:11.501003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T12:59:11.501053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T12:59:11.501084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-08-11T12:59:11.501099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-08-11T12:59:11.501108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-08-11T12:59:11.501117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-08-11T12:59:11.501123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-08-11T12:59:11.503207Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:59:11.505065Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T12:59:11.505066Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T12:59:11.505106Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T12:59:11.505495Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T12:59:11.505554Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T12:59:11.505947Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:59:11.506185Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:59:11.506276Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:59:11.508914Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-08-11T12:59:11.509555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-11T12:59:15.651947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.013775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-wht9hk\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:59:15.652181Z","caller":"traceutil/trace.go:171","msg":"trace[280595482] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-wht9hk; range_end:; response_count:0; response_revision:213; }","duration":"359.321814ms","start":"2026-08-11T12:59:15.292837Z","end":"2026-08-11T12:59:15.652159Z","steps":["trace[280595482] 'range keys from in-memory index tree' (duration: 358.926686ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:15.652285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:15.292819Z","time spent":"359.450934ms","remote":"127.0.0.1:60180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-wht9hk\" "} {"level":"info","ts":"2026-08-11T12:59:15.892785Z","caller":"traceutil/trace.go:171","msg":"trace[1037615756] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"235.735274ms","start":"2026-08-11T12:59:15.657024Z","end":"2026-08-11T12:59:15.892759Z","steps":["trace[1037615756] 'process raft request' (duration: 235.632284ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:16.425691Z","caller":"traceutil/trace.go:171","msg":"trace[1114174747] linearizableReadLoop","detail":"{readStateIndex:219; appliedIndex:218; }","duration":"461.00113ms","start":"2026-08-11T12:59:15.964662Z","end":"2026-08-11T12:59:16.425663Z","steps":["trace[1114174747] 'read index received' (duration: 457.538219ms)","trace[1114174747] 'applied index is now lower than readState.Index' (duration: 3.461841ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:59:16.425782Z","caller":"traceutil/trace.go:171","msg":"trace[1014023620] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"526.277002ms","start":"2026-08-11T12:59:15.899473Z","end":"2026-08-11T12:59:16.42575Z","steps":["trace[1014023620] 'process raft request' (duration: 522.748401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:16.42585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.16987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:59:16.425911Z","caller":"traceutil/trace.go:171","msg":"trace[1172664509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:215; }","duration":"461.27887ms","start":"2026-08-11T12:59:15.964621Z","end":"2026-08-11T12:59:16.425893Z","steps":["trace[1172664509] 'agreement among raft nodes before linearized reading' (duration: 461.14049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:16.425956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:15.964602Z","time spent":"461.34301ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T12:59:16.426235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:15.899461Z","time spent":"526.385392ms","remote":"127.0.0.1:60180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11436,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.871629Z","caller":"traceutil/trace.go:171","msg":"trace[826483936] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"489.463581ms","start":"2026-08-11T12:59:48.382138Z","end":"2026-08-11T12:59:48.871601Z","steps":["trace[826483936] 'process raft request' (duration: 489.357519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.871757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.382119Z","time spent":"489.579904ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.879509Z","caller":"traceutil/trace.go:171","msg":"trace[2094190613] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"484.461638ms","start":"2026-08-11T12:59:48.395028Z","end":"2026-08-11T12:59:48.879489Z","steps":["trace[2094190613] 'process raft request' (duration: 484.120739ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:48.879849Z","caller":"traceutil/trace.go:171","msg":"trace[1660981992] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"495.06857ms","start":"2026-08-11T12:59:48.384773Z","end":"2026-08-11T12:59:48.879841Z","steps":["trace[1660981992] 'process raft request' (duration: 494.191047ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:48.879842Z","caller":"traceutil/trace.go:171","msg":"trace[371929096] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"456.649716ms","start":"2026-08-11T12:59:48.423158Z","end":"2026-08-11T12:59:48.879808Z","steps":["trace[371929096] 'process raft request' (duration: 456.211425ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.87999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.423138Z","time spent":"456.771409ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:59:48.879983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.384767Z","time spent":"495.121272ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.879998Z","caller":"traceutil/trace.go:171","msg":"trace[47888026] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"497.043653ms","start":"2026-08-11T12:59:48.38294Z","end":"2026-08-11T12:59:48.879983Z","steps":["trace[47888026] 'process raft request' (duration: 495.907783ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:48.880092Z","caller":"traceutil/trace.go:171","msg":"trace[1039540409] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"473.068903ms","start":"2026-08-11T12:59:48.407015Z","end":"2026-08-11T12:59:48.880083Z","steps":["trace[1039540409] 'process raft request' (duration: 472.223331ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.880104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.382916Z","time spent":"497.160655ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:59:48.880141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.407002Z","time spent":"473.117735ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.880153Z","caller":"traceutil/trace.go:171","msg":"trace[860247729] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"469.129778ms","start":"2026-08-11T12:59:48.411015Z","end":"2026-08-11T12:59:48.880145Z","steps":["trace[860247729] 'process raft request' (duration: 468.301816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.880185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.411007Z","time spent":"469.164319ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.880214Z","caller":"traceutil/trace.go:171","msg":"trace[292112441] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"488.570377ms","start":"2026-08-11T12:59:48.391636Z","end":"2026-08-11T12:59:48.880206Z","steps":["trace[292112441] 'process raft request' (duration: 487.373235ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:48.880244Z","caller":"traceutil/trace.go:171","msg":"trace[366449461] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"488.542495ms","start":"2026-08-11T12:59:48.391697Z","end":"2026-08-11T12:59:48.880239Z","steps":["trace[366449461] 'process raft request' (duration: 487.409086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.880258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.391623Z","time spent":"488.617727ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:59:48.880269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.391667Z","time spent":"488.588337ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:59:48.879722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.226509ms","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-08-11T12:59:48.880338Z","caller":"traceutil/trace.go:171","msg":"trace[611896893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:496; }","duration":"200.889277ms","start":"2026-08-11T12:59:48.679439Z","end":"2026-08-11T12:59:48.880329Z","steps":["trace[611896893] 'agreement among raft nodes before linearized reading' (duration: 200.160168ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:48.879757Z","caller":"traceutil/trace.go:171","msg":"trace[1747085588] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"480.645215ms","start":"2026-08-11T12:59:48.399102Z","end":"2026-08-11T12:59:48.879748Z","steps":["trace[1747085588] 'process raft request' (duration: 480.099651ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.880431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.399089Z","time spent":"481.330944ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.879785Z","caller":"traceutil/trace.go:171","msg":"trace[814343274] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"441.860712ms","start":"2026-08-11T12:59:48.437917Z","end":"2026-08-11T12:59:48.879778Z","steps":["trace[814343274] 'process raft request' (duration: 441.501413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.880486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.437892Z","time spent":"442.584561ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.87981Z","caller":"traceutil/trace.go:171","msg":"trace[502253781] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"341.862345ms","start":"2026-08-11T12:59:48.537942Z","end":"2026-08-11T12:59:48.879804Z","steps":["trace[502253781] 'process raft request' (duration: 341.541037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:48.880557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.537917Z","time spent":"342.629946ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:48.879555Z","caller":"traceutil/trace.go:171","msg":"trace[2041682985] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:508; }","duration":"200.048585ms","start":"2026-08-11T12:59:48.679487Z","end":"2026-08-11T12:59:48.879535Z","steps":["trace[2041682985] 'read index received' (duration: 192.144814ms)","trace[2041682985] 'applied index is now lower than readState.Index' (duration: 7.902911ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:59:48.880794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:48.395012Z","time spent":"484.841287ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:59:55.207962Z","caller":"traceutil/trace.go:171","msg":"trace[525234928] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"285.90756ms","start":"2026-08-11T12:59:54.922028Z","end":"2026-08-11T12:59:55.207935Z","steps":["trace[525234928] 'read index received' (duration: 255.140301ms)","trace[525234928] 'applied index is now lower than readState.Index' (duration: 30.766189ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:59:55.208041Z","caller":"traceutil/trace.go:171","msg":"trace[1158852985] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"336.741491ms","start":"2026-08-11T12:59:54.87125Z","end":"2026-08-11T12:59:55.207991Z","steps":["trace[1158852985] 'process raft request' (duration: 305.965541ms)","trace[1158852985] 'compare' (duration: 30.598945ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:59:55.208175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:54.871228Z","time spent":"336.882666ms","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:59:55.20825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.21007ms","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-08-11T12:59:55.208333Z","caller":"traceutil/trace.go:171","msg":"trace[29912146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"286.301723ms","start":"2026-08-11T12:59:54.922012Z","end":"2026-08-11T12:59:55.208314Z","steps":["trace[29912146] 'agreement among raft nodes before linearized reading' (duration: 286.037905ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:55.968204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.989311ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:59:55.968418Z","caller":"traceutil/trace.go:171","msg":"trace[1684548250] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:622; }","duration":"748.753483ms","start":"2026-08-11T12:59:55.219649Z","end":"2026-08-11T12:59:55.968403Z","steps":["trace[1684548250] 'read index received' (duration: 3.204289ms)","trace[1684548250] 'applied index is now lower than readState.Index' (duration: 745.548214ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:59:55.968565Z","caller":"traceutil/trace.go:171","msg":"trace[500359355] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"755.458919ms","start":"2026-08-11T12:59:55.213095Z","end":"2026-08-11T12:59:55.968554Z","steps":["trace[500359355] 'process raft request' (duration: 356.809668ms)","trace[500359355] 'compare' (duration: 397.198017ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:59:55.968678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:55.213082Z","time spent":"755.568572ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:59:55.968818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.086193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:59:55.968925Z","caller":"traceutil/trace.go:171","msg":"trace[269237169] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:595; }","duration":"749.27513ms","start":"2026-08-11T12:59:55.219628Z","end":"2026-08-11T12:59:55.968903Z","steps":["trace[269237169] 'agreement among raft nodes before linearized reading' (duration: 749.009031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:55.968948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.402581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T12:59:55.969013Z","caller":"traceutil/trace.go:171","msg":"trace[691598029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"509.513055ms","start":"2026-08-11T12:59:55.459491Z","end":"2026-08-11T12:59:55.969004Z","steps":["trace[691598029] 'agreement among raft nodes before linearized reading' (duration: 509.380821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:55.969055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:55.459467Z","time spent":"509.581006ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T12:59:55.969169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.231392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lj888\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-11T12:59:55.969239Z","caller":"traceutil/trace.go:171","msg":"trace[1795039786] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"755.353667ms","start":"2026-08-11T12:59:55.213869Z","end":"2026-08-11T12:59:55.969223Z","steps":["trace[1795039786] 'process raft request' (duration: 754.470979ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:55.969267Z","caller":"traceutil/trace.go:171","msg":"trace[1856524887] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lj888; range_end:; response_count:1; response_revision:595; }","duration":"437.315165ms","start":"2026-08-11T12:59:55.531891Z","end":"2026-08-11T12:59:55.969207Z","steps":["trace[1856524887] 'agreement among raft nodes before linearized reading' (duration: 437.248423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:55.969336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:55.53187Z","time spent":"437.455339ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-lj888\" "} {"level":"warn","ts":"2026-08-11T12:59:55.969352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:55.21385Z","time spent":"755.430649ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:59:55.968976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:55.219621Z","time spent":"749.344002ms","remote":"127.0.0.1:60352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-08-11T12:59:56.665384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680221792397422917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T12:59:57.139789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:56.457848Z","time spent":"681.93397ms","remote":"127.0.0.1:53658","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-11T12:59:57.140607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.000638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:59:57.141332Z","caller":"traceutil/trace.go:171","msg":"trace[1360365961] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.157421709s","start":"2026-08-11T12:59:55.983833Z","end":"2026-08-11T12:59:57.141255Z","steps":["trace[1360365961] 'process raft request' (duration: 760.12127ms)","trace[1360365961] 'compare' (duration: 395.14899ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:59:57.141624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:55.983807Z","time spent":"1.157644657s","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:59:57.142956Z","caller":"traceutil/trace.go:171","msg":"trace[1667761255] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"978.477308ms","start":"2026-08-11T12:59:56.164431Z","end":"2026-08-11T12:59:57.142909Z","steps":["trace[1667761255] 'read index received' (duration: 579.67028ms)","trace[1667761255] 'applied index is now lower than readState.Index' (duration: 398.805458ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:59:57.143133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.707384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:59:57.143202Z","caller":"traceutil/trace.go:171","msg":"trace[1211707790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"978.787747ms","start":"2026-08-11T12:59:56.164373Z","end":"2026-08-11T12:59:57.143161Z","steps":["trace[1211707790] 'agreement among raft nodes before linearized reading' (duration: 978.658013ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:59:57.143168Z","caller":"traceutil/trace.go:171","msg":"trace[1621249278] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"783.96363ms","start":"2026-08-11T12:59:56.359166Z","end":"2026-08-11T12:59:57.14313Z","steps":["trace[1621249278] 'process raft request' (duration: 782.834543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:59:57.143242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:56.164354Z","time spent":"978.87915ms","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T12:59:57.143347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:59:56.35914Z","time spent":"784.111235ms","remote":"127.0.0.1:60180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:59:58.933971Z","caller":"traceutil/trace.go:171","msg":"trace[186392889] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"251.661653ms","start":"2026-08-11T12:59:58.682289Z","end":"2026-08-11T12:59:58.93395Z","steps":["trace[186392889] 'process raft request' (duration: 251.481617ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:00:13.078364Z","caller":"traceutil/trace.go:171","msg":"trace[233226225] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"441.163568ms","start":"2026-08-11T13:00:12.637144Z","end":"2026-08-11T13:00:13.078308Z","steps":["trace[233226225] 'read index received' (duration: 440.989041ms)","trace[233226225] 'applied index is now lower than readState.Index' (duration: 173.497µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:00:13.078402Z","caller":"traceutil/trace.go:171","msg":"trace[2139110943] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"532.64185ms","start":"2026-08-11T13:00:12.545724Z","end":"2026-08-11T13:00:13.078366Z","steps":["trace[2139110943] 'process raft request' (duration: 532.426902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:00:13.078574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.410678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l5wtg\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-08-11T13:00:13.078585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:00:12.545709Z","time spent":"532.771256ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T13:00:13.07861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.200754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:00:13.078643Z","caller":"traceutil/trace.go:171","msg":"trace[1785498571] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l5wtg; range_end:; response_count:1; response_revision:760; }","duration":"441.517542ms","start":"2026-08-11T13:00:12.637107Z","end":"2026-08-11T13:00:13.078625Z","steps":["trace[1785498571] 'agreement among raft nodes before linearized reading' (duration: 441.322045ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:00:13.078682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:00:12.637054Z","time spent":"441.620916ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l5wtg\" "} {"level":"info","ts":"2026-08-11T13:00:13.078678Z","caller":"traceutil/trace.go:171","msg":"trace[296326117] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:760; }","duration":"287.3677ms","start":"2026-08-11T13:00:12.791297Z","end":"2026-08-11T13:00:13.078664Z","steps":["trace[296326117] 'agreement among raft nodes before linearized reading' (duration: 287.199323ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:00:44.392889Z","caller":"traceutil/trace.go:171","msg":"trace[1565066565] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"190.868629ms","start":"2026-08-11T13:00:44.201988Z","end":"2026-08-11T13:00:44.392857Z","steps":["trace[1565066565] 'process raft request' (duration: 190.660109ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:00:44.393576Z","caller":"traceutil/trace.go:171","msg":"trace[1257312913] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"188.729522ms","start":"2026-08-11T13:00:44.204819Z","end":"2026-08-11T13:00:44.393549Z","steps":["trace[1257312913] 'process raft request' (duration: 188.578074ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:00:44.393795Z","caller":"traceutil/trace.go:171","msg":"trace[818356819] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"188.918551ms","start":"2026-08-11T13:00:44.204857Z","end":"2026-08-11T13:00:44.393775Z","steps":["trace[818356819] 'process raft request' (duration: 188.653658ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:00.719615Z","caller":"traceutil/trace.go:171","msg":"trace[854540350] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1355; }","duration":"155.572553ms","start":"2026-08-11T13:01:00.564018Z","end":"2026-08-11T13:01:00.719591Z","steps":["trace[854540350] 'read index received' (duration: 153.069857ms)","trace[854540350] 'applied index is now lower than readState.Index' (duration: 2.501626ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:00.719731Z","caller":"traceutil/trace.go:171","msg":"trace[311311066] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"213.825812ms","start":"2026-08-11T13:01:00.50586Z","end":"2026-08-11T13:01:00.719685Z","steps":["trace[311311066] 'process raft request' (duration: 211.285214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:00.71977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.726011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:01:00.719856Z","caller":"traceutil/trace.go:171","msg":"trace[1277118529] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1306; }","duration":"155.871669ms","start":"2026-08-11T13:01:00.56396Z","end":"2026-08-11T13:01:00.719832Z","steps":["trace[1277118529] 'agreement among raft nodes before linearized reading' (duration: 155.740441ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:31.378335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.706788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:01:31.378418Z","caller":"traceutil/trace.go:171","msg":"trace[1138134697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1837; }","duration":"214.835196ms","start":"2026-08-11T13:01:31.163563Z","end":"2026-08-11T13:01:31.378398Z","steps":["trace[1138134697] 'range keys from in-memory index tree' (duration: 214.583792ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:31.37841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.265464ms","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-08-11T13:01:31.37849Z","caller":"traceutil/trace.go:171","msg":"trace[1976370519] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"113.385961ms","start":"2026-08-11T13:01:31.265083Z","end":"2026-08-11T13:01:31.378469Z","steps":["trace[1976370519] 'range keys from in-memory index tree' (duration: 113.091593ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:31.378514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.695661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eb2d05b2-b600-4e8f-a7e4-9727434601ac\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-11T13:01:31.378582Z","caller":"traceutil/trace.go:171","msg":"trace[387240064] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eb2d05b2-b600-4e8f-a7e4-9727434601ac; range_end:; response_count:1; response_revision:1837; }","duration":"300.798167ms","start":"2026-08-11T13:01:31.077767Z","end":"2026-08-11T13:01:31.378565Z","steps":["trace[387240064] 'range keys from in-memory index tree' (duration: 300.528509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:31.378633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:01:31.077749Z","time spent":"300.869241ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eb2d05b2-b600-4e8f-a7e4-9727434601ac\" "} {"level":"warn","ts":"2026-08-11T13:01:31.378508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.837086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-08-11T13:01:31.3788Z","caller":"traceutil/trace.go:171","msg":"trace[425171489] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1837; }","duration":"368.150846ms","start":"2026-08-11T13:01:31.010612Z","end":"2026-08-11T13:01:31.378763Z","steps":["trace[425171489] 'range keys from in-memory index tree' (duration: 367.607033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:31.378876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:01:31.01059Z","time spent":"368.247962ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10689,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-08-11T13:01:31.607613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.029989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T13:01:31.607816Z","caller":"traceutil/trace.go:171","msg":"trace[377025831] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"142.705783ms","start":"2026-08-11T13:01:31.465039Z","end":"2026-08-11T13:01:31.607745Z","steps":["trace[377025831] 'process raft request' (duration: 39.399238ms)","trace[377025831] 'compare' (duration: 102.841267ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:31.639065Z","caller":"traceutil/trace.go:171","msg":"trace[1896213663] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"173.601809ms","start":"2026-08-11T13:01:31.465436Z","end":"2026-08-11T13:01:31.639038Z","steps":["trace[1896213663] 'process raft request' (duration: 173.386917ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:31.639627Z","caller":"traceutil/trace.go:171","msg":"trace[1322095769] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"172.705566ms","start":"2026-08-11T13:01:31.466863Z","end":"2026-08-11T13:01:31.639569Z","steps":["trace[1322095769] 'process raft request' (duration: 172.41956ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:31.639769Z","caller":"traceutil/trace.go:171","msg":"trace[10494870] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"171.101081ms","start":"2026-08-11T13:01:31.468626Z","end":"2026-08-11T13:01:31.639727Z","steps":["trace[10494870] 'process raft request' (duration: 170.877708ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:31.64091Z","caller":"traceutil/trace.go:171","msg":"trace[1877738965] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"145.19383ms","start":"2026-08-11T13:01:31.495705Z","end":"2026-08-11T13:01:31.640899Z","steps":["trace[1877738965] 'process raft request' (duration: 143.921405ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:31.641305Z","caller":"traceutil/trace.go:171","msg":"trace[993971733] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"173.863485ms","start":"2026-08-11T13:01:31.465521Z","end":"2026-08-11T13:01:31.639385Z","steps":["trace[993971733] 'process raft request' (duration: 173.473002ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:31.640739Z","caller":"traceutil/trace.go:171","msg":"trace[651613097] linearizableReadLoop","detail":"{readStateIndex:1924; appliedIndex:1919; }","duration":"169.450143ms","start":"2026-08-11T13:01:31.471273Z","end":"2026-08-11T13:01:31.640723Z","steps":["trace[651613097] 'read index received' (duration: 33.189262ms)","trace[651613097] 'applied index is now lower than readState.Index' (duration: 136.259251ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:01:31.641659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.353247ms","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-08-11T13:01:31.641722Z","caller":"traceutil/trace.go:171","msg":"trace[4564221] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1845; }","duration":"170.454603ms","start":"2026-08-11T13:01:31.471256Z","end":"2026-08-11T13:01:31.641711Z","steps":["trace[4564221] 'agreement among raft nodes before linearized reading' (duration: 170.131134ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:31.90113Z","caller":"traceutil/trace.go:171","msg":"trace[1138143612] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1925; }","duration":"165.702402ms","start":"2026-08-11T13:01:31.735391Z","end":"2026-08-11T13:01:31.901094Z","steps":["trace[1138143612] 'read index received' (duration: 160.880618ms)","trace[1138143612] 'applied index is now lower than readState.Index' (duration: 4.820544ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:31.90137Z","caller":"traceutil/trace.go:171","msg":"trace[1791809662] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"254.613205ms","start":"2026-08-11T13:01:31.646552Z","end":"2026-08-11T13:01:31.901165Z","steps":["trace[1791809662] 'process raft request' (duration: 249.695435ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:31.90153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.085064ms","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-08-11T13:01:31.901664Z","caller":"traceutil/trace.go:171","msg":"trace[219996800] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1846; }","duration":"166.281426ms","start":"2026-08-11T13:01:31.735331Z","end":"2026-08-11T13:01:31.901612Z","steps":["trace[219996800] 'agreement among raft nodes before linearized reading' (duration: 165.890102ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:37.427629Z","caller":"traceutil/trace.go:171","msg":"trace[479293173] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"336.726841ms","start":"2026-08-11T13:01:37.090858Z","end":"2026-08-11T13:01:37.427585Z","steps":["trace[479293173] 'process raft request' (duration: 332.533051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:37.427821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:01:37.090839Z","time spent":"336.864369ms","remote":"127.0.0.1:60276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1139,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T13:01:37.431664Z","caller":"traceutil/trace.go:171","msg":"trace[985410764] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"339.353769ms","start":"2026-08-11T13:01:37.092296Z","end":"2026-08-11T13:01:37.43165Z","steps":["trace[985410764] 'process raft request' (duration: 339.22126ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:37.431766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:01:37.092287Z","time spent":"339.426624ms","remote":"127.0.0.1:60276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1144,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T13:01:37.431976Z","caller":"traceutil/trace.go:171","msg":"trace[1263534761] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"339.52363ms","start":"2026-08-11T13:01:37.092435Z","end":"2026-08-11T13:01:37.431958Z","steps":["trace[1263534761] 'process raft request' (duration: 339.174959ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:37.432165Z","caller":"traceutil/trace.go:171","msg":"trace[303583580] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"339.415052ms","start":"2026-08-11T13:01:37.09273Z","end":"2026-08-11T13:01:37.432145Z","steps":["trace[303583580] 'process raft request' (duration: 339.155196ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:37.432223Z","caller":"traceutil/trace.go:171","msg":"trace[298862235] linearizableReadLoop","detail":"{readStateIndex:1989; appliedIndex:1985; }","duration":"268.894124ms","start":"2026-08-11T13:01:37.163321Z","end":"2026-08-11T13:01:37.432215Z","steps":["trace[298862235] 'read index received' (duration: 260.083447ms)","trace[298862235] 'applied index is now lower than readState.Index' (duration: 8.809857ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:01:37.432269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:01:37.092723Z","time spent":"339.506818ms","remote":"127.0.0.1:60378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1702,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T13:01:37.432185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:01:37.092429Z","time spent":"339.664178ms","remote":"127.0.0.1:60378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1684,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T13:01:37.432912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.101316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:01:37.432955Z","caller":"traceutil/trace.go:171","msg":"trace[1111946135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1908; }","duration":"269.654729ms","start":"2026-08-11T13:01:37.163283Z","end":"2026-08-11T13:01:37.432938Z","steps":["trace[1111946135] 'agreement among raft nodes before linearized reading' (duration: 269.117897ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:42.916403Z","caller":"traceutil/trace.go:171","msg":"trace[370963287] linearizableReadLoop","detail":"{readStateIndex:2023; appliedIndex:2022; }","duration":"112.940397ms","start":"2026-08-11T13:01:42.803444Z","end":"2026-08-11T13:01:42.916384Z","steps":["trace[370963287] 'read index received' (duration: 112.766937ms)","trace[370963287] 'applied index is now lower than readState.Index' (duration: 172.77µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:42.916517Z","caller":"traceutil/trace.go:171","msg":"trace[224817307] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"187.8605ms","start":"2026-08-11T13:01:42.72863Z","end":"2026-08-11T13:01:42.91649Z","steps":["trace[224817307] 'process raft request' (duration: 187.631267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:42.916596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.13586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T13:01:42.916627Z","caller":"traceutil/trace.go:171","msg":"trace[1346354291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1940; }","duration":"113.213334ms","start":"2026-08-11T13:01:42.803405Z","end":"2026-08-11T13:01:42.916619Z","steps":["trace[1346354291] 'agreement among raft nodes before linearized reading' (duration: 113.076776ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:55.103149Z","caller":"traceutil/trace.go:171","msg":"trace[1000055287] linearizableReadLoop","detail":"{readStateIndex:2109; appliedIndex:2108; }","duration":"119.19296ms","start":"2026-08-11T13:01:54.983929Z","end":"2026-08-11T13:01:55.103122Z","steps":["trace[1000055287] 'read index received' (duration: 118.990528ms)","trace[1000055287] 'applied index is now lower than readState.Index' (duration: 201.502µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:55.1032Z","caller":"traceutil/trace.go:171","msg":"trace[1661891820] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"126.682311ms","start":"2026-08-11T13:01:54.976485Z","end":"2026-08-11T13:01:55.103167Z","steps":["trace[1661891820] 'process raft request' (duration: 126.475548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:55.103385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.437036ms","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-08-11T13:01:55.103433Z","caller":"traceutil/trace.go:171","msg":"trace[1886816924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2023; }","duration":"119.516942ms","start":"2026-08-11T13:01:54.983906Z","end":"2026-08-11T13:01:55.103423Z","steps":["trace[1886816924] 'agreement among raft nodes before linearized reading' (duration: 119.35065ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:55.25496Z","caller":"traceutil/trace.go:171","msg":"trace[729248670] linearizableReadLoop","detail":"{readStateIndex:2111; appliedIndex:2109; }","duration":"104.806808ms","start":"2026-08-11T13:01:55.150129Z","end":"2026-08-11T13:01:55.254935Z","steps":["trace[729248670] 'read index received' (duration: 8.246668ms)","trace[729248670] 'applied index is now lower than readState.Index' (duration: 96.559ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:55.255074Z","caller":"traceutil/trace.go:171","msg":"trace[1366087504] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"147.425373ms","start":"2026-08-11T13:01:55.107636Z","end":"2026-08-11T13:01:55.255061Z","steps":["trace[1366087504] 'process raft request' (duration: 127.694397ms)","trace[1366087504] 'compare' (duration: 19.48398ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:01:55.255547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.096095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-08-11T13:01:55.255611Z","caller":"traceutil/trace.go:171","msg":"trace[1354651827] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2025; }","duration":"105.50932ms","start":"2026-08-11T13:01:55.150087Z","end":"2026-08-11T13:01:55.255596Z","steps":["trace[1354651827] 'agreement among raft nodes before linearized reading' (duration: 105.039722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:59.720543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.214856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-08-11T13:01:59.721086Z","caller":"traceutil/trace.go:171","msg":"trace[1676145946] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2048; }","duration":"233.824013ms","start":"2026-08-11T13:01:59.487235Z","end":"2026-08-11T13:01:59.721059Z","steps":["trace[1676145946] 'range keys from in-memory index tree' (duration: 232.970781ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:59.724574Z","caller":"traceutil/trace.go:171","msg":"trace[1088833651] linearizableReadLoop","detail":"{readStateIndex:2135; appliedIndex:2134; }","duration":"121.827026ms","start":"2026-08-11T13:01:59.602717Z","end":"2026-08-11T13:01:59.724544Z","steps":["trace[1088833651] 'read index received' (duration: 121.635974ms)","trace[1088833651] 'applied index is now lower than readState.Index' (duration: 189.112µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:01:59.725004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.238651ms","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-08-11T13:01:59.725113Z","caller":"traceutil/trace.go:171","msg":"trace[94022204] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2049; }","duration":"122.424343ms","start":"2026-08-11T13:01:59.60267Z","end":"2026-08-11T13:01:59.725094Z","steps":["trace[94022204] 'agreement among raft nodes before linearized reading' (duration: 121.998567ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:01:59.725532Z","caller":"traceutil/trace.go:171","msg":"trace[995607246] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"166.320082ms","start":"2026-08-11T13:01:59.559192Z","end":"2026-08-11T13:01:59.725512Z","steps":["trace[995607246] 'process raft request' (duration: 165.181222ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:05.368511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.410283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T13:02:05.368595Z","caller":"traceutil/trace.go:171","msg":"trace[1558063164] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2077; }","duration":"161.551322ms","start":"2026-08-11T13:02:05.207024Z","end":"2026-08-11T13:02:05.368576Z","steps":["trace[1558063164] 'count revisions from in-memory index tree' (duration: 161.307467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:05.368649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.020409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-11T13:02:05.368719Z","caller":"traceutil/trace.go:171","msg":"trace[1172322630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2077; }","duration":"161.130236ms","start":"2026-08-11T13:02:05.207573Z","end":"2026-08-11T13:02:05.368703Z","steps":["trace[1172322630] 'range keys from in-memory index tree' (duration: 160.813506ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:05.691677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.455168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T13:02:05.691794Z","caller":"traceutil/trace.go:171","msg":"trace[1140217296] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"318.564859ms","start":"2026-08-11T13:02:05.373208Z","end":"2026-08-11T13:02:05.691773Z","steps":["trace[1140217296] 'process raft request' (duration: 213.92829ms)","trace[1140217296] 'compare' (duration: 104.278487ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:02:05.691852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:05.373189Z","time spent":"318.636294ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T13:02:06.759533Z","caller":"traceutil/trace.go:171","msg":"trace[168317224] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"405.12435ms","start":"2026-08-11T13:02:06.354383Z","end":"2026-08-11T13:02:06.759507Z","steps":["trace[168317224] 'process raft request' (duration: 381.997115ms)","trace[168317224] 'compare' (duration: 22.918992ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:02:06.759542Z","caller":"traceutil/trace.go:171","msg":"trace[61601111] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"331.240135ms","start":"2026-08-11T13:02:06.428285Z","end":"2026-08-11T13:02:06.759525Z","steps":["trace[61601111] 'process raft request' (duration: 331.187352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:06.75965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:06.428259Z","time spent":"331.33296ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T13:02:06.759654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:06.35435Z","time spent":"405.235757ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T13:02:06.759727Z","caller":"traceutil/trace.go:171","msg":"trace[180049358] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"106.898958ms","start":"2026-08-11T13:02:06.652811Z","end":"2026-08-11T13:02:06.75971Z","steps":["trace[180049358] 'process raft request' (duration: 106.696596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:07.978094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.855312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-11T13:02:07.978175Z","caller":"traceutil/trace.go:171","msg":"trace[1079525233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2089; }","duration":"282.98697ms","start":"2026-08-11T13:02:07.695168Z","end":"2026-08-11T13:02:07.978155Z","steps":["trace[1079525233] 'range keys from in-memory index tree' (duration: 282.66861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:07.978524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.646395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T13:02:07.978599Z","caller":"traceutil/trace.go:171","msg":"trace[1273052961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2089; }","duration":"520.777374ms","start":"2026-08-11T13:02:07.457804Z","end":"2026-08-11T13:02:07.978581Z","steps":["trace[1273052961] 'range keys from in-memory index tree' (duration: 520.459403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:07.978641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:07.457783Z","time spent":"520.848508ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T13:02:07.979276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.030703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:02:07.979345Z","caller":"traceutil/trace.go:171","msg":"trace[1894346086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2089; }","duration":"240.14082ms","start":"2026-08-11T13:02:07.739187Z","end":"2026-08-11T13:02:07.979328Z","steps":["trace[1894346086] 'range keys from in-memory index tree' (duration: 239.965319ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:02:08.073718Z","caller":"traceutil/trace.go:171","msg":"trace[139585608] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"314.122612ms","start":"2026-08-11T13:02:07.759574Z","end":"2026-08-11T13:02:08.073696Z","steps":["trace[139585608] 'process raft request' (duration: 313.983323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:08.073858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:07.759555Z","time spent":"314.227528ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T13:02:08.231257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.225927ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T13:02:08.231561Z","caller":"traceutil/trace.go:171","msg":"trace[924928716] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2177; }","duration":"450.28464ms","start":"2026-08-11T13:02:07.781253Z","end":"2026-08-11T13:02:08.231538Z","steps":["trace[924928716] 'read index received' (duration: 292.279726ms)","trace[924928716] 'applied index is now lower than readState.Index' (duration: 158.003544ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:02:08.231688Z","caller":"traceutil/trace.go:171","msg":"trace[1253972561] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"248.3392ms","start":"2026-08-11T13:02:07.983318Z","end":"2026-08-11T13:02:08.231657Z","steps":["trace[1253972561] 'process raft request' (duration: 248.055092ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:02:08.231755Z","caller":"traceutil/trace.go:171","msg":"trace[1946344162] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"248.339899ms","start":"2026-08-11T13:02:07.983389Z","end":"2026-08-11T13:02:08.231729Z","steps":["trace[1946344162] 'process raft request' (duration: 248.094394ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:02:08.231778Z","caller":"traceutil/trace.go:171","msg":"trace[526673547] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"459.979656ms","start":"2026-08-11T13:02:07.771775Z","end":"2026-08-11T13:02:08.231755Z","steps":["trace[526673547] 'process raft request' (duration: 313.166072ms)","trace[526673547] 'compare' (duration: 145.96842ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:02:08.231877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:07.771759Z","time spent":"460.066451ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T13:02:08.231945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.682606ms","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-08-11T13:02:08.23199Z","caller":"traceutil/trace.go:171","msg":"trace[578755890] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2093; }","duration":"450.76933ms","start":"2026-08-11T13:02:07.781207Z","end":"2026-08-11T13:02:08.231976Z","steps":["trace[578755890] 'agreement among raft nodes before linearized reading' (duration: 450.60815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:08.232031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T13:02:07.781185Z","time spent":"450.838354ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-11T13:02:08.250066Z","caller":"traceutil/trace.go:171","msg":"trace[1274062105] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"116.123471ms","start":"2026-08-11T13:02:08.13391Z","end":"2026-08-11T13:02:08.250034Z","steps":["trace[1274062105] 'process raft request' (duration: 116.044866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:08.250151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.285226ms","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-08-11T13:02:08.250175Z","caller":"traceutil/trace.go:171","msg":"trace[664302480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2094; }","duration":"148.345649ms","start":"2026-08-11T13:02:08.101821Z","end":"2026-08-11T13:02:08.250167Z","steps":["trace[664302480] 'agreement among raft nodes before linearized reading' (duration: 148.287185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:02:08.250092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.251159ms","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-08-11T13:02:08.250233Z","caller":"traceutil/trace.go:171","msg":"trace[834374460] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2094; }","duration":"181.42726ms","start":"2026-08-11T13:02:08.068796Z","end":"2026-08-11T13:02:08.250212Z","steps":["trace[834374460] 'agreement among raft nodes before linearized reading' (duration: 181.218637ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:29.928464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.726443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-319144fd-9056-427f-a695-55f623188000\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-08-11T13:07:29.928555Z","caller":"traceutil/trace.go:171","msg":"trace[1251794384] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-319144fd-9056-427f-a695-55f623188000; range_end:; response_count:1; response_revision:4514; }","duration":"123.807627ms","start":"2026-08-11T13:07:29.804715Z","end":"2026-08-11T13:07:29.928522Z","steps":["trace[1251794384] 'agreement among raft nodes before linearized reading' (duration: 123.66055ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:33.671617Z","caller":"traceutil/trace.go:171","msg":"trace[958578633] linearizableReadLoop","detail":"{readStateIndex:4791; appliedIndex:4790; }","duration":"161.271194ms","start":"2026-08-11T13:07:33.510313Z","end":"2026-08-11T13:07:33.671584Z","steps":["trace[958578633] 'read index received' (duration: 135.242942ms)","trace[958578633] 'applied index is now lower than readState.Index' (duration: 26.026942ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:07:33.67187Z","caller":"traceutil/trace.go:171","msg":"trace[1415525913] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"161.80897ms","start":"2026-08-11T13:07:33.510023Z","end":"2026-08-11T13:07:33.671832Z","steps":["trace[1415525913] 'process raft request' (duration: 135.516655ms)","trace[1415525913] 'compare' (duration: 25.826742ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:07:33.672084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.746307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-08-11T13:07:33.672138Z","caller":"traceutil/trace.go:171","msg":"trace[1957165919] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4604; }","duration":"161.850972ms","start":"2026-08-11T13:07:33.51027Z","end":"2026-08-11T13:07:33.672121Z","steps":["trace[1957165919] 'agreement among raft nodes before linearized reading' (duration: 161.636492ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:33.679244Z","caller":"traceutil/trace.go:171","msg":"trace[1992396203] transaction","detail":"{read_only:false; response_revision:4605; number_of_response:1; }","duration":"142.243039ms","start":"2026-08-11T13:07:33.536986Z","end":"2026-08-11T13:07:33.679229Z","steps":["trace[1992396203] 'process raft request' (duration: 141.904813ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:33.679361Z","caller":"traceutil/trace.go:171","msg":"trace[174074900] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"141.743064ms","start":"2026-08-11T13:07:33.537612Z","end":"2026-08-11T13:07:33.679355Z","steps":["trace[174074900] 'process raft request' (duration: 141.385257ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.196216Z","caller":"traceutil/trace.go:171","msg":"trace[44833741] linearizableReadLoop","detail":"{readStateIndex:4894; appliedIndex:4892; }","duration":"183.200063ms","start":"2026-08-11T13:07:39.012987Z","end":"2026-08-11T13:07:39.196187Z","steps":["trace[44833741] 'read index received' (duration: 183.003123ms)","trace[44833741] 'applied index is now lower than readState.Index' (duration: 196.069µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:07:39.19632Z","caller":"traceutil/trace.go:171","msg":"trace[1516129995] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"202.282097ms","start":"2026-08-11T13:07:38.994029Z","end":"2026-08-11T13:07:39.196311Z","steps":["trace[1516129995] 'process raft request' (duration: 201.947631ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.196365Z","caller":"traceutil/trace.go:171","msg":"trace[1087584538] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"201.370702ms","start":"2026-08-11T13:07:38.994958Z","end":"2026-08-11T13:07:39.196328Z","steps":["trace[1087584538] 'process raft request' (duration: 201.180173ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.196651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.34995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-08-11T13:07:39.196725Z","caller":"traceutil/trace.go:171","msg":"trace[996311145] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4705; }","duration":"202.493178ms","start":"2026-08-11T13:07:38.994214Z","end":"2026-08-11T13:07:39.196708Z","steps":["trace[996311145] 'agreement among raft nodes before linearized reading' (duration: 202.211314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.196684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.472517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61148"} {"level":"info","ts":"2026-08-11T13:07:39.196806Z","caller":"traceutil/trace.go:171","msg":"trace[1066423030] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4705; }","duration":"202.598343ms","start":"2026-08-11T13:07:38.9942Z","end":"2026-08-11T13:07:39.196799Z","steps":["trace[1066423030] 'agreement among raft nodes before linearized reading' (duration: 202.375912ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.274927Z","caller":"traceutil/trace.go:171","msg":"trace[1008910773] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"233.086352ms","start":"2026-08-11T13:07:39.041808Z","end":"2026-08-11T13:07:39.274894Z","steps":["trace[1008910773] 'process raft request' (duration: 232.629019ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.275254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.693908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:07:39.275296Z","caller":"traceutil/trace.go:171","msg":"trace[1798340605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4706; }","duration":"109.800013ms","start":"2026-08-11T13:07:39.165481Z","end":"2026-08-11T13:07:39.275281Z","steps":["trace[1798340605] 'agreement among raft nodes before linearized reading' (duration: 109.709989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.275664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.233809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T13:07:39.275696Z","caller":"traceutil/trace.go:171","msg":"trace[1787952435] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4706; }","duration":"226.290502ms","start":"2026-08-11T13:07:39.049396Z","end":"2026-08-11T13:07:39.275687Z","steps":["trace[1787952435] 'agreement among raft nodes before linearized reading' (duration: 226.182946ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.275834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.251561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-11T13:07:39.277192Z","caller":"traceutil/trace.go:171","msg":"trace[753987835] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4706; }","duration":"260.678809ms","start":"2026-08-11T13:07:39.016503Z","end":"2026-08-11T13:07:39.277182Z","steps":["trace[753987835] 'agreement among raft nodes before linearized reading' (duration: 258.717214ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.414149Z","caller":"traceutil/trace.go:171","msg":"trace[343001069] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"211.711084ms","start":"2026-08-11T13:07:39.202386Z","end":"2026-08-11T13:07:39.414097Z","steps":["trace[343001069] 'process raft request' (duration: 211.478403ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.41419Z","caller":"traceutil/trace.go:171","msg":"trace[289252992] linearizableReadLoop","detail":"{readStateIndex:4898; appliedIndex:4895; }","duration":"139.569936ms","start":"2026-08-11T13:07:39.274593Z","end":"2026-08-11T13:07:39.414163Z","steps":["trace[289252992] 'read index received' (duration: 139.312554ms)","trace[289252992] 'applied index is now lower than readState.Index' (duration: 256.072µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:07:39.414415Z","caller":"traceutil/trace.go:171","msg":"trace[19207119] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"204.41853ms","start":"2026-08-11T13:07:39.209986Z","end":"2026-08-11T13:07:39.414405Z","steps":["trace[19207119] 'process raft request' (duration: 204.106955ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.414621Z","caller":"traceutil/trace.go:171","msg":"trace[35420503] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"209.490307ms","start":"2026-08-11T13:07:39.205081Z","end":"2026-08-11T13:07:39.414571Z","steps":["trace[35420503] 'process raft request' (duration: 208.94938ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.414828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.808072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-08-11T13:07:39.414923Z","caller":"traceutil/trace.go:171","msg":"trace[1169841778] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4709; }","duration":"209.941709ms","start":"2026-08-11T13:07:39.204956Z","end":"2026-08-11T13:07:39.414898Z","steps":["trace[1169841778] 'agreement among raft nodes before linearized reading' (duration: 209.654705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.415286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.286165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9318"} {"level":"info","ts":"2026-08-11T13:07:39.415418Z","caller":"traceutil/trace.go:171","msg":"trace[1981225262] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4709; }","duration":"210.512666ms","start":"2026-08-11T13:07:39.204882Z","end":"2026-08-11T13:07:39.415395Z","steps":["trace[1981225262] 'agreement among raft nodes before linearized reading' (duration: 209.778241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.417928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.211743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-08-11T13:07:39.417993Z","caller":"traceutil/trace.go:171","msg":"trace[387605367] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4709; }","duration":"210.317127ms","start":"2026-08-11T13:07:39.207662Z","end":"2026-08-11T13:07:39.417979Z","steps":["trace[387605367] 'agreement among raft nodes before linearized reading' (duration: 207.037628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.423015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.241433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T13:07:39.423066Z","caller":"traceutil/trace.go:171","msg":"trace[960476943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4711; }","duration":"145.471383ms","start":"2026-08-11T13:07:39.277582Z","end":"2026-08-11T13:07:39.423054Z","steps":["trace[960476943] 'agreement among raft nodes before linearized reading' (duration: 145.370468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.423274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.701598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3296"} {"level":"info","ts":"2026-08-11T13:07:39.4233Z","caller":"traceutil/trace.go:171","msg":"trace[607833480] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4711; }","duration":"137.74005ms","start":"2026-08-11T13:07:39.285553Z","end":"2026-08-11T13:07:39.423293Z","steps":["trace[607833480] 'agreement among raft nodes before linearized reading' (duration: 137.644855ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.423396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.877378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9514"} {"level":"info","ts":"2026-08-11T13:07:39.423442Z","caller":"traceutil/trace.go:171","msg":"trace[1936110501] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4711; }","duration":"143.016754ms","start":"2026-08-11T13:07:39.280415Z","end":"2026-08-11T13:07:39.423432Z","steps":["trace[1936110501] 'agreement among raft nodes before linearized reading' (duration: 142.811915ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.423594Z","caller":"traceutil/trace.go:171","msg":"trace[1159462655] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"141.456309ms","start":"2026-08-11T13:07:39.282128Z","end":"2026-08-11T13:07:39.423584Z","steps":["trace[1159462655] 'process raft request' (duration: 140.681151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.764866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.457259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T13:07:39.765014Z","caller":"traceutil/trace.go:171","msg":"trace[491719865] linearizableReadLoop","detail":"{readStateIndex:4911; appliedIndex:4910; }","duration":"190.023234ms","start":"2026-08-11T13:07:39.574966Z","end":"2026-08-11T13:07:39.764989Z","steps":["trace[491719865] 'read index received' (duration: 81.340374ms)","trace[491719865] 'applied index is now lower than readState.Index' (duration: 108.68121ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:07:39.765107Z","caller":"traceutil/trace.go:171","msg":"trace[1173394268] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"191.680964ms","start":"2026-08-11T13:07:39.573411Z","end":"2026-08-11T13:07:39.765092Z","steps":["trace[1173394268] 'process raft request' (duration: 82.888029ms)","trace[1173394268] 'compare' (duration: 108.269269ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:07:39.765626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.635413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-08-11T13:07:39.765674Z","caller":"traceutil/trace.go:171","msg":"trace[56070645] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4722; }","duration":"190.705176ms","start":"2026-08-11T13:07:39.574954Z","end":"2026-08-11T13:07:39.765659Z","steps":["trace[56070645] 'agreement among raft nodes before linearized reading' (duration: 190.461914ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.795446Z","caller":"traceutil/trace.go:171","msg":"trace[1635851197] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"217.317886ms","start":"2026-08-11T13:07:39.578094Z","end":"2026-08-11T13:07:39.795412Z","steps":["trace[1635851197] 'process raft request' (duration: 217.089335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.806992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.087337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-08-11T13:07:39.807056Z","caller":"traceutil/trace.go:171","msg":"trace[1180201554] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4725; }","duration":"229.172722ms","start":"2026-08-11T13:07:39.577868Z","end":"2026-08-11T13:07:39.807041Z","steps":["trace[1180201554] 'agreement among raft nodes before linearized reading' (duration: 229.005233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:07:39.807222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.039323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-11T13:07:39.807243Z","caller":"traceutil/trace.go:171","msg":"trace[1941052004] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4725; }","duration":"230.070495ms","start":"2026-08-11T13:07:39.577165Z","end":"2026-08-11T13:07:39.807235Z","steps":["trace[1941052004] 'agreement among raft nodes before linearized reading' (duration: 230.007382ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T13:07:39.926573Z","caller":"traceutil/trace.go:171","msg":"trace[1014977308] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4914; }","duration":"101.720322ms","start":"2026-08-11T13:07:39.824816Z","end":"2026-08-11T13:07:39.926536Z","steps":["trace[1014977308] 'read index received' (duration: 12.450083ms)","trace[1014977308] 'applied index is now lower than readState.Index' (duration: 89.267949ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:07:39.955093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.474458ms","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":"warn","ts":"2026-08-11T13:07:39.955139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.312328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-08-11T13:07:39.955225Z","caller":"traceutil/trace.go:171","msg":"trace[835430548] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4726; }","duration":"130.393772ms","start":"2026-08-11T13:07:39.824809Z","end":"2026-08-11T13:07:39.955203Z","steps":["trace[835430548] 'agreement among raft nodes before linearized reading' (duration: 101.827167ms)","trace[835430548] 'range keys from in-memory index tree' (duration: 28.393066ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:07:39.955282Z","caller":"traceutil/trace.go:171","msg":"trace[1069185775] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4726; }","duration":"129.580764ms","start":"2026-08-11T13:07:39.825586Z","end":"2026-08-11T13:07:39.955167Z","steps":["trace[1069185775] 'agreement among raft nodes before linearized reading' (duration: 101.319023ms)","trace[1069185775] 'range keys from in-memory index tree' (duration: 28.05504ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T13:07:39.955375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.291418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-11T13:07:39.955554Z","caller":"traceutil/trace.go:171","msg":"trace[838544429] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4726; }","duration":"123.477007ms","start":"2026-08-11T13:07:39.831982Z","end":"2026-08-11T13:07:39.955459Z","steps":["trace[838544429] 'agreement among raft nodes before linearized reading' (duration: 94.903131ms)","trace[838544429] 'range keys from in-memory index tree' (duration: 28.181046ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:09:11.540384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2864} {"level":"info","ts":"2026-08-11T13:09:11.625911Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2864,"took":"83.628597ms","hash":3067464091,"current-db-size-bytes":54206464,"current-db-size":"54 MB","current-db-size-in-use-bytes":29069312,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T13:09:11.625978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3067464091,"revision":2864,"compact-revision":-1} {"level":"info","ts":"2026-08-11T13:14:11.545571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5534} {"level":"info","ts":"2026-08-11T13:14:11.637597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5534,"took":"90.090412ms","hash":3823117715,"current-db-size-bytes":54206464,"current-db-size":"54 MB","current-db-size-in-use-bytes":18296832,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T13:14:11.637663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3823117715,"revision":5534,"compact-revision":2864}