{"level":"warn","ts":"2026-04-18T01:25:01.75593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T01:25:01.756033Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-04-18T01:25:01.756106Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T01:25:01.756117Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-18T01:25:01.756145Z","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-04-18T01:25:01.756738Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-04-18T01:25:01.756812Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-04-18T01:25:01.761234Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.205242ms"} {"level":"info","ts":"2026-04-18T01:25:01.777334Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-04-18T01:25:01.777412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T01:25:01.777435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-04-18T01:25:01.777459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T01:25:01.777471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-04-18T01:25:01.777519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-04-18T01:25:01.783414Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T01:25:01.785143Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T01:25:01.786275Z","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-04-18T01:25:01.788371Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T01:25:01.791661Z","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-04-18T01:25:01.789987Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T01:25:01.792193Z","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-04-18T01:25:01.792231Z","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-04-18T01:25:01.792685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-04-18T01:25:01.792845Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-18T01:25:01.793055Z","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-04-18T01:25:01.793168Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-18T01:25:01.793218Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-18T01:25:01.794455Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T01:25:01.794504Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T01:25:02.178743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T01:25:02.178795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T01:25:02.17882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-04-18T01:25:02.17883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-04-18T01:25:02.178835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-18T01:25:02.178846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-04-18T01:25:02.178852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-18T01:25:02.186185Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:25:02.186282Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T01:25:02.186301Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T01:25:02.186504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T01:25:02.186831Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T01:25:02.187015Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T01:25:02.189084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-04-18T01:25:02.190754Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:25:02.190838Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:25:02.190863Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:25:02.191475Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T01:25:04.849594Z","caller":"traceutil/trace.go:171","msg":"trace[1713672410] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"190.270112ms","start":"2026-04-18T01:25:04.659294Z","end":"2026-04-18T01:25:04.849565Z","steps":["trace[1713672410] 'read index received' (duration: 190.082259ms)","trace[1713672410] 'applied index is now lower than readState.Index' (duration: 186.863µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:25:04.84971Z","caller":"traceutil/trace.go:171","msg":"trace[1408849604] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"191.284855ms","start":"2026-04-18T01:25:04.658361Z","end":"2026-04-18T01:25:04.849645Z","steps":["trace[1408849604] 'process raft request' (duration: 191.030217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:04.849882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.555053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T01:25:04.849953Z","caller":"traceutil/trace.go:171","msg":"trace[1384129884] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:72; }","duration":"190.677582ms","start":"2026-04-18T01:25:04.659261Z","end":"2026-04-18T01:25:04.849939Z","steps":["trace[1384129884] 'agreement among raft nodes before linearized reading' (duration: 190.479388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:04.85005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.480656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T01:25:04.850099Z","caller":"traceutil/trace.go:171","msg":"trace[991087758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"183.572563ms","start":"2026-04-18T01:25:04.666513Z","end":"2026-04-18T01:25:04.850085Z","steps":["trace[991087758] 'agreement among raft nodes before linearized reading' (duration: 183.468375ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:05.050451Z","caller":"traceutil/trace.go:171","msg":"trace[1951670255] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"149.485253ms","start":"2026-04-18T01:25:04.90094Z","end":"2026-04-18T01:25:05.050425Z","steps":["trace[1951670255] 'process raft request' (duration: 144.874966ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:05.050889Z","caller":"traceutil/trace.go:171","msg":"trace[1817804064] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"106.68295ms","start":"2026-04-18T01:25:04.944161Z","end":"2026-04-18T01:25:05.050844Z","steps":["trace[1817804064] 'process raft request' (duration: 106.429542ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.5986Z","caller":"traceutil/trace.go:171","msg":"trace[596666992] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"145.176243ms","start":"2026-04-18T01:25:32.453394Z","end":"2026-04-18T01:25:32.59857Z","steps":["trace[596666992] 'process raft request' (duration: 145.053702ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610215Z","caller":"traceutil/trace.go:171","msg":"trace[371696438] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"143.032953ms","start":"2026-04-18T01:25:32.467132Z","end":"2026-04-18T01:25:32.610165Z","steps":["trace[371696438] 'process raft request' (duration: 142.821395ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610256Z","caller":"traceutil/trace.go:171","msg":"trace[984673878] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"139.818489ms","start":"2026-04-18T01:25:32.4704Z","end":"2026-04-18T01:25:32.610218Z","steps":["trace[984673878] 'process raft request' (duration: 139.645104ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610427Z","caller":"traceutil/trace.go:171","msg":"trace[1281385432] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"153.303442ms","start":"2026-04-18T01:25:32.457088Z","end":"2026-04-18T01:25:32.610392Z","steps":["trace[1281385432] 'process raft request' (duration: 152.673227ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.61045Z","caller":"traceutil/trace.go:171","msg":"trace[279455606] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"141.869131ms","start":"2026-04-18T01:25:32.468572Z","end":"2026-04-18T01:25:32.610441Z","steps":["trace[279455606] 'process raft request' (duration: 141.424132ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610552Z","caller":"traceutil/trace.go:171","msg":"trace[1059385959] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"124.820423ms","start":"2026-04-18T01:25:32.485725Z","end":"2026-04-18T01:25:32.610545Z","steps":["trace[1059385959] 'process raft request' (duration: 124.548099ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610551Z","caller":"traceutil/trace.go:171","msg":"trace[532297588] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"126.275021ms","start":"2026-04-18T01:25:32.484269Z","end":"2026-04-18T01:25:32.610544Z","steps":["trace[532297588] 'process raft request' (duration: 125.870075ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610611Z","caller":"traceutil/trace.go:171","msg":"trace[1178733560] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"138.68934ms","start":"2026-04-18T01:25:32.471885Z","end":"2026-04-18T01:25:32.610574Z","steps":["trace[1178733560] 'process raft request' (duration: 138.210677ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610667Z","caller":"traceutil/trace.go:171","msg":"trace[472184991] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"100.336206ms","start":"2026-04-18T01:25:32.510302Z","end":"2026-04-18T01:25:32.610638Z","steps":["trace[472184991] 'process raft request' (duration: 100.203625ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610748Z","caller":"traceutil/trace.go:171","msg":"trace[528656469] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"120.375429ms","start":"2026-04-18T01:25:32.490293Z","end":"2026-04-18T01:25:32.610669Z","steps":["trace[528656469] 'process raft request' (duration: 120.061061ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:32.610739Z","caller":"traceutil/trace.go:171","msg":"trace[244817589] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"143.750166ms","start":"2026-04-18T01:25:32.466922Z","end":"2026-04-18T01:25:32.610672Z","steps":["trace[244817589] 'process raft request' (duration: 142.976598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:39.031953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.585389ms","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-04-18T01:25:39.032025Z","caller":"traceutil/trace.go:171","msg":"trace[1778338288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"230.762554ms","start":"2026-04-18T01:25:38.801248Z","end":"2026-04-18T01:25:39.03201Z","steps":["trace[1778338288] 'range keys from in-memory index tree' (duration: 230.37736ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:39.315186Z","caller":"traceutil/trace.go:171","msg":"trace[96957862] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"278.700644ms","start":"2026-04-18T01:25:39.036464Z","end":"2026-04-18T01:25:39.315165Z","steps":["trace[96957862] 'process raft request' (duration: 278.515697ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:39.51318Z","caller":"traceutil/trace.go:171","msg":"trace[1701735013] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"476.314908ms","start":"2026-04-18T01:25:39.036844Z","end":"2026-04-18T01:25:39.513159Z","steps":["trace[1701735013] 'process raft request' (duration: 476.142333ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:39.513592Z","caller":"traceutil/trace.go:171","msg":"trace[293573498] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"469.30118ms","start":"2026-04-18T01:25:39.044256Z","end":"2026-04-18T01:25:39.513557Z","steps":["trace[293573498] 'process raft request' (duration: 468.85561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:39.513697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:25:39.036821Z","time spent":"476.427829ms","remote":"127.0.0.1:40620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T01:25:39.513777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:25:39.044238Z","time spent":"469.436833ms","remote":"127.0.0.1:40514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:25:39.514848Z","caller":"traceutil/trace.go:171","msg":"trace[534197972] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:593; }","duration":"245.567078ms","start":"2026-04-18T01:25:39.269263Z","end":"2026-04-18T01:25:39.51483Z","steps":["trace[534197972] 'read index received' (duration: 45.771185ms)","trace[534197972] 'applied index is now lower than readState.Index' (duration: 199.795003ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:25:39.514947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.681208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:25:39.514985Z","caller":"traceutil/trace.go:171","msg":"trace[2001492691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"245.748475ms","start":"2026-04-18T01:25:39.269225Z","end":"2026-04-18T01:25:39.514974Z","steps":["trace[2001492691] 'agreement among raft nodes before linearized reading' (duration: 245.667907ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:25:39.515031Z","caller":"traceutil/trace.go:171","msg":"trace[688378509] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"447.638058ms","start":"2026-04-18T01:25:39.067374Z","end":"2026-04-18T01:25:39.515012Z","steps":["trace[688378509] 'process raft request' (duration: 446.754858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:39.515134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:25:39.067352Z","time spent":"447.725956ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:25:39.883521Z","caller":"traceutil/trace.go:171","msg":"trace[373717940] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"299.109162ms","start":"2026-04-18T01:25:39.584388Z","end":"2026-04-18T01:25:39.883497Z","steps":["trace[373717940] 'process raft request' (duration: 298.935816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:40.276448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.601704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:25:40.276664Z","caller":"traceutil/trace.go:171","msg":"trace[2062357164] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"203.186817ms","start":"2026-04-18T01:25:40.073457Z","end":"2026-04-18T01:25:40.276644Z","steps":["trace[2062357164] 'read index received' (duration: 29.11965ms)","trace[2062357164] 'applied index is now lower than readState.Index' (duration: 174.065657ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:25:40.276794Z","caller":"traceutil/trace.go:171","msg":"trace[1773566611] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"377.467359ms","start":"2026-04-18T01:25:39.899314Z","end":"2026-04-18T01:25:40.276781Z","steps":["trace[1773566611] 'process raft request' (duration: 203.259049ms)","trace[1773566611] 'compare' (duration: 173.424299ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:25:40.276897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:25:39.89929Z","time spent":"377.577451ms","remote":"127.0.0.1:40514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T01:25:40.277243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.769859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-18T01:25:40.277341Z","caller":"traceutil/trace.go:171","msg":"trace[641214317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"203.925373ms","start":"2026-04-18T01:25:40.073397Z","end":"2026-04-18T01:25:40.277322Z","steps":["trace[641214317] 'agreement among raft nodes before linearized reading' (duration: 203.546959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:25:55.268641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.976302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:25:55.269398Z","caller":"traceutil/trace.go:171","msg":"trace[1272379729] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"253.276912ms","start":"2026-04-18T01:25:55.015719Z","end":"2026-04-18T01:25:55.268996Z","steps":["trace[1272379729] 'process raft request' (duration: 72.822734ms)","trace[1272379729] 'compare' (duration: 179.821757ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:25:55.268815Z","caller":"traceutil/trace.go:171","msg":"trace[30010047] linearizableReadLoop","detail":"{readStateIndex:761; appliedIndex:760; }","duration":"134.694197ms","start":"2026-04-18T01:25:55.134075Z","end":"2026-04-18T01:25:55.268769Z","steps":["trace[30010047] 'read index received' (duration: 34.473µs)","trace[30010047] 'applied index is now lower than readState.Index' (duration: 134.658354ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:25:55.270267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.127933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rtgfd\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-18T01:25:55.270388Z","caller":"traceutil/trace.go:171","msg":"trace[1965929314] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rtgfd; range_end:; response_count:1; response_revision:737; }","duration":"136.333813ms","start":"2026-04-18T01:25:55.134024Z","end":"2026-04-18T01:25:55.270358Z","steps":["trace[1965929314] 'agreement among raft nodes before linearized reading' (duration: 135.090405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:12.679744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.800398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-643d7126-91c5-49f9-882c-ced68a17f64e\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-18T01:27:12.679845Z","caller":"traceutil/trace.go:171","msg":"trace[388965414] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-643d7126-91c5-49f9-882c-ced68a17f64e; range_end:; response_count:1; response_revision:1832; }","duration":"153.95472ms","start":"2026-04-18T01:27:12.525868Z","end":"2026-04-18T01:27:12.679822Z","steps":["trace[388965414] 'range keys from in-memory index tree' (duration: 153.636834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:12.679829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.379074ms","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":"warn","ts":"2026-04-18T01:27:12.679941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.830539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-643d7126-91c5-49f9-882c-ced68a17f64e\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-18T01:27:12.680035Z","caller":"traceutil/trace.go:171","msg":"trace[1499153705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1832; }","duration":"223.598819ms","start":"2026-04-18T01:27:12.456373Z","end":"2026-04-18T01:27:12.679972Z","steps":["trace[1499153705] 'range keys from in-memory index tree' (duration: 223.198519ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:12.680035Z","caller":"traceutil/trace.go:171","msg":"trace[1175325927] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-643d7126-91c5-49f9-882c-ced68a17f64e; range_end:; response_count:1; response_revision:1832; }","duration":"304.976032ms","start":"2026-04-18T01:27:12.375043Z","end":"2026-04-18T01:27:12.680019Z","steps":["trace[1175325927] 'range keys from in-memory index tree' (duration: 304.37771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:12.680108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:27:12.375021Z","time spent":"305.074674ms","remote":"127.0.0.1:40514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-643d7126-91c5-49f9-882c-ced68a17f64e\" "} {"level":"warn","ts":"2026-04-18T01:27:12.680291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.215017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T01:27:12.68038Z","caller":"traceutil/trace.go:171","msg":"trace[1637879471] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1832; }","duration":"176.408751ms","start":"2026-04-18T01:27:12.50394Z","end":"2026-04-18T01:27:12.680349Z","steps":["trace[1637879471] 'count revisions from in-memory index tree' (duration: 176.103265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:13.089718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.683164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:27:13.089919Z","caller":"traceutil/trace.go:171","msg":"trace[1292119509] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"107.201886ms","start":"2026-04-18T01:27:12.982696Z","end":"2026-04-18T01:27:13.089898Z","steps":["trace[1292119509] 'process raft request' (duration: 107.130594ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:13.089994Z","caller":"traceutil/trace.go:171","msg":"trace[630451157] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"309.853274ms","start":"2026-04-18T01:27:12.780111Z","end":"2026-04-18T01:27:13.089965Z","steps":["trace[630451157] 'read index received' (duration: 94.861804ms)","trace[630451157] 'applied index is now lower than readState.Index' (duration: 214.98997ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:27:13.090443Z","caller":"traceutil/trace.go:171","msg":"trace[761706529] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"334.736714ms","start":"2026-04-18T01:27:12.755667Z","end":"2026-04-18T01:27:13.090404Z","steps":["trace[761706529] 'process raft request' (duration: 119.264345ms)","trace[761706529] 'compare' (duration: 214.557499ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:27:13.090518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.385455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:27:13.09056Z","caller":"traceutil/trace.go:171","msg":"trace[1154238930] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1836; }","duration":"310.489057ms","start":"2026-04-18T01:27:12.780059Z","end":"2026-04-18T01:27:13.090548Z","steps":["trace[1154238930] 'agreement among raft nodes before linearized reading' (duration: 310.399905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:13.090595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:27:12.780034Z","time spent":"310.551858ms","remote":"127.0.0.1:51578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-04-18T01:27:13.090618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:27:12.755632Z","time spent":"334.887948ms","remote":"127.0.0.1:40514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10969,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T01:27:13.091664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.507983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-18T01:27:13.091773Z","caller":"traceutil/trace.go:171","msg":"trace[471832644] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1836; }","duration":"110.672697ms","start":"2026-04-18T01:27:12.981073Z","end":"2026-04-18T01:27:13.091746Z","steps":["trace[471832644] 'agreement among raft nodes before linearized reading' (duration: 110.35438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:13.091866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.134208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-18T01:27:13.091896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.873644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T01:27:13.091954Z","caller":"traceutil/trace.go:171","msg":"trace[628907905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1836; }","duration":"158.934286ms","start":"2026-04-18T01:27:12.933004Z","end":"2026-04-18T01:27:13.091939Z","steps":["trace[628907905] 'agreement among raft nodes before linearized reading' (duration: 158.752242ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:13.091952Z","caller":"traceutil/trace.go:171","msg":"trace[525903878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1836; }","duration":"274.248671ms","start":"2026-04-18T01:27:12.817674Z","end":"2026-04-18T01:27:13.091923Z","steps":["trace[525903878] 'agreement among raft nodes before linearized reading' (duration: 273.644498ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:24.253219Z","caller":"traceutil/trace.go:171","msg":"trace[387955853] linearizableReadLoop","detail":"{readStateIndex:2007; appliedIndex:2006; }","duration":"109.731048ms","start":"2026-04-18T01:27:24.143466Z","end":"2026-04-18T01:27:24.253197Z","steps":["trace[387955853] 'read index received' (duration: 109.469729ms)","trace[387955853] 'applied index is now lower than readState.Index' (duration: 260.409µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:27:24.253401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.924325ms","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-04-18T01:27:24.253368Z","caller":"traceutil/trace.go:171","msg":"trace[83708899] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"202.824765ms","start":"2026-04-18T01:27:24.050502Z","end":"2026-04-18T01:27:24.253327Z","steps":["trace[83708899] 'process raft request' (duration: 202.549546ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:24.25343Z","caller":"traceutil/trace.go:171","msg":"trace[1612966351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1936; }","duration":"110.017267ms","start":"2026-04-18T01:27:24.143405Z","end":"2026-04-18T01:27:24.253423Z","steps":["trace[1612966351] 'agreement among raft nodes before linearized reading' (duration: 109.895103ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:47.469217Z","caller":"traceutil/trace.go:171","msg":"trace[1672466984] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"132.436629ms","start":"2026-04-18T01:27:47.336751Z","end":"2026-04-18T01:27:47.469188Z","steps":["trace[1672466984] 'process raft request' (duration: 132.23694ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:47.659136Z","caller":"traceutil/trace.go:171","msg":"trace[365290964] linearizableReadLoop","detail":"{readStateIndex:2157; appliedIndex:2155; }","duration":"252.474374ms","start":"2026-04-18T01:27:47.40663Z","end":"2026-04-18T01:27:47.659104Z","steps":["trace[365290964] 'read index received' (duration: 62.426975ms)","trace[365290964] 'applied index is now lower than readState.Index' (duration: 190.046249ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:27:47.659255Z","caller":"traceutil/trace.go:171","msg":"trace[1773186739] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"321.791695ms","start":"2026-04-18T01:27:47.337436Z","end":"2026-04-18T01:27:47.659228Z","steps":["trace[1773186739] 'process raft request' (duration: 267.525738ms)","trace[1773186739] 'compare' (duration: 53.981684ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:27:47.659338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.670843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T01:27:47.659475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:27:47.337424Z","time spent":"321.883889ms","remote":"127.0.0.1:40620","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-04-18T01:27:47.659477Z","caller":"traceutil/trace.go:171","msg":"trace[643493723] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2081; }","duration":"252.815269ms","start":"2026-04-18T01:27:47.406599Z","end":"2026-04-18T01:27:47.659414Z","steps":["trace[643493723] 'agreement among raft nodes before linearized reading' (duration: 252.639051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:47.659576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.373586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:27:47.659663Z","caller":"traceutil/trace.go:171","msg":"trace[1064495513] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2081; }","duration":"179.523653ms","start":"2026-04-18T01:27:47.480118Z","end":"2026-04-18T01:27:47.659641Z","steps":["trace[1064495513] 'agreement among raft nodes before linearized reading' (duration: 179.302123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:27:47.659669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.505337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-18T01:27:47.659725Z","caller":"traceutil/trace.go:171","msg":"trace[434400028] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2081; }","duration":"246.584791ms","start":"2026-04-18T01:27:47.413121Z","end":"2026-04-18T01:27:47.659706Z","steps":["trace[434400028] 'agreement among raft nodes before linearized reading' (duration: 246.165252ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:47.909304Z","caller":"traceutil/trace.go:171","msg":"trace[1118517478] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"244.712644ms","start":"2026-04-18T01:27:47.664565Z","end":"2026-04-18T01:27:47.909277Z","steps":["trace[1118517478] 'process raft request' (duration: 236.742555ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:47.909615Z","caller":"traceutil/trace.go:171","msg":"trace[778477808] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"215.505135ms","start":"2026-04-18T01:27:47.694081Z","end":"2026-04-18T01:27:47.909587Z","steps":["trace[778477808] 'process raft request' (duration: 215.029293ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:27:47.909296Z","caller":"traceutil/trace.go:171","msg":"trace[355526621] linearizableReadLoop","detail":"{readStateIndex:2159; appliedIndex:2157; }","duration":"214.51942ms","start":"2026-04-18T01:27:47.694749Z","end":"2026-04-18T01:27:47.909269Z","steps":["trace[355526621] 'read index received' (duration: 206.532471ms)","trace[355526621] 'applied index is now lower than readState.Index' (duration: 7.977349ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:27:47.910046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.256554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T01:27:47.910146Z","caller":"traceutil/trace.go:171","msg":"trace[1509888638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2084; }","duration":"215.440192ms","start":"2026-04-18T01:27:47.694683Z","end":"2026-04-18T01:27:47.910123Z","steps":["trace[1509888638] 'agreement among raft nodes before linearized reading' (duration: 214.676737ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:28:58.78522Z","caller":"traceutil/trace.go:171","msg":"trace[1027015078] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"125.983402ms","start":"2026-04-18T01:28:58.659179Z","end":"2026-04-18T01:28:58.785163Z","steps":["trace[1027015078] 'process raft request' (duration: 125.745715ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:29:31.745472Z","caller":"traceutil/trace.go:171","msg":"trace[189918836] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"165.407834ms","start":"2026-04-18T01:29:31.580031Z","end":"2026-04-18T01:29:31.745439Z","steps":["trace[189918836] 'process raft request' (duration: 77.502228ms)","trace[189918836] 'compare' (duration: 87.571831ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:33:24.811029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.512344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-18T01:33:24.811095Z","caller":"traceutil/trace.go:171","msg":"trace[1669389808] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4751; }","duration":"118.63736ms","start":"2026-04-18T01:33:24.692445Z","end":"2026-04-18T01:33:24.811082Z","steps":["trace[1669389808] 'range keys from in-memory index tree' (duration: 118.340099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:24.811094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.065882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-18T01:33:24.811173Z","caller":"traceutil/trace.go:171","msg":"trace[460901682] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4751; }","duration":"263.177916ms","start":"2026-04-18T01:33:24.547973Z","end":"2026-04-18T01:33:24.811151Z","steps":["trace[460901682] 'range keys from in-memory index tree' (duration: 262.952828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:24.811158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.428317ms","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-04-18T01:33:24.811228Z","caller":"traceutil/trace.go:171","msg":"trace[846905516] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4751; }","duration":"257.52075ms","start":"2026-04-18T01:33:24.553687Z","end":"2026-04-18T01:33:24.811208Z","steps":["trace[846905516] 'range keys from in-memory index tree' (duration: 257.327973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:24.811544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.007891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-04-18T01:33:24.811861Z","caller":"traceutil/trace.go:171","msg":"trace[486847529] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4751; }","duration":"259.322082ms","start":"2026-04-18T01:33:24.552527Z","end":"2026-04-18T01:33:24.811849Z","steps":["trace[486847529] 'range keys from in-memory index tree' (duration: 258.314387ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:24.821318Z","caller":"traceutil/trace.go:171","msg":"trace[557548973] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"123.244169ms","start":"2026-04-18T01:33:24.69805Z","end":"2026-04-18T01:33:24.821294Z","steps":["trace[557548973] 'process raft request' (duration: 123.018292ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:25.240697Z","caller":"traceutil/trace.go:171","msg":"trace[942001704] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"121.914232ms","start":"2026-04-18T01:33:25.118745Z","end":"2026-04-18T01:33:25.240659Z","steps":["trace[942001704] 'process raft request' (duration: 60.879932ms)","trace[942001704] 'compare' (duration: 60.551553ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:33:25.241176Z","caller":"traceutil/trace.go:171","msg":"trace[345371059] linearizableReadLoop","detail":"{readStateIndex:4933; appliedIndex:4932; }","duration":"103.953896ms","start":"2026-04-18T01:33:25.137213Z","end":"2026-04-18T01:33:25.241167Z","steps":["trace[345371059] 'read index received' (duration: 42.579645ms)","trace[345371059] 'applied index is now lower than readState.Index' (duration: 61.371991ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:33:25.241367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.128342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T01:33:25.241438Z","caller":"traceutil/trace.go:171","msg":"trace[439318619] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4758; }","duration":"104.245856ms","start":"2026-04-18T01:33:25.137175Z","end":"2026-04-18T01:33:25.24142Z","steps":["trace[439318619] 'agreement among raft nodes before linearized reading' (duration: 104.094891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:25.244916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.459009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193158"} {"level":"info","ts":"2026-04-18T01:33:25.24498Z","caller":"traceutil/trace.go:171","msg":"trace[1285501445] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4759; }","duration":"107.544072ms","start":"2026-04-18T01:33:25.137421Z","end":"2026-04-18T01:33:25.244965Z","steps":["trace[1285501445] 'agreement among raft nodes before linearized reading' (duration: 104.139394ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:25.547121Z","caller":"traceutil/trace.go:171","msg":"trace[900384137] linearizableReadLoop","detail":"{readStateIndex:4943; appliedIndex:4939; }","duration":"109.262922ms","start":"2026-04-18T01:33:25.437839Z","end":"2026-04-18T01:33:25.547102Z","steps":["trace[900384137] 'read index received' (duration: 106.396072ms)","trace[900384137] 'applied index is now lower than readState.Index' (duration: 2.86604ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:33:25.547484Z","caller":"traceutil/trace.go:171","msg":"trace[2126207720] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"152.039845ms","start":"2026-04-18T01:33:25.395412Z","end":"2026-04-18T01:33:25.547452Z","steps":["trace[2126207720] 'process raft request' (duration: 151.657691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:25.547581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.526334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16084"} {"level":"info","ts":"2026-04-18T01:33:25.547604Z","caller":"traceutil/trace.go:171","msg":"trace[976848555] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4767; }","duration":"157.567176ms","start":"2026-04-18T01:33:25.390026Z","end":"2026-04-18T01:33:25.547594Z","steps":["trace[976848555] 'agreement among raft nodes before linearized reading' (duration: 157.519524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:25.547795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.705017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-18T01:33:25.547813Z","caller":"traceutil/trace.go:171","msg":"trace[880752873] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4767; }","duration":"105.744049ms","start":"2026-04-18T01:33:25.442062Z","end":"2026-04-18T01:33:25.547806Z","steps":["trace[880752873] 'agreement among raft nodes before linearized reading' (duration: 105.698787ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:25.54781Z","caller":"traceutil/trace.go:171","msg":"trace[1344455906] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"153.860498ms","start":"2026-04-18T01:33:25.393936Z","end":"2026-04-18T01:33:25.547796Z","steps":["trace[1344455906] 'process raft request' (duration: 150.366686ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:25.548018Z","caller":"traceutil/trace.go:171","msg":"trace[1847557820] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"153.909199ms","start":"2026-04-18T01:33:25.394098Z","end":"2026-04-18T01:33:25.548007Z","steps":["trace[1847557820] 'process raft request' (duration: 152.864713ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:25.54813Z","caller":"traceutil/trace.go:171","msg":"trace[1207987829] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"154.148227ms","start":"2026-04-18T01:33:25.393974Z","end":"2026-04-18T01:33:25.548122Z","steps":["trace[1207987829] 'process raft request' (duration: 153.037288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:25.54753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.617379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-18T01:33:25.548202Z","caller":"traceutil/trace.go:171","msg":"trace[1208058287] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4767; }","duration":"154.335343ms","start":"2026-04-18T01:33:25.393854Z","end":"2026-04-18T01:33:25.548189Z","steps":["trace[1208058287] 'agreement among raft nodes before linearized reading' (duration: 153.588827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:27.555689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.550379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2f0ed43-341b-4da2-99de-0f8cc1c21120\" ","response":"range_response_count:1 size:3938"} {"level":"info","ts":"2026-04-18T01:33:27.555767Z","caller":"traceutil/trace.go:171","msg":"trace[408190584] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e2f0ed43-341b-4da2-99de-0f8cc1c21120; range_end:; response_count:1; response_revision:4791; }","duration":"160.686024ms","start":"2026-04-18T01:33:27.395061Z","end":"2026-04-18T01:33:27.555747Z","steps":["trace[408190584] 'range keys from in-memory index tree' (duration: 160.362052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:38.85101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.209758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:33:38.851133Z","caller":"traceutil/trace.go:171","msg":"trace[1249300609] linearizableReadLoop","detail":"{readStateIndex:5112; appliedIndex:5111; }","duration":"370.470207ms","start":"2026-04-18T01:33:38.480647Z","end":"2026-04-18T01:33:38.851117Z","steps":["trace[1249300609] 'read index received' (duration: 182.433096ms)","trace[1249300609] 'applied index is now lower than readState.Index' (duration: 188.035661ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:33:38.851214Z","caller":"traceutil/trace.go:171","msg":"trace[1786497634] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"374.862363ms","start":"2026-04-18T01:33:38.476309Z","end":"2026-04-18T01:33:38.851171Z","steps":["trace[1786497634] 'process raft request' (duration: 186.780331ms)","trace[1786497634] 'compare' (duration: 187.087313ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:33:38.851444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:33:38.476295Z","time spent":"375.059331ms","remote":"127.0.0.1:40514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10669,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T01:33:38.851386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.229809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T01:33:38.851504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.852681ms","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-04-18T01:33:38.851529Z","caller":"traceutil/trace.go:171","msg":"trace[1118091736] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4930; }","duration":"115.427506ms","start":"2026-04-18T01:33:38.736083Z","end":"2026-04-18T01:33:38.85151Z","steps":["trace[1118091736] 'agreement among raft nodes before linearized reading' (duration: 115.185747ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:33:38.851551Z","caller":"traceutil/trace.go:171","msg":"trace[1005320850] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4930; }","duration":"370.923134ms","start":"2026-04-18T01:33:38.480615Z","end":"2026-04-18T01:33:38.851538Z","steps":["trace[1005320850] 'agreement among raft nodes before linearized reading' (duration: 370.595491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:33:38.851609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:33:38.4806Z","time spent":"370.992447ms","remote":"127.0.0.1:40480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-18T01:35:02.392152Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2906} {"level":"info","ts":"2026-04-18T01:35:02.498457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2906,"took":"104.877016ms","hash":2344636132,"current-db-size-bytes":53825536,"current-db-size":"54 MB","current-db-size-in-use-bytes":29270016,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-18T01:35:02.498533Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2344636132,"revision":2906,"compact-revision":-1} {"level":"info","ts":"2026-04-18T01:40:02.398514Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5597} {"level":"info","ts":"2026-04-18T01:40:02.487741Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5597,"took":"87.437587ms","hash":2955785533,"current-db-size-bytes":53825536,"current-db-size":"54 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-18T01:40:02.487801Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2955785533,"revision":5597,"compact-revision":2906}