{"level":"warn","ts":"2026-08-22T14:35:31.810948Z","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-22T14:35:31.811077Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.235:2380","--initial-cluster=instance=https://199.19.213.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.235: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-22T14:35:31.811512Z","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-22T14:35:31.811544Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-08-22T14:35:31.811848Z","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-22T14:35:31.81257Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"]} {"level":"info","ts":"2026-08-22T14:35:31.812705Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.235: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-22T14:35:31.816699Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.784375ms"} {"level":"info","ts":"2026-08-22T14:35:31.822419Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"61a3fe3fc9dc5d35","cluster-id":"e13fd0e1d9ce1168"} {"level":"info","ts":"2026-08-22T14:35:31.822503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T14:35:31.822536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 0"} {"level":"info","ts":"2026-08-22T14:35:31.822554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 61a3fe3fc9dc5d35 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T14:35:31.822574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 1"} {"level":"info","ts":"2026-08-22T14:35:31.822629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"warn","ts":"2026-08-22T14:35:31.834103Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T14:35:31.835467Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T14:35:31.8376Z","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-22T14:35:31.840786Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"61a3fe3fc9dc5d35","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T14:35:31.845875Z","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-22T14:35:31.845984Z","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-22T14:35:31.845999Z","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-22T14:35:31.846083Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"61a3fe3fc9dc5d35","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T14:35:31.84881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"info","ts":"2026-08-22T14:35:31.849004Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","added-peer-id":"61a3fe3fc9dc5d35","added-peer-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-08-22T14:35:31.853501Z","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-22T14:35:31.853731Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"61a3fe3fc9dc5d35","initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T14:35:31.853768Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T14:35:31.853895Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-08-22T14:35:31.853913Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-08-22T14:35:32.3237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T14:35:32.32376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T14:35:32.323804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgPreVoteResp from 61a3fe3fc9dc5d35 at term 1"} {"level":"info","ts":"2026-08-22T14:35:32.323829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became candidate at term 2"} {"level":"info","ts":"2026-08-22T14:35:32.323846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgVoteResp from 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-08-22T14:35:32.323867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became leader at term 2"} {"level":"info","ts":"2026-08-22T14:35:32.323885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 61a3fe3fc9dc5d35 elected leader 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-08-22T14:35:32.325029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:32.325904Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"61a3fe3fc9dc5d35","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.235:2379]}","request-path":"/0/members/61a3fe3fc9dc5d35/attributes","cluster-id":"e13fd0e1d9ce1168","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T14:35:32.32606Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:35:32.326144Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:35:32.329158Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T14:35:32.32936Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:32.329757Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:32.332295Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.235:2379"} {"level":"info","ts":"2026-08-22T14:35:32.340003Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:35:32.340206Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T14:35:32.340687Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-08-22T14:36:07.115903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.412057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:36:07.11623Z","caller":"traceutil/trace.go:171","msg":"trace[168816807] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"277.505099ms","start":"2026-08-22T14:36:06.838702Z","end":"2026-08-22T14:36:07.116207Z","steps":["trace[168816807] 'process raft request' (duration: 277.345614ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:07.116205Z","caller":"traceutil/trace.go:171","msg":"trace[1827012722] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"282.095754ms","start":"2026-08-22T14:36:06.834058Z","end":"2026-08-22T14:36:07.116154Z","steps":["trace[1827012722] 'process raft request' (duration: 143.823848ms)","trace[1827012722] 'compare' (duration: 137.19983ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:36:07.11667Z","caller":"traceutil/trace.go:171","msg":"trace[1680564469] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"276.385252ms","start":"2026-08-22T14:36:06.840254Z","end":"2026-08-22T14:36:07.116639Z","steps":["trace[1680564469] 'process raft request' (duration: 275.891906ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:07.116835Z","caller":"traceutil/trace.go:171","msg":"trace[2006323556] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"265.405721ms","start":"2026-08-22T14:36:06.851413Z","end":"2026-08-22T14:36:07.116819Z","steps":["trace[2006323556] 'process raft request' (duration: 265.041869ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:07.116952Z","caller":"traceutil/trace.go:171","msg":"trace[1351607543] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"263.186986ms","start":"2026-08-22T14:36:06.853728Z","end":"2026-08-22T14:36:07.116915Z","steps":["trace[1351607543] 'process raft request' (duration: 262.915857ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:07.117467Z","caller":"traceutil/trace.go:171","msg":"trace[973227898] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"246.929618ms","start":"2026-08-22T14:36:06.87052Z","end":"2026-08-22T14:36:07.11745Z","steps":["trace[973227898] 'process raft request' (duration: 246.305507ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:07.123589Z","caller":"traceutil/trace.go:171","msg":"trace[786119518] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"193.025368ms","start":"2026-08-22T14:36:06.930518Z","end":"2026-08-22T14:36:07.123544Z","steps":["trace[786119518] 'process raft request' (duration: 190.720582ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:13.069048Z","caller":"traceutil/trace.go:171","msg":"trace[1182475726] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"189.049092ms","start":"2026-08-22T14:36:12.879971Z","end":"2026-08-22T14:36:13.06902Z","steps":["trace[1182475726] 'process raft request' (duration: 188.785374ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:13.237366Z","caller":"traceutil/trace.go:171","msg":"trace[773081552] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"347.673593ms","start":"2026-08-22T14:36:12.88967Z","end":"2026-08-22T14:36:13.237344Z","steps":["trace[773081552] 'process raft request' (duration: 347.092625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:13.237601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:12.889648Z","time spent":"347.864729ms","remote":"127.0.0.1:39506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:36:13.491831Z","caller":"traceutil/trace.go:171","msg":"trace[362960122] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"202.202278ms","start":"2026-08-22T14:36:13.289607Z","end":"2026-08-22T14:36:13.49181Z","steps":["trace[362960122] 'process raft request' (duration: 120.604029ms)","trace[362960122] 'compare' (duration: 80.948658ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:36:14.106652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.181758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-22T14:36:14.106662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.232651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T14:36:14.106909Z","caller":"traceutil/trace.go:171","msg":"trace[1895414172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"398.449136ms","start":"2026-08-22T14:36:13.70844Z","end":"2026-08-22T14:36:14.106889Z","steps":["trace[1895414172] 'range keys from in-memory index tree' (duration: 398.054634ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:14.106942Z","caller":"traceutil/trace.go:171","msg":"trace[527511241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"399.567221ms","start":"2026-08-22T14:36:13.707346Z","end":"2026-08-22T14:36:14.106913Z","steps":["trace[527511241] 'range keys from in-memory index tree' (duration: 399.100076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:14.107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:13.707327Z","time spent":"399.658983ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T14:36:14.106949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:13.708407Z","time spent":"398.533809ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-22T14:36:14.108456Z","caller":"traceutil/trace.go:171","msg":"trace[236846218] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"188.233456ms","start":"2026-08-22T14:36:13.920192Z","end":"2026-08-22T14:36:14.108425Z","steps":["trace[236846218] 'read index received' (duration: 186.209282ms)","trace[236846218] 'applied index is now lower than readState.Index' (duration: 2.022824ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:36:14.108591Z","caller":"traceutil/trace.go:171","msg":"trace[788988558] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"204.408245ms","start":"2026-08-22T14:36:13.904169Z","end":"2026-08-22T14:36:14.108577Z","steps":["trace[788988558] 'process raft request' (duration: 203.467805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:14.108934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.729151ms","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-22T14:36:14.108998Z","caller":"traceutil/trace.go:171","msg":"trace[1215564052] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"188.828594ms","start":"2026-08-22T14:36:13.920153Z","end":"2026-08-22T14:36:14.108981Z","steps":["trace[1215564052] 'agreement among raft nodes before linearized reading' (duration: 188.71471ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:14.109058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.919011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-22T14:36:14.109334Z","caller":"traceutil/trace.go:171","msg":"trace[1235687369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"144.325663ms","start":"2026-08-22T14:36:13.964986Z","end":"2026-08-22T14:36:14.109312Z","steps":["trace[1235687369] 'agreement among raft nodes before linearized reading' (duration: 143.776056ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:29.306033Z","caller":"traceutil/trace.go:171","msg":"trace[815930349] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"339.087455ms","start":"2026-08-22T14:36:28.966922Z","end":"2026-08-22T14:36:29.306009Z","steps":["trace[815930349] 'process raft request' (duration: 338.950951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:29.306243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:28.966906Z","time spent":"339.202717ms","remote":"127.0.0.1:39584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:37:02.236539Z","caller":"traceutil/trace.go:171","msg":"trace[465469721] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"127.903784ms","start":"2026-08-22T14:37:02.108616Z","end":"2026-08-22T14:37:02.23652Z","steps":["trace[465469721] 'process raft request' (duration: 127.785212ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:24.436958Z","caller":"traceutil/trace.go:171","msg":"trace[1558128463] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"193.637309ms","start":"2026-08-22T14:37:24.2433Z","end":"2026-08-22T14:37:24.436937Z","steps":["trace[1558128463] 'process raft request' (duration: 193.475626ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:24.463297Z","caller":"traceutil/trace.go:171","msg":"trace[936927897] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"160.132314ms","start":"2026-08-22T14:37:24.303116Z","end":"2026-08-22T14:37:24.463248Z","steps":["trace[936927897] 'process raft request' (duration: 159.824728ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:48.136458Z","caller":"traceutil/trace.go:171","msg":"trace[1405764802] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"353.404196ms","start":"2026-08-22T14:37:47.783021Z","end":"2026-08-22T14:37:48.136425Z","steps":["trace[1405764802] 'process raft request' (duration: 353.116401ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:48.136361Z","caller":"traceutil/trace.go:171","msg":"trace[1174097607] linearizableReadLoop","detail":"{readStateIndex:1864; appliedIndex:1863; }","duration":"276.506539ms","start":"2026-08-22T14:37:47.859824Z","end":"2026-08-22T14:37:48.136331Z","steps":["trace[1174097607] 'read index received' (duration: 276.314886ms)","trace[1174097607] 'applied index is now lower than readState.Index' (duration: 190.243µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:37:48.136622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.778113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-22T14:37:48.136696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:37:47.782999Z","time spent":"353.541458ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:37:48.136908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.994665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-08-22T14:37:48.136737Z","caller":"traceutil/trace.go:171","msg":"trace[1164315726] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1808; }","duration":"276.961496ms","start":"2026-08-22T14:37:47.859758Z","end":"2026-08-22T14:37:48.13672Z","steps":["trace[1164315726] 'agreement among raft nodes before linearized reading' (duration: 276.764583ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:48.136984Z","caller":"traceutil/trace.go:171","msg":"trace[1366226059] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1808; }","duration":"195.116946ms","start":"2026-08-22T14:37:47.941848Z","end":"2026-08-22T14:37:48.136965Z","steps":["trace[1366226059] 'agreement among raft nodes before linearized reading' (duration: 194.900403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:37:48.136921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.592079ms","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-22T14:37:48.137194Z","caller":"traceutil/trace.go:171","msg":"trace[1381405431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1808; }","duration":"206.909254ms","start":"2026-08-22T14:37:47.93025Z","end":"2026-08-22T14:37:48.137159Z","steps":["trace[1381405431] 'agreement among raft nodes before linearized reading' (duration: 206.478147ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:48.518309Z","caller":"traceutil/trace.go:171","msg":"trace[1436521446] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"113.029464ms","start":"2026-08-22T14:37:48.405241Z","end":"2026-08-22T14:37:48.51827Z","steps":["trace[1436521446] 'process raft request' (duration: 112.649138ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:53.800669Z","caller":"traceutil/trace.go:171","msg":"trace[566227679] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"126.954686ms","start":"2026-08-22T14:37:53.673688Z","end":"2026-08-22T14:37:53.800642Z","steps":["trace[566227679] 'process raft request' (duration: 126.786804ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:56.058631Z","caller":"traceutil/trace.go:171","msg":"trace[358917133] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"105.845583ms","start":"2026-08-22T14:37:55.952753Z","end":"2026-08-22T14:37:56.058599Z","steps":["trace[358917133] 'process raft request' (duration: 105.675521ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:30.368921Z","caller":"traceutil/trace.go:171","msg":"trace[1805877166] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"189.10724ms","start":"2026-08-22T14:38:30.179769Z","end":"2026-08-22T14:38:30.368876Z","steps":["trace[1805877166] 'process raft request' (duration: 188.882187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.708531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.248471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:38:30.708642Z","caller":"traceutil/trace.go:171","msg":"trace[1292267416] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"335.963406ms","start":"2026-08-22T14:38:30.372658Z","end":"2026-08-22T14:38:30.708622Z","steps":["trace[1292267416] 'process raft request' (duration: 225.541613ms)","trace[1292267416] 'compare' (duration: 110.134668ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:38:30.708705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:38:30.37263Z","time spent":"336.045106ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:38:30.787051Z","caller":"traceutil/trace.go:171","msg":"trace[1432407828] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"411.517488ms","start":"2026-08-22T14:38:30.375504Z","end":"2026-08-22T14:38:30.787022Z","steps":["trace[1432407828] 'process raft request' (duration: 411.294405ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.787201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:38:30.37549Z","time spent":"411.63314ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":536,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:38:30.941683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.736599ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-22T14:38:30.941782Z","caller":"traceutil/trace.go:171","msg":"trace[20551698] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2218; }","duration":"522.966466ms","start":"2026-08-22T14:38:30.418797Z","end":"2026-08-22T14:38:30.941763Z","steps":["trace[20551698] 'read index received' (duration: 179.4186ms)","trace[20551698] 'applied index is now lower than readState.Index' (duration: 343.546556ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:38:30.942033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.21783ms","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-22T14:38:30.942142Z","caller":"traceutil/trace.go:171","msg":"trace[1793973295] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2147; }","duration":"523.343451ms","start":"2026-08-22T14:38:30.418751Z","end":"2026-08-22T14:38:30.942095Z","steps":["trace[1793973295] 'agreement among raft nodes before linearized reading' (duration: 523.117268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.942226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:38:30.418716Z","time spent":"523.471583ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-22T14:38:30.964522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.823834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:38:30.964567Z","caller":"traceutil/trace.go:171","msg":"trace[1369242315] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2148; }","duration":"118.915956ms","start":"2026-08-22T14:38:30.845638Z","end":"2026-08-22T14:38:30.964554Z","steps":["trace[1369242315] 'agreement among raft nodes before linearized reading' (duration: 118.832645ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.964586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.986957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T14:38:30.964622Z","caller":"traceutil/trace.go:171","msg":"trace[1761046216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2148; }","duration":"180.052009ms","start":"2026-08-22T14:38:30.784558Z","end":"2026-08-22T14:38:30.96461Z","steps":["trace[1761046216] 'agreement among raft nodes before linearized reading' (duration: 179.992278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.964621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.421279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T14:38:30.964688Z","caller":"traceutil/trace.go:171","msg":"trace[302216377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2148; }","duration":"118.481759ms","start":"2026-08-22T14:38:30.846184Z","end":"2026-08-22T14:38:30.964666Z","steps":["trace[302216377] 'agreement among raft nodes before linearized reading' (duration: 118.327167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.964523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.365528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-08-22T14:38:30.964735Z","caller":"traceutil/trace.go:171","msg":"trace[459206931] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2148; }","duration":"544.627861ms","start":"2026-08-22T14:38:30.420097Z","end":"2026-08-22T14:38:30.964725Z","steps":["trace[459206931] 'agreement among raft nodes before linearized reading' (duration: 544.329067ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:38:30.964751Z","caller":"traceutil/trace.go:171","msg":"trace[591090311] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"250.465636ms","start":"2026-08-22T14:38:30.714268Z","end":"2026-08-22T14:38:30.964733Z","steps":["trace[591090311] 'process raft request' (duration: 250.048051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.964616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.177766ms","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-22T14:38:30.964796Z","caller":"traceutil/trace.go:171","msg":"trace[1309808010] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2148; }","duration":"116.415279ms","start":"2026-08-22T14:38:30.848371Z","end":"2026-08-22T14:38:30.964787Z","steps":["trace[1309808010] 'agreement among raft nodes before linearized reading' (duration: 116.086365ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:38:30.964767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:38:30.420076Z","time spent":"544.680693ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4614,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-22T14:38:30.964906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.877862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-22T14:38:30.96494Z","caller":"traceutil/trace.go:171","msg":"trace[2049506047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2148; }","duration":"115.935032ms","start":"2026-08-22T14:38:30.848992Z","end":"2026-08-22T14:38:30.964927Z","steps":["trace[2049506047] 'agreement among raft nodes before linearized reading' (duration: 115.872431ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:39:13.059656Z","caller":"traceutil/trace.go:171","msg":"trace[1126461247] linearizableReadLoop","detail":"{readStateIndex:2632; appliedIndex:2631; }","duration":"147.213342ms","start":"2026-08-22T14:39:12.912429Z","end":"2026-08-22T14:39:13.059643Z","steps":["trace[1126461247] 'read index received' (duration: 147.08973ms)","trace[1126461247] 'applied index is now lower than readState.Index' (duration: 123.062µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:39:13.059861Z","caller":"traceutil/trace.go:171","msg":"trace[405069855] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"157.020524ms","start":"2026-08-22T14:39:12.902832Z","end":"2026-08-22T14:39:13.059853Z","steps":["trace[405069855] 'process raft request' (duration: 156.72808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:39:13.060022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.568727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:39:13.060102Z","caller":"traceutil/trace.go:171","msg":"trace[1452757951] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2538; }","duration":"147.678298ms","start":"2026-08-22T14:39:12.912401Z","end":"2026-08-22T14:39:13.060079Z","steps":["trace[1452757951] 'agreement among raft nodes before linearized reading' (duration: 147.525276ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:39:40.802212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.97957ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-22T14:39:40.802466Z","caller":"traceutil/trace.go:171","msg":"trace[1507044631] linearizableReadLoop","detail":"{readStateIndex:2836; appliedIndex:2835; }","duration":"147.421294ms","start":"2026-08-22T14:39:40.655024Z","end":"2026-08-22T14:39:40.802445Z","steps":["trace[1507044631] 'read index received' (duration: 22.183671ms)","trace[1507044631] 'applied index is now lower than readState.Index' (duration: 125.096232ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:39:40.802709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.670968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1377"} {"level":"info","ts":"2026-08-22T14:39:40.802747Z","caller":"traceutil/trace.go:171","msg":"trace[1098173481] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2730; }","duration":"147.755689ms","start":"2026-08-22T14:39:40.654981Z","end":"2026-08-22T14:39:40.802737Z","steps":["trace[1098173481] 'agreement among raft nodes before linearized reading' (duration: 147.525616ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:41:53.674029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.934188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-08-22T14:41:53.67413Z","caller":"traceutil/trace.go:171","msg":"trace[1551243386] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4249; }","duration":"113.088392ms","start":"2026-08-22T14:41:53.56102Z","end":"2026-08-22T14:41:53.674108Z","steps":["trace[1551243386] 'range keys from in-memory index tree' (duration: 112.690992ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:41:53.679643Z","caller":"traceutil/trace.go:171","msg":"trace[39012856] transaction","detail":"{read_only:false; response_revision:4250; number_of_response:1; }","duration":"106.211383ms","start":"2026-08-22T14:41:53.573395Z","end":"2026-08-22T14:41:53.679606Z","steps":["trace[39012856] 'process raft request' (duration: 105.963107ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:41:58.923827Z","caller":"traceutil/trace.go:171","msg":"trace[1731729076] linearizableReadLoop","detail":"{readStateIndex:4550; appliedIndex:4549; }","duration":"112.420355ms","start":"2026-08-22T14:41:58.811387Z","end":"2026-08-22T14:41:58.923807Z","steps":["trace[1731729076] 'read index received' (duration: 112.293282ms)","trace[1731729076] 'applied index is now lower than readState.Index' (duration: 125.903µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:41:58.923865Z","caller":"traceutil/trace.go:171","msg":"trace[32531217] transaction","detail":"{read_only:false; response_revision:4365; number_of_response:1; }","duration":"112.758053ms","start":"2026-08-22T14:41:58.811082Z","end":"2026-08-22T14:41:58.92384Z","steps":["trace[32531217] 'process raft request' (duration: 112.598009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:41:58.924011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.596539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-08-22T14:41:58.924051Z","caller":"traceutil/trace.go:171","msg":"trace[560413604] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4365; }","duration":"112.691732ms","start":"2026-08-22T14:41:58.811351Z","end":"2026-08-22T14:41:58.924042Z","steps":["trace[560413604] 'agreement among raft nodes before linearized reading' (duration: 112.503617ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:41:58.932607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.420809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-08-22T14:41:58.932661Z","caller":"traceutil/trace.go:171","msg":"trace[1736850994] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4366; }","duration":"108.520522ms","start":"2026-08-22T14:41:58.824128Z","end":"2026-08-22T14:41:58.932649Z","steps":["trace[1736850994] 'agreement among raft nodes before linearized reading' (duration: 108.385249ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:41:58.932693Z","caller":"traceutil/trace.go:171","msg":"trace[1034769340] transaction","detail":"{read_only:false; response_revision:4366; number_of_response:1; }","duration":"112.997029ms","start":"2026-08-22T14:41:58.819683Z","end":"2026-08-22T14:41:58.93268Z","steps":["trace[1034769340] 'process raft request' (duration: 112.679071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:41:59.127271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.343065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:41:59.127392Z","caller":"traceutil/trace.go:171","msg":"trace[338576374] linearizableReadLoop","detail":"{readStateIndex:4553; appliedIndex:4552; }","duration":"149.507533ms","start":"2026-08-22T14:41:58.977863Z","end":"2026-08-22T14:41:59.127371Z","steps":["trace[338576374] 'read index received' (duration: 47.078156ms)","trace[338576374] 'applied index is now lower than readState.Index' (duration: 102.427747ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:41:59.127477Z","caller":"traceutil/trace.go:171","msg":"trace[1059988019] transaction","detail":"{read_only:false; response_revision:4368; number_of_response:1; }","duration":"172.848997ms","start":"2026-08-22T14:41:58.954586Z","end":"2026-08-22T14:41:59.127435Z","steps":["trace[1059988019] 'process raft request' (duration: 70.273066ms)","trace[1059988019] 'compare' (duration: 102.188681ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:41:59.127672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.79128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-08-22T14:41:59.127727Z","caller":"traceutil/trace.go:171","msg":"trace[2000891654] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4368; }","duration":"149.876552ms","start":"2026-08-22T14:41:58.977835Z","end":"2026-08-22T14:41:59.127712Z","steps":["trace[2000891654] 'agreement among raft nodes before linearized reading' (duration: 149.649197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:41:59.127967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.392971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-22T14:41:59.12819Z","caller":"traceutil/trace.go:171","msg":"trace[25669140] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4368; }","duration":"149.641646ms","start":"2026-08-22T14:41:58.978531Z","end":"2026-08-22T14:41:59.128172Z","steps":["trace[25669140] 'agreement among raft nodes before linearized reading' (duration: 149.274618ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:04.917026Z","caller":"traceutil/trace.go:171","msg":"trace[1196961269] linearizableReadLoop","detail":"{readStateIndex:4681; appliedIndex:4680; }","duration":"196.788612ms","start":"2026-08-22T14:42:04.720211Z","end":"2026-08-22T14:42:04.917Z","steps":["trace[1196961269] 'read index received' (duration: 196.445914ms)","trace[1196961269] 'applied index is now lower than readState.Index' (duration: 341.828µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:42:04.917188Z","caller":"traceutil/trace.go:171","msg":"trace[548439079] transaction","detail":"{read_only:false; response_revision:4492; number_of_response:1; }","duration":"298.357923ms","start":"2026-08-22T14:42:04.618795Z","end":"2026-08-22T14:42:04.917153Z","steps":["trace[548439079] 'process raft request' (duration: 297.975834ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:04.917251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.995187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-72ae15ee-ff76-4644-83e5-eba8953dd1ee\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-08-22T14:42:04.917313Z","caller":"traceutil/trace.go:171","msg":"trace[590885395] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-72ae15ee-ff76-4644-83e5-eba8953dd1ee; range_end:; response_count:1; response_revision:4492; }","duration":"197.17088ms","start":"2026-08-22T14:42:04.720131Z","end":"2026-08-22T14:42:04.917302Z","steps":["trace[590885395] 'agreement among raft nodes before linearized reading' (duration: 197.027137ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:20.141021Z","caller":"traceutil/trace.go:171","msg":"trace[1918598549] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"402.631127ms","start":"2026-08-22T14:42:19.738364Z","end":"2026-08-22T14:42:20.140995Z","steps":["trace[1918598549] 'process raft request' (duration: 364.809027ms)","trace[1918598549] 'compare' (duration: 37.626326ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:42:20.141255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:19.738343Z","time spent":"402.840462ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":552,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:42:20.141569Z","caller":"traceutil/trace.go:171","msg":"trace[512031185] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"349.67579ms","start":"2026-08-22T14:42:19.79188Z","end":"2026-08-22T14:42:20.141555Z","steps":["trace[512031185] 'process raft request' (duration: 349.085567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:20.141664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:19.791852Z","time spent":"349.778703ms","remote":"127.0.0.1:39676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:42:20.141565Z","caller":"traceutil/trace.go:171","msg":"trace[1676494074] linearizableReadLoop","detail":"{readStateIndex:4890; appliedIndex:4889; }","duration":"384.712928ms","start":"2026-08-22T14:42:19.756818Z","end":"2026-08-22T14:42:20.141531Z","steps":["trace[1676494074] 'read index received' (duration: 346.412478ms)","trace[1676494074] 'applied index is now lower than readState.Index' (duration: 38.29776ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:42:20.141877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.054676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10516"} {"level":"info","ts":"2026-08-22T14:42:20.141932Z","caller":"traceutil/trace.go:171","msg":"trace[259789848] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4695; }","duration":"385.146438ms","start":"2026-08-22T14:42:19.756772Z","end":"2026-08-22T14:42:20.141918Z","steps":["trace[259789848] 'agreement among raft nodes before linearized reading' (duration: 384.998795ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:20.141966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:19.756755Z","time spent":"385.203009ms","remote":"127.0.0.1:39584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10539,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-22T14:42:20.141966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.046306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-22T14:42:20.142023Z","caller":"traceutil/trace.go:171","msg":"trace[781934170] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4695; }","duration":"349.145048ms","start":"2026-08-22T14:42:19.79286Z","end":"2026-08-22T14:42:20.142005Z","steps":["trace[781934170] 'agreement among raft nodes before linearized reading' (duration: 348.987264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:20.142079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:19.792841Z","time spent":"349.22457ms","remote":"127.0.0.1:39556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-22T14:42:20.142242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.625448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-08-22T14:42:20.142288Z","caller":"traceutil/trace.go:171","msg":"trace[1532253093] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4695; }","duration":"126.71454ms","start":"2026-08-22T14:42:20.015562Z","end":"2026-08-22T14:42:20.142276Z","steps":["trace[1532253093] 'agreement among raft nodes before linearized reading' (duration: 126.604218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:20.505308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.704029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:42:20.505617Z","caller":"traceutil/trace.go:171","msg":"trace[102508545] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"167.045717ms","start":"2026-08-22T14:42:20.338546Z","end":"2026-08-22T14:42:20.505591Z","steps":["trace[102508545] 'process raft request' (duration: 21.946579ms)","trace[102508545] 'compare' (duration: 144.523596ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:42:20.505676Z","caller":"traceutil/trace.go:171","msg":"trace[209481532] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"166.959365ms","start":"2026-08-22T14:42:20.338679Z","end":"2026-08-22T14:42:20.505638Z","steps":["trace[209481532] 'process raft request' (duration: 166.756661ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:20.548911Z","caller":"traceutil/trace.go:171","msg":"trace[1264937365] linearizableReadLoop","detail":"{readStateIndex:4909; appliedIndex:4905; }","duration":"120.746524ms","start":"2026-08-22T14:42:20.428144Z","end":"2026-08-22T14:42:20.548891Z","steps":["trace[1264937365] 'read index received' (duration: 62.570133ms)","trace[1264937365] 'applied index is now lower than readState.Index' (duration: 58.175101ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:42:20.549035Z","caller":"traceutil/trace.go:171","msg":"trace[2131029989] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"204.542608ms","start":"2026-08-22T14:42:20.344461Z","end":"2026-08-22T14:42:20.549003Z","steps":["trace[2131029989] 'process raft request' (duration: 204.296393ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:20.549032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.872677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:42:20.549343Z","caller":"traceutil/trace.go:171","msg":"trace[1712814534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4711; }","duration":"121.132893ms","start":"2026-08-22T14:42:20.4281Z","end":"2026-08-22T14:42:20.549233Z","steps":["trace[1712814534] 'agreement among raft nodes before linearized reading' (duration: 120.871247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:43:02.406143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.467812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:43:02.406407Z","caller":"traceutil/trace.go:171","msg":"trace[112743724] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"132.913429ms","start":"2026-08-22T14:43:02.273442Z","end":"2026-08-22T14:43:02.406356Z","steps":["trace[112743724] 'process raft request' (duration: 12.13947ms)","trace[112743724] 'compare' (duration: 120.34836ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:45:32.405188Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3174} {"level":"info","ts":"2026-08-22T14:45:32.524605Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3174,"took":"117.975607ms","hash":1246514298,"current-db-size-bytes":58740736,"current-db-size":"59 MB","current-db-size-in-use-bytes":31514624,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-22T14:45:32.524688Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1246514298,"revision":3174,"compact-revision":-1} {"level":"info","ts":"2026-08-22T14:46:01.741625Z","caller":"traceutil/trace.go:171","msg":"trace[1522467989] transaction","detail":"{read_only:false; response_revision:6627; number_of_response:1; }","duration":"150.491073ms","start":"2026-08-22T14:46:01.591106Z","end":"2026-08-22T14:46:01.741597Z","steps":["trace[1522467989] 'process raft request' (duration: 135.457495ms)","trace[1522467989] 'compare' (duration: 14.715183ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:50:32.411041Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6313} {"level":"info","ts":"2026-08-22T14:50:32.508119Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6313,"took":"95.423981ms","hash":379225853,"current-db-size-bytes":58740736,"current-db-size":"59 MB","current-db-size-in-use-bytes":18513920,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-22T14:50:32.508195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":379225853,"revision":6313,"compact-revision":3174} {"level":"info","ts":"2026-08-22T14:53:22.138486Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"61a3fe3fc9dc5d35","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T14:53:22.144266Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-22T14:53:22.144406Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}