{"level":"warn","ts":"2026-07-27T19:57:52.860706Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T19:57:52.860837Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-07-27T19:57:52.86093Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T19:57:52.860939Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-07-27T19:57:52.860957Z","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-07-27T19:57:52.861703Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-07-27T19:57:52.861787Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-07-27T19:57:52.865677Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.613324ms"} {"level":"info","ts":"2026-07-27T19:57:52.873678Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-07-27T19:57:52.874092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-07-27T19:57:52.874133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-07-27T19:57:52.874149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-27T19:57:52.874168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-07-27T19:57:52.874218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-07-27T19:57:52.882977Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-27T19:57:52.884557Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-27T19:57:52.885636Z","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-07-27T19:57:52.888395Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-27T19:57:52.893874Z","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-07-27T19:57:52.894952Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-27T19:57:52.896952Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-27T19:57:52.897261Z","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-07-27T19:57:52.897315Z","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-07-27T19:57:52.897356Z","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-07-27T19:57:52.897646Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-07-27T19:57:52.897671Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-07-27T19:57:52.898098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-07-27T19:57:52.898464Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-07-27T19:57:52.898703Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-27T19:57:53.474506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-07-27T19:57:53.474566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-27T19:57:53.4746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-07-27T19:57:53.474687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-07-27T19:57:53.474717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-07-27T19:57:53.474743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-07-27T19:57:53.474765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-07-27T19:57:53.476163Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-07-27T19:57:53.476183Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T19:57:53.476207Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:57:53.47629Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T19:57:53.47657Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-27T19:57:53.476656Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-27T19:57:53.477324Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:57:53.477517Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:57:53.477566Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T19:57:53.48Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-27T19:57:53.480333Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-07-27T19:58:08.70629Z","caller":"traceutil/trace.go:171","msg":"trace[1172294117] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"169.821647ms","start":"2026-07-27T19:58:08.536443Z","end":"2026-07-27T19:58:08.706265Z","steps":["trace[1172294117] 'process raft request' (duration: 169.682508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:08.975914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.640099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T19:58:08.97605Z","caller":"traceutil/trace.go:171","msg":"trace[988258570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:370; }","duration":"113.905927ms","start":"2026-07-27T19:58:08.862122Z","end":"2026-07-27T19:58:08.976028Z","steps":["trace[988258570] 'range keys from in-memory index tree' (duration: 113.530358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:08.976176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.105567ms","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-07-27T19:58:08.97626Z","caller":"traceutil/trace.go:171","msg":"trace[713186178] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:370; }","duration":"154.239026ms","start":"2026-07-27T19:58:08.821998Z","end":"2026-07-27T19:58:08.976237Z","steps":["trace[713186178] 'range keys from in-memory index tree' (duration: 153.889945ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:09.19949Z","caller":"traceutil/trace.go:171","msg":"trace[1839462452] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"150.213289ms","start":"2026-07-27T19:58:09.049235Z","end":"2026-07-27T19:58:09.199449Z","steps":["trace[1839462452] 'read index received' (duration: 144.004793ms)","trace[1839462452] 'applied index is now lower than readState.Index' (duration: 6.206816ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T19:58:09.1996Z","caller":"traceutil/trace.go:171","msg":"trace[1999597017] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"158.621309ms","start":"2026-07-27T19:58:09.040899Z","end":"2026-07-27T19:58:09.19952Z","steps":["trace[1999597017] 'process raft request' (duration: 152.260636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:09.19976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.601786ms","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-07-27T19:58:09.199812Z","caller":"traceutil/trace.go:171","msg":"trace[1400126011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:372; }","duration":"147.705738ms","start":"2026-07-27T19:58:09.052093Z","end":"2026-07-27T19:58:09.199798Z","steps":["trace[1400126011] 'agreement among raft nodes before linearized reading' (duration: 147.570539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:09.200074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.663243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-27T19:58:09.200247Z","caller":"traceutil/trace.go:171","msg":"trace[1241217240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"151.009085ms","start":"2026-07-27T19:58:09.049165Z","end":"2026-07-27T19:58:09.200174Z","steps":["trace[1241217240] 'agreement among raft nodes before linearized reading' (duration: 150.520704ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.711755Z","caller":"traceutil/trace.go:171","msg":"trace[1500966516] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"248.122467ms","start":"2026-07-27T19:58:30.463585Z","end":"2026-07-27T19:58:30.711707Z","steps":["trace[1500966516] 'process raft request' (duration: 242.369813ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723082Z","caller":"traceutil/trace.go:171","msg":"trace[1645509463] transaction","detail":"{read_only:false; number_of_response:1; response_revision:503; }","duration":"253.141418ms","start":"2026-07-27T19:58:30.469902Z","end":"2026-07-27T19:58:30.723043Z","steps":["trace[1645509463] 'process raft request' (duration: 252.898126ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723332Z","caller":"traceutil/trace.go:171","msg":"trace[2029570496] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"251.711228ms","start":"2026-07-27T19:58:30.471603Z","end":"2026-07-27T19:58:30.723315Z","steps":["trace[2029570496] 'process raft request' (duration: 251.419348ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723544Z","caller":"traceutil/trace.go:171","msg":"trace[883815369] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"252.749331ms","start":"2026-07-27T19:58:30.470785Z","end":"2026-07-27T19:58:30.723534Z","steps":["trace[883815369] 'process raft request' (duration: 252.165552ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723671Z","caller":"traceutil/trace.go:171","msg":"trace[1478156860] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"241.29903ms","start":"2026-07-27T19:58:30.48236Z","end":"2026-07-27T19:58:30.723659Z","steps":["trace[1478156860] 'process raft request' (duration: 240.833077ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723882Z","caller":"traceutil/trace.go:171","msg":"trace[659270030] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"233.534997ms","start":"2026-07-27T19:58:30.490318Z","end":"2026-07-27T19:58:30.723853Z","steps":["trace[659270030] 'process raft request' (duration: 233.004327ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723958Z","caller":"traceutil/trace.go:171","msg":"trace[1700233780] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"227.727785ms","start":"2026-07-27T19:58:30.496209Z","end":"2026-07-27T19:58:30.723937Z","steps":["trace[1700233780] 'process raft request' (duration: 227.222844ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.724058Z","caller":"traceutil/trace.go:171","msg":"trace[394193266] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"239.661298ms","start":"2026-07-27T19:58:30.484387Z","end":"2026-07-27T19:58:30.724048Z","steps":["trace[394193266] 'process raft request' (duration: 238.876017ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.723989Z","caller":"traceutil/trace.go:171","msg":"trace[1043419106] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"241.778213ms","start":"2026-07-27T19:58:30.482203Z","end":"2026-07-27T19:58:30.723981Z","steps":["trace[1043419106] 'process raft request' (duration: 240.856396ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:30.724198Z","caller":"traceutil/trace.go:171","msg":"trace[1503609813] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"220.738046ms","start":"2026-07-27T19:58:30.50345Z","end":"2026-07-27T19:58:30.724188Z","steps":["trace[1503609813] 'process raft request' (duration: 220.08708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:37.655904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.694169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T19:58:37.656034Z","caller":"traceutil/trace.go:171","msg":"trace[1875178277] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"294.468778ms","start":"2026-07-27T19:58:37.361548Z","end":"2026-07-27T19:58:37.656017Z","steps":["trace[1875178277] 'read index received' (duration: 144.682715ms)","trace[1875178277] 'applied index is now lower than readState.Index' (duration: 149.784743ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T19:58:37.656135Z","caller":"traceutil/trace.go:171","msg":"trace[1319107674] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"307.455057ms","start":"2026-07-27T19:58:37.348624Z","end":"2026-07-27T19:58:37.656079Z","steps":["trace[1319107674] 'process raft request' (duration: 157.575305ms)","trace[1319107674] 'compare' (duration: 148.203412ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T19:58:37.6562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.651464ms","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-07-27T19:58:37.656229Z","caller":"traceutil/trace.go:171","msg":"trace[1031823953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"294.704803ms","start":"2026-07-27T19:58:37.361515Z","end":"2026-07-27T19:58:37.65622Z","steps":["trace[1031823953] 'agreement among raft nodes before linearized reading' (duration: 294.575766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:37.656272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T19:58:37.348604Z","time spent":"307.608812ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T19:58:37.689427Z","caller":"traceutil/trace.go:171","msg":"trace[759572590] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"250.612826ms","start":"2026-07-27T19:58:37.438776Z","end":"2026-07-27T19:58:37.689389Z","steps":["trace[759572590] 'process raft request' (duration: 249.602149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:37.689531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.396624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fz8t5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-27T19:58:37.690258Z","caller":"traceutil/trace.go:171","msg":"trace[125512458] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fz8t5; range_end:; response_count:1; response_revision:597; }","duration":"265.154035ms","start":"2026-07-27T19:58:37.425052Z","end":"2026-07-27T19:58:37.690206Z","steps":["trace[125512458] 'agreement among raft nodes before linearized reading' (duration: 264.336145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:37.690645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.757552ms","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-07-27T19:58:37.690753Z","caller":"traceutil/trace.go:171","msg":"trace[1427081953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"284.86365ms","start":"2026-07-27T19:58:37.405837Z","end":"2026-07-27T19:58:37.6907Z","steps":["trace[1427081953] 'agreement among raft nodes before linearized reading' (duration: 283.523122ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:58:38.342147Z","caller":"traceutil/trace.go:171","msg":"trace[856903956] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"628.741206ms","start":"2026-07-27T19:58:37.713366Z","end":"2026-07-27T19:58:38.342107Z","steps":["trace[856903956] 'process raft request' (duration: 600.469453ms)","trace[856903956] 'compare' (duration: 28.111446ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T19:58:38.342373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T19:58:37.713336Z","time spent":"628.923632ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T19:58:38.372236Z","caller":"traceutil/trace.go:171","msg":"trace[637159796] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"615.322017ms","start":"2026-07-27T19:58:37.756882Z","end":"2026-07-27T19:58:38.372204Z","steps":["trace[637159796] 'process raft request' (duration: 614.763928ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:58:38.372407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T19:58:37.756847Z","time spent":"615.470963ms","remote":"127.0.0.1:38974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T19:58:39.744367Z","caller":"traceutil/trace.go:171","msg":"trace[997373508] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"152.604829ms","start":"2026-07-27T19:58:39.591731Z","end":"2026-07-27T19:58:39.744335Z","steps":["trace[997373508] 'process raft request' (duration: 152.146559ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T19:59:43.989781Z","caller":"traceutil/trace.go:171","msg":"trace[733628818] linearizableReadLoop","detail":"{readStateIndex:1459; appliedIndex:1458; }","duration":"130.191778ms","start":"2026-07-27T19:59:43.859559Z","end":"2026-07-27T19:59:43.989751Z","steps":["trace[733628818] 'read index received' (duration: 129.97998ms)","trace[733628818] 'applied index is now lower than readState.Index' (duration: 211.038µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T19:59:43.989888Z","caller":"traceutil/trace.go:171","msg":"trace[1198287366] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"138.525567ms","start":"2026-07-27T19:59:43.851339Z","end":"2026-07-27T19:59:43.989864Z","steps":["trace[1198287366] 'process raft request' (duration: 138.231695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T19:59:43.989975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.387646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T19:59:43.990137Z","caller":"traceutil/trace.go:171","msg":"trace[446599434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1412; }","duration":"130.602215ms","start":"2026-07-27T19:59:43.859487Z","end":"2026-07-27T19:59:43.990089Z","steps":["trace[446599434] 'agreement among raft nodes before linearized reading' (duration: 130.386506ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:14.875963Z","caller":"traceutil/trace.go:171","msg":"trace[1093509558] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"188.595477ms","start":"2026-07-27T20:00:14.687338Z","end":"2026-07-27T20:00:14.875934Z","steps":["trace[1093509558] 'read index received' (duration: 188.392747ms)","trace[1093509558] 'applied index is now lower than readState.Index' (duration: 201.95µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:00:14.876101Z","caller":"traceutil/trace.go:171","msg":"trace[632601896] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"196.785572ms","start":"2026-07-27T20:00:14.679201Z","end":"2026-07-27T20:00:14.875987Z","steps":["trace[632601896] 'process raft request' (duration: 196.55963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:14.876415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.033091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d70b2fe7-d5c8-4e27-a00b-4dd7047126ca\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-27T20:00:14.876511Z","caller":"traceutil/trace.go:171","msg":"trace[1916276687] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d70b2fe7-d5c8-4e27-a00b-4dd7047126ca; range_end:; response_count:1; response_revision:1848; }","duration":"189.217641ms","start":"2026-07-27T20:00:14.687277Z","end":"2026-07-27T20:00:14.876495Z","steps":["trace[1916276687] 'agreement among raft nodes before linearized reading' (duration: 188.814869ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:16.300764Z","caller":"traceutil/trace.go:171","msg":"trace[1403689997] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"305.868668ms","start":"2026-07-27T20:00:15.99486Z","end":"2026-07-27T20:00:16.300729Z","steps":["trace[1403689997] 'process raft request' (duration: 305.698839ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:16.301092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:15.994833Z","time spent":"306.020336ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:16.303348Z","caller":"traceutil/trace.go:171","msg":"trace[461815471] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"214.025075ms","start":"2026-07-27T20:00:16.089285Z","end":"2026-07-27T20:00:16.30331Z","steps":["trace[461815471] 'process raft request' (duration: 213.74402ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:16.303629Z","caller":"traceutil/trace.go:171","msg":"trace[1883226858] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"184.850829ms","start":"2026-07-27T20:00:16.118763Z","end":"2026-07-27T20:00:16.303614Z","steps":["trace[1883226858] 'process raft request' (duration: 184.447107ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:50.612529Z","caller":"traceutil/trace.go:171","msg":"trace[363106540] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"120.876982ms","start":"2026-07-27T20:00:50.491606Z","end":"2026-07-27T20:00:50.612483Z","steps":["trace[363106540] 'process raft request' (duration: 120.739943ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:50.620584Z","caller":"traceutil/trace.go:171","msg":"trace[6049351] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"120.508299ms","start":"2026-07-27T20:00:50.500049Z","end":"2026-07-27T20:00:50.620558Z","steps":["trace[6049351] 'read index received' (duration: 113.024442ms)","trace[6049351] 'applied index is now lower than readState.Index' (duration: 7.482656ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:00:50.620712Z","caller":"traceutil/trace.go:171","msg":"trace[1575243058] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"126.977691ms","start":"2026-07-27T20:00:50.493723Z","end":"2026-07-27T20:00:50.620701Z","steps":["trace[1575243058] 'process raft request' (duration: 126.680102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:50.621104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.123357ms","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-07-27T20:00:50.621192Z","caller":"traceutil/trace.go:171","msg":"trace[1483985603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2102; }","duration":"118.237495ms","start":"2026-07-27T20:00:50.502935Z","end":"2026-07-27T20:00:50.621172Z","steps":["trace[1483985603] 'agreement among raft nodes before linearized reading' (duration: 118.03146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:50.621565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.517494ms","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-07-27T20:00:50.621591Z","caller":"traceutil/trace.go:171","msg":"trace[727353531] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2102; }","duration":"121.573398ms","start":"2026-07-27T20:00:50.500012Z","end":"2026-07-27T20:00:50.621586Z","steps":["trace[727353531] 'agreement among raft nodes before linearized reading' (duration: 121.520714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:51.139117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.908536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:00:51.139501Z","caller":"traceutil/trace.go:171","msg":"trace[494217606] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2184; }","duration":"215.184265ms","start":"2026-07-27T20:00:50.924293Z","end":"2026-07-27T20:00:51.139477Z","steps":["trace[494217606] 'read index received' (duration: 36.736203ms)","trace[494217606] 'applied index is now lower than readState.Index' (duration: 178.447052ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:00:51.13976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.471754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-27T20:00:51.139793Z","caller":"traceutil/trace.go:171","msg":"trace[1792528063] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2106; }","duration":"215.504966ms","start":"2026-07-27T20:00:50.924275Z","end":"2026-07-27T20:00:51.13978Z","steps":["trace[1792528063] 'agreement among raft nodes before linearized reading' (duration: 215.273271ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:51.139838Z","caller":"traceutil/trace.go:171","msg":"trace[819044866] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"513.366031ms","start":"2026-07-27T20:00:50.626432Z","end":"2026-07-27T20:00:51.139798Z","steps":["trace[819044866] 'process raft request' (duration: 512.966345ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:00:51.139842Z","caller":"traceutil/trace.go:171","msg":"trace[1679256377] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"513.442805ms","start":"2026-07-27T20:00:50.626352Z","end":"2026-07-27T20:00:51.139794Z","steps":["trace[1679256377] 'process raft request' (duration: 512.916112ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:51.140042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:50.626405Z","time spent":"513.52591ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:00:51.140071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:50.626339Z","time spent":"513.626007ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:51.140045Z","caller":"traceutil/trace.go:171","msg":"trace[135079092] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"512.085289ms","start":"2026-07-27T20:00:50.627946Z","end":"2026-07-27T20:00:51.140032Z","steps":["trace[135079092] 'process raft request' (duration: 511.494401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:00:51.140241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:50.627934Z","time spent":"512.280891ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:51.140333Z","caller":"traceutil/trace.go:171","msg":"trace[1509846150] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"514.191363ms","start":"2026-07-27T20:00:50.626128Z","end":"2026-07-27T20:00:51.14032Z","steps":["trace[1509846150] 'process raft request' (duration: 242.900368ms)","trace[1509846150] 'compare' (duration: 269.535442ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:00:51.140405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:00:50.626103Z","time spent":"514.264358ms","remote":"127.0.0.1:39000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:00:51.146461Z","caller":"traceutil/trace.go:171","msg":"trace[1217120558] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"131.177244ms","start":"2026-07-27T20:00:51.015262Z","end":"2026-07-27T20:00:51.146439Z","steps":["trace[1217120558] 'process raft request' (duration: 131.065377ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:01:53.57152Z","caller":"traceutil/trace.go:171","msg":"trace[1562163825] transaction","detail":"{read_only:false; response_revision:2543; number_of_response:1; }","duration":"176.716237ms","start":"2026-07-27T20:01:53.394781Z","end":"2026-07-27T20:01:53.571497Z","steps":["trace[1562163825] 'process raft request' (duration: 176.20475ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:25.694648Z","caller":"traceutil/trace.go:171","msg":"trace[1668950709] linearizableReadLoop","detail":"{readStateIndex:2823; appliedIndex:2822; }","duration":"161.459146ms","start":"2026-07-27T20:02:25.533172Z","end":"2026-07-27T20:02:25.694631Z","steps":["trace[1668950709] 'read index received' (duration: 161.399858ms)","trace[1668950709] 'applied index is now lower than readState.Index' (duration: 58.198µs)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:02:25.694769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.583892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:02:25.694786Z","caller":"traceutil/trace.go:171","msg":"trace[1798639985] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"213.297185ms","start":"2026-07-27T20:02:25.481443Z","end":"2026-07-27T20:02:25.69474Z","steps":["trace[1798639985] 'process raft request' (duration: 213.085043ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:25.694834Z","caller":"traceutil/trace.go:171","msg":"trace[552328765] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2719; }","duration":"161.62164ms","start":"2026-07-27T20:02:25.533164Z","end":"2026-07-27T20:02:25.694786Z","steps":["trace[552328765] 'agreement among raft nodes before linearized reading' (duration: 161.543553ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:25.924866Z","caller":"traceutil/trace.go:171","msg":"trace[317176225] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"148.557286ms","start":"2026-07-27T20:02:25.776281Z","end":"2026-07-27T20:02:25.924839Z","steps":["trace[317176225] 'process raft request' (duration: 148.376874ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:26.063506Z","caller":"traceutil/trace.go:171","msg":"trace[1984415335] linearizableReadLoop","detail":"{readStateIndex:2829; appliedIndex:2824; }","duration":"202.136618ms","start":"2026-07-27T20:02:25.861306Z","end":"2026-07-27T20:02:26.063443Z","steps":["trace[1984415335] 'read index received' (duration: 63.365116ms)","trace[1984415335] 'applied index is now lower than readState.Index' (duration: 138.769872ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:02:26.063577Z","caller":"traceutil/trace.go:171","msg":"trace[588584924] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"286.370179ms","start":"2026-07-27T20:02:25.777161Z","end":"2026-07-27T20:02:26.063531Z","steps":["trace[588584924] 'process raft request' (duration: 286.149558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:26.063781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.426496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:02:26.063918Z","caller":"traceutil/trace.go:171","msg":"trace[1886477940] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"287.603396ms","start":"2026-07-27T20:02:25.7763Z","end":"2026-07-27T20:02:26.063903Z","steps":["trace[1886477940] 'process raft request' (duration: 282.301824ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:26.063896Z","caller":"traceutil/trace.go:171","msg":"trace[1532861957] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"286.506363ms","start":"2026-07-27T20:02:25.77735Z","end":"2026-07-27T20:02:26.063856Z","steps":["trace[1532861957] 'process raft request' (duration: 286.015743ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:26.064292Z","caller":"traceutil/trace.go:171","msg":"trace[708165891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2725; }","duration":"202.586779ms","start":"2026-07-27T20:02:25.861252Z","end":"2026-07-27T20:02:26.063839Z","steps":["trace[708165891] 'agreement among raft nodes before linearized reading' (duration: 202.3272ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:26.064358Z","caller":"traceutil/trace.go:171","msg":"trace[903475829] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"286.439506ms","start":"2026-07-27T20:02:25.777904Z","end":"2026-07-27T20:02:26.064344Z","steps":["trace[903475829] 'process raft request' (duration: 285.492945ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:02:31.283121Z","caller":"traceutil/trace.go:171","msg":"trace[723235825] linearizableReadLoop","detail":"{readStateIndex:2856; appliedIndex:2855; }","duration":"175.000937ms","start":"2026-07-27T20:02:31.108079Z","end":"2026-07-27T20:02:31.28308Z","steps":["trace[723235825] 'read index received' (duration: 171.349052ms)","trace[723235825] 'applied index is now lower than readState.Index' (duration: 3.650555ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:02:31.283173Z","caller":"traceutil/trace.go:171","msg":"trace[817850203] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"194.254163ms","start":"2026-07-27T20:02:31.088885Z","end":"2026-07-27T20:02:31.283139Z","steps":["trace[817850203] 'process raft request' (duration: 190.643877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:02:31.283401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.293676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-27T20:02:31.28347Z","caller":"traceutil/trace.go:171","msg":"trace[1584369415] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2751; }","duration":"175.438231ms","start":"2026-07-27T20:02:31.108015Z","end":"2026-07-27T20:02:31.283453Z","steps":["trace[1584369415] 'agreement among raft nodes before linearized reading' (duration: 175.19601ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:20.969303Z","caller":"traceutil/trace.go:171","msg":"trace[2082575525] linearizableReadLoop","detail":"{readStateIndex:4854; appliedIndex:4853; }","duration":"111.273364ms","start":"2026-07-27T20:06:20.858007Z","end":"2026-07-27T20:06:20.96928Z","steps":["trace[2082575525] 'read index received' (duration: 111.169659ms)","trace[2082575525] 'applied index is now lower than readState.Index' (duration: 102.495µs)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:20.969434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.408441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:06:20.969464Z","caller":"traceutil/trace.go:171","msg":"trace[917039965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4672; }","duration":"111.499835ms","start":"2026-07-27T20:06:20.857957Z","end":"2026-07-27T20:06:20.969456Z","steps":["trace[917039965] 'agreement among raft nodes before linearized reading' (duration: 111.406981ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:20.969701Z","caller":"traceutil/trace.go:171","msg":"trace[515384751] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"112.891259ms","start":"2026-07-27T20:06:20.856793Z","end":"2026-07-27T20:06:20.969685Z","steps":["trace[515384751] 'process raft request' (duration: 112.343094ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:38.941822Z","caller":"traceutil/trace.go:171","msg":"trace[128444379] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"565.310148ms","start":"2026-07-27T20:06:38.376478Z","end":"2026-07-27T20:06:38.941788Z","steps":["trace[128444379] 'process raft request' (duration: 554.135711ms)","trace[128444379] 'compare' (duration: 10.723505ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:38.942078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:06:38.376449Z","time spent":"565.473155ms","remote":"127.0.0.1:39006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1562,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:06:38.970917Z","caller":"traceutil/trace.go:171","msg":"trace[1290460359] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"590.094757ms","start":"2026-07-27T20:06:38.380783Z","end":"2026-07-27T20:06:38.970878Z","steps":["trace[1290460359] 'process raft request' (duration: 589.931849ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:38.970916Z","caller":"traceutil/trace.go:171","msg":"trace[1493460053] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"594.379674ms","start":"2026-07-27T20:06:38.376478Z","end":"2026-07-27T20:06:38.970858Z","steps":["trace[1493460053] 'process raft request' (duration: 594.067579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:38.97117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:06:38.376462Z","time spent":"594.647537ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":991,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:06:38.971615Z","caller":"traceutil/trace.go:171","msg":"trace[1112531118] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"239.040704ms","start":"2026-07-27T20:06:38.73256Z","end":"2026-07-27T20:06:38.971601Z","steps":["trace[1112531118] 'process raft request' (duration: 238.216234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:38.971504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:06:38.380772Z","time spent":"590.282947ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:06:38.972125Z","caller":"traceutil/trace.go:171","msg":"trace[1665797756] linearizableReadLoop","detail":"{readStateIndex:5119; appliedIndex:5115; }","duration":"110.635206ms","start":"2026-07-27T20:06:38.86148Z","end":"2026-07-27T20:06:38.972115Z","steps":["trace[1665797756] 'read index received' (duration: 69.154643ms)","trace[1665797756] 'applied index is now lower than readState.Index' (duration: 41.479673ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:38.972191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.705469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:06:38.972222Z","caller":"traceutil/trace.go:171","msg":"trace[739246635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4930; }","duration":"110.789942ms","start":"2026-07-27T20:06:38.861425Z","end":"2026-07-27T20:06:38.972215Z","steps":["trace[739246635] 'agreement among raft nodes before linearized reading' (duration: 110.72932ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.152192Z","caller":"traceutil/trace.go:171","msg":"trace[1952111184] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"167.058852ms","start":"2026-07-27T20:06:38.985002Z","end":"2026-07-27T20:06:39.152061Z","steps":["trace[1952111184] 'process raft request' (duration: 107.441901ms)","trace[1952111184] 'compare' (duration: 58.665855ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:39.152702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.700658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10395"} {"level":"info","ts":"2026-07-27T20:06:39.152855Z","caller":"traceutil/trace.go:171","msg":"trace[700921732] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4931; }","duration":"111.930929ms","start":"2026-07-27T20:06:39.040893Z","end":"2026-07-27T20:06:39.152824Z","steps":["trace[700921732] 'agreement among raft nodes before linearized reading' (duration: 111.53778ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.152759Z","caller":"traceutil/trace.go:171","msg":"trace[950943558] linearizableReadLoop","detail":"{readStateIndex:5121; appliedIndex:5120; }","duration":"110.974563ms","start":"2026-07-27T20:06:39.040973Z","end":"2026-07-27T20:06:39.151948Z","steps":["trace[950943558] 'read index received' (duration: 51.176944ms)","trace[950943558] 'applied index is now lower than readState.Index' (duration: 59.795319ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:39.153817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.331908ms","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-07-27T20:06:39.154117Z","caller":"traceutil/trace.go:171","msg":"trace[905392316] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4931; }","duration":"107.452374ms","start":"2026-07-27T20:06:39.046417Z","end":"2026-07-27T20:06:39.15387Z","steps":["trace[905392316] 'agreement among raft nodes before linearized reading' (duration: 106.73014ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.469131Z","caller":"traceutil/trace.go:171","msg":"trace[1682567619] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5121; }","duration":"193.662335ms","start":"2026-07-27T20:06:39.275433Z","end":"2026-07-27T20:06:39.469095Z","steps":["trace[1682567619] 'read index received' (duration: 95.981412ms)","trace[1682567619] 'applied index is now lower than readState.Index' (duration: 97.679173ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:06:39.469222Z","caller":"traceutil/trace.go:171","msg":"trace[1045002881] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"301.754249ms","start":"2026-07-27T20:06:39.167428Z","end":"2026-07-27T20:06:39.469182Z","steps":["trace[1045002881] 'process raft request' (duration: 204.075636ms)","trace[1045002881] 'compare' (duration: 97.320986ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:39.469405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:06:39.167402Z","time spent":"301.900726ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:06:39.469685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.392172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-27T20:06:39.469733Z","caller":"traceutil/trace.go:171","msg":"trace[763838383] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4932; }","duration":"155.491047ms","start":"2026-07-27T20:06:39.31423Z","end":"2026-07-27T20:06:39.469721Z","steps":["trace[763838383] 'agreement among raft nodes before linearized reading' (duration: 155.333799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:39.469752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.274905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-fz9tk.18c63e47ab4ab59a\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-07-27T20:06:39.469926Z","caller":"traceutil/trace.go:171","msg":"trace[1417664560] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-fz9tk.18c63e47ab4ab59a; range_end:; response_count:1; response_revision:4932; }","duration":"194.537788ms","start":"2026-07-27T20:06:39.27537Z","end":"2026-07-27T20:06:39.469908Z","steps":["trace[1417664560] 'agreement among raft nodes before linearized reading' (duration: 193.919337ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.672212Z","caller":"traceutil/trace.go:171","msg":"trace[1588037212] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"194.096767ms","start":"2026-07-27T20:06:39.478075Z","end":"2026-07-27T20:06:39.672172Z","steps":["trace[1588037212] 'process raft request' (duration: 95.30634ms)","trace[1588037212] 'compare' (duration: 98.463951ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:06:39.673017Z","caller":"traceutil/trace.go:171","msg":"trace[1681193120] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"194.802919ms","start":"2026-07-27T20:06:39.478185Z","end":"2026-07-27T20:06:39.672988Z","steps":["trace[1681193120] 'process raft request' (duration: 193.892976ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.673317Z","caller":"traceutil/trace.go:171","msg":"trace[1178047675] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"194.996759ms","start":"2026-07-27T20:06:39.478297Z","end":"2026-07-27T20:06:39.673294Z","steps":["trace[1178047675] 'process raft request' (duration: 194.642772ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.673453Z","caller":"traceutil/trace.go:171","msg":"trace[2105665069] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"194.830141ms","start":"2026-07-27T20:06:39.478614Z","end":"2026-07-27T20:06:39.673444Z","steps":["trace[2105665069] 'process raft request' (duration: 194.683084ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.673541Z","caller":"traceutil/trace.go:171","msg":"trace[2123274379] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"195.23641ms","start":"2026-07-27T20:06:39.478295Z","end":"2026-07-27T20:06:39.673531Z","steps":["trace[2123274379] 'process raft request' (duration: 194.867852ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.673495Z","caller":"traceutil/trace.go:171","msg":"trace[1167797949] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"192.416724ms","start":"2026-07-27T20:06:39.481051Z","end":"2026-07-27T20:06:39.673467Z","steps":["trace[1167797949] 'process raft request' (duration: 192.368742ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.67358Z","caller":"traceutil/trace.go:171","msg":"trace[706363143] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"194.592089ms","start":"2026-07-27T20:06:39.47898Z","end":"2026-07-27T20:06:39.673572Z","steps":["trace[706363143] 'process raft request' (duration: 194.351827ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.673606Z","caller":"traceutil/trace.go:171","msg":"trace[881498007] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"195.157087ms","start":"2026-07-27T20:06:39.478409Z","end":"2026-07-27T20:06:39.673566Z","steps":["trace[881498007] 'process raft request' (duration: 194.844602ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.673715Z","caller":"traceutil/trace.go:171","msg":"trace[1628776607] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"193.304437ms","start":"2026-07-27T20:06:39.480401Z","end":"2026-07-27T20:06:39.673706Z","steps":["trace[1628776607] 'process raft request' (duration: 192.972741ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:53.506388Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2867} {"level":"info","ts":"2026-07-27T20:07:53.604641Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2867,"took":"96.595877ms","hash":3736520620,"current-db-size-bytes":52805632,"current-db-size":"53 MB","current-db-size-in-use-bytes":28921856,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-27T20:07:53.604724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3736520620,"revision":2867,"compact-revision":-1} {"level":"info","ts":"2026-07-27T20:12:53.512313Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5539} {"level":"info","ts":"2026-07-27T20:12:53.591612Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5539,"took":"77.675511ms","hash":3177211959,"current-db-size-bytes":52805632,"current-db-size":"53 MB","current-db-size-in-use-bytes":18391040,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-27T20:12:53.591691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3177211959,"revision":5539,"compact-revision":2867}