{"level":"warn","ts":"2026-06-17T15:21:23.943041Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T15:21:23.943162Z","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-06-17T15:21:23.943248Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T15:21:23.943263Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-17T15:21:23.943282Z","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-06-17T15:21:23.944003Z","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-06-17T15:21:23.94409Z","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":16,"max-cpu-available":16,"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-06-17T15:21:23.947004Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.683158ms"} {"level":"info","ts":"2026-06-17T15:21:23.951871Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-06-17T15:21:23.951955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-17T15:21:23.951981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-06-17T15:21:23.951993Z","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-06-17T15:21:23.952003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-06-17T15:21:23.952041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-06-17T15:21:23.95605Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-17T15:21:23.957434Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-17T15:21:23.958685Z","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-06-17T15:21:23.960408Z","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-06-17T15:21:23.96095Z","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-06-17T15:21:23.961023Z","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-06-17T15:21:23.961261Z","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-06-17T15:21:23.961318Z","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-06-17T15:21:23.96238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-06-17T15:21:23.962771Z","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-06-17T15:21:23.96575Z","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-06-17T15:21:23.966184Z","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-06-17T15:21:23.966265Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-17T15:21:23.966243Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-17T15:21:23.966357Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-17T15:21:24.652206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-17T15:21:24.652269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-17T15:21:24.652292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-06-17T15:21:24.652303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-06-17T15:21:24.652318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-17T15:21:24.652326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-06-17T15:21:24.652332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-17T15:21:24.654467Z","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-06-17T15:21:24.654488Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T15:21:24.654544Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:21:24.654549Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T15:21:24.655745Z","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-06-17T15:21:24.655863Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:21:24.655896Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T15:21:24.655915Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-17T15:21:24.656014Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-17T15:21:24.658063Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-06-17T15:21:24.658064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-17T15:21:38.44609Z","caller":"traceutil/trace.go:171","msg":"trace[1873952664] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"133.390712ms","start":"2026-06-17T15:21:38.312669Z","end":"2026-06-17T15:21:38.44606Z","steps":["trace[1873952664] 'process raft request' (duration: 133.243108ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:22:09.931463Z","caller":"traceutil/trace.go:171","msg":"trace[645655396] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"155.002136ms","start":"2026-06-17T15:22:09.776424Z","end":"2026-06-17T15:22:09.931427Z","steps":["trace[645655396] 'read index received' (duration: 152.658058ms)","trace[645655396] 'applied index is now lower than readState.Index' (duration: 2.342468ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:22:09.931553Z","caller":"traceutil/trace.go:171","msg":"trace[1535073794] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"283.237307ms","start":"2026-06-17T15:22:09.648275Z","end":"2026-06-17T15:22:09.931513Z","steps":["trace[1535073794] 'process raft request' (duration: 281.522877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:22:09.931833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.380417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vw6rw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-17T15:22:09.931929Z","caller":"traceutil/trace.go:171","msg":"trace[317227615] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vw6rw; range_end:; response_count:1; response_revision:583; }","duration":"155.529412ms","start":"2026-06-17T15:22:09.776381Z","end":"2026-06-17T15:22:09.931911Z","steps":["trace[317227615] 'agreement among raft nodes before linearized reading' (duration: 155.189562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:22:10.410589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.352543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:22:10.410741Z","caller":"traceutil/trace.go:171","msg":"trace[1450741469] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"460.527418ms","start":"2026-06-17T15:22:09.950188Z","end":"2026-06-17T15:22:10.410716Z","steps":["trace[1450741469] 'process raft request' (duration: 293.259737ms)","trace[1450741469] 'compare' (duration: 166.197969ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:22:10.410824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:22:09.950153Z","time spent":"460.630891ms","remote":"127.0.0.1:34600","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-06-17T15:22:10.42037Z","caller":"traceutil/trace.go:171","msg":"trace[2083049260] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"418.511711ms","start":"2026-06-17T15:22:10.001817Z","end":"2026-06-17T15:22:10.420329Z","steps":["trace[2083049260] 'process raft request' (duration: 418.376287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:22:10.420706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:22:10.001791Z","time spent":"418.755698ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-17T15:22:10.441902Z","caller":"traceutil/trace.go:171","msg":"trace[1136536860] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"141.386032ms","start":"2026-06-17T15:22:10.300465Z","end":"2026-06-17T15:22:10.441852Z","steps":["trace[1136536860] 'process raft request' (duration: 140.917719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:22:25.107996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.457146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-49bv8\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-17T15:22:25.108128Z","caller":"traceutil/trace.go:171","msg":"trace[1122552579] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-49bv8; range_end:; response_count:1; response_revision:751; }","duration":"233.651901ms","start":"2026-06-17T15:22:24.874444Z","end":"2026-06-17T15:22:25.108096Z","steps":["trace[1122552579] 'range keys from in-memory index tree' (duration: 233.157438ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:22:53.529116Z","caller":"traceutil/trace.go:171","msg":"trace[567328157] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1192; }","duration":"149.474716ms","start":"2026-06-17T15:22:53.379616Z","end":"2026-06-17T15:22:53.529091Z","steps":["trace[567328157] 'read index received' (duration: 149.26369ms)","trace[567328157] 'applied index is now lower than readState.Index' (duration: 210.166µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:22:53.529192Z","caller":"traceutil/trace.go:171","msg":"trace[1157058455] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"149.683622ms","start":"2026-06-17T15:22:53.379474Z","end":"2026-06-17T15:22:53.529158Z","steps":["trace[1157058455] 'process raft request' (duration: 149.457035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:22:53.529276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.64264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:22:53.529314Z","caller":"traceutil/trace.go:171","msg":"trace[1154805069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1156; }","duration":"149.728343ms","start":"2026-06-17T15:22:53.379576Z","end":"2026-06-17T15:22:53.529304Z","steps":["trace[1154805069] 'agreement among raft nodes before linearized reading' (duration: 149.64673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:22:53.52938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.124054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T15:22:53.529469Z","caller":"traceutil/trace.go:171","msg":"trace[285121559] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1156; }","duration":"122.258727ms","start":"2026-06-17T15:22:53.407191Z","end":"2026-06-17T15:22:53.52945Z","steps":["trace[285121559] 'agreement among raft nodes before linearized reading' (duration: 122.081182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:23:41.794414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.403344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:23:41.794741Z","caller":"traceutil/trace.go:171","msg":"trace[211409154] linearizableReadLoop","detail":"{readStateIndex:1912; appliedIndex:1909; }","duration":"363.621606ms","start":"2026-06-17T15:23:41.431101Z","end":"2026-06-17T15:23:41.794722Z","steps":["trace[211409154] 'read index received' (duration: 247.434608ms)","trace[211409154] 'applied index is now lower than readState.Index' (duration: 116.186198ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:23:41.794705Z","caller":"traceutil/trace.go:171","msg":"trace[276850535] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"390.929676ms","start":"2026-06-17T15:23:41.403728Z","end":"2026-06-17T15:23:41.794658Z","steps":["trace[276850535] 'process raft request' (duration: 274.829901ms)","trace[276850535] 'compare' (duration: 115.205769ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:23:41.794799Z","caller":"traceutil/trace.go:171","msg":"trace[1545773249] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"390.227686ms","start":"2026-06-17T15:23:41.404547Z","end":"2026-06-17T15:23:41.794775Z","steps":["trace[1545773249] 'process raft request' (duration: 390.102432ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:23:41.79489Z","caller":"traceutil/trace.go:171","msg":"trace[522444241] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"390.768951ms","start":"2026-06-17T15:23:41.404094Z","end":"2026-06-17T15:23:41.794862Z","steps":["trace[522444241] 'process raft request' (duration: 390.452831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:23:41.794939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:23:41.403693Z","time spent":"391.135592ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T15:23:41.794878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.810062ms","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":"warn","ts":"2026-06-17T15:23:41.795062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:23:41.404082Z","time spent":"390.901056ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T15:23:41.795115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:23:41.404523Z","time spent":"390.429092ms","remote":"127.0.0.1:34684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T15:23:41.795103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.956096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f4ddc1e8-1574-4f8b-af95-edb9a95415d4\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-17T15:23:41.795117Z","caller":"traceutil/trace.go:171","msg":"trace[1552207631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1839; }","duration":"102.07781ms","start":"2026-06-17T15:23:41.693001Z","end":"2026-06-17T15:23:41.795078Z","steps":["trace[1552207631] 'agreement among raft nodes before linearized reading' (duration: 101.836094ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:23:41.795243Z","caller":"traceutil/trace.go:171","msg":"trace[1741623674] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f4ddc1e8-1574-4f8b-af95-edb9a95415d4; range_end:; response_count:1; response_revision:1839; }","duration":"364.156392ms","start":"2026-06-17T15:23:41.431041Z","end":"2026-06-17T15:23:41.795198Z","steps":["trace[1741623674] 'agreement among raft nodes before linearized reading' (duration: 363.74139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:23:41.795328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:23:41.431017Z","time spent":"364.293846ms","remote":"127.0.0.1:34600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3771,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f4ddc1e8-1574-4f8b-af95-edb9a95415d4\" "} {"level":"warn","ts":"2026-06-17T15:23:42.174059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.081904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-17T15:23:42.174182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.423531ms","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-06-17T15:23:42.17427Z","caller":"traceutil/trace.go:171","msg":"trace[672395078] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1840; }","duration":"209.555495ms","start":"2026-06-17T15:23:41.964691Z","end":"2026-06-17T15:23:42.174246Z","steps":["trace[672395078] 'range keys from in-memory index tree' (duration: 209.144863ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:23:42.174208Z","caller":"traceutil/trace.go:171","msg":"trace[940244242] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1840; }","duration":"234.2842ms","start":"2026-06-17T15:23:41.939901Z","end":"2026-06-17T15:23:42.174185Z","steps":["trace[940244242] 'count revisions from in-memory index tree' (duration: 233.998981ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:23:57.302235Z","caller":"traceutil/trace.go:171","msg":"trace[1767125470] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2043; }","duration":"124.674822ms","start":"2026-06-17T15:23:57.17753Z","end":"2026-06-17T15:23:57.302205Z","steps":["trace[1767125470] 'read index received' (duration: 124.447175ms)","trace[1767125470] 'applied index is now lower than readState.Index' (duration: 226.557µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:23:57.302354Z","caller":"traceutil/trace.go:171","msg":"trace[267769011] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"134.853626ms","start":"2026-06-17T15:23:57.167462Z","end":"2026-06-17T15:23:57.302315Z","steps":["trace[267769011] 'process raft request' (duration: 134.561008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:23:57.302421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.874887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T15:23:57.302545Z","caller":"traceutil/trace.go:171","msg":"trace[2006422367] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1967; }","duration":"124.97139ms","start":"2026-06-17T15:23:57.177481Z","end":"2026-06-17T15:23:57.302452Z","steps":["trace[2006422367] 'agreement among raft nodes before linearized reading' (duration: 124.877617ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:24:25.574387Z","caller":"traceutil/trace.go:171","msg":"trace[1731581767] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"141.749721ms","start":"2026-06-17T15:24:25.432599Z","end":"2026-06-17T15:24:25.574349Z","steps":["trace[1731581767] 'process raft request' (duration: 141.591917ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:24:31.735367Z","caller":"traceutil/trace.go:171","msg":"trace[1067847262] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"123.013112ms","start":"2026-06-17T15:24:31.612334Z","end":"2026-06-17T15:24:31.735347Z","steps":["trace[1067847262] 'read index received' (duration: 122.751355ms)","trace[1067847262] 'applied index is now lower than readState.Index' (duration: 261.087µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:24:31.735476Z","caller":"traceutil/trace.go:171","msg":"trace[1336762897] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"132.216458ms","start":"2026-06-17T15:24:31.60323Z","end":"2026-06-17T15:24:31.735447Z","steps":["trace[1336762897] 'process raft request' (duration: 131.92677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:24:31.735622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.250119ms","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-06-17T15:24:31.736124Z","caller":"traceutil/trace.go:171","msg":"trace[1184643146] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2161; }","duration":"123.334462ms","start":"2026-06-17T15:24:31.612309Z","end":"2026-06-17T15:24:31.735644Z","steps":["trace[1184643146] 'agreement among raft nodes before linearized reading' (duration: 123.125416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:24:37.273552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.949023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:24:37.273649Z","caller":"traceutil/trace.go:171","msg":"trace[1141617556] linearizableReadLoop","detail":"{readStateIndex:2275; appliedIndex:2274; }","duration":"160.996236ms","start":"2026-06-17T15:24:37.112639Z","end":"2026-06-17T15:24:37.273635Z","steps":["trace[1141617556] 'read index received' (duration: 22.784035ms)","trace[1141617556] 'applied index is now lower than readState.Index' (duration: 138.211331ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:24:37.273707Z","caller":"traceutil/trace.go:171","msg":"trace[805944845] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"279.743766ms","start":"2026-06-17T15:24:36.993954Z","end":"2026-06-17T15:24:37.273698Z","steps":["trace[805944845] 'process raft request' (duration: 141.566496ms)","trace[805944845] 'compare' (duration: 137.84287ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:24:37.27382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.192422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:24:37.273849Z","caller":"traceutil/trace.go:171","msg":"trace[451405107] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2189; }","duration":"161.311326ms","start":"2026-06-17T15:24:37.112529Z","end":"2026-06-17T15:24:37.273841Z","steps":["trace[451405107] 'agreement among raft nodes before linearized reading' (duration: 161.260564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:24:37.323396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.034099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:24:37.323506Z","caller":"traceutil/trace.go:171","msg":"trace[1231171472] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2190; }","duration":"193.211073ms","start":"2026-06-17T15:24:37.130267Z","end":"2026-06-17T15:24:37.323478Z","steps":["trace[1231171472] 'agreement among raft nodes before linearized reading' (duration: 193.018408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:24:37.323703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.198592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-17T15:24:37.323811Z","caller":"traceutil/trace.go:171","msg":"trace[1336736990] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2190; }","duration":"161.367797ms","start":"2026-06-17T15:24:37.162413Z","end":"2026-06-17T15:24:37.323781Z","steps":["trace[1336736990] 'agreement among raft nodes before linearized reading' (duration: 161.017696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:24:37.659077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.765307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:24:37.659224Z","caller":"traceutil/trace.go:171","msg":"trace[1941866108] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"282.641798ms","start":"2026-06-17T15:24:37.376559Z","end":"2026-06-17T15:24:37.659201Z","steps":["trace[1941866108] 'read index received' (duration: 70.692506ms)","trace[1941866108] 'applied index is now lower than readState.Index' (duration: 211.947782ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:24:37.659341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.784663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:24:37.659377Z","caller":"traceutil/trace.go:171","msg":"trace[766480463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2191; }","duration":"282.876915ms","start":"2026-06-17T15:24:37.376488Z","end":"2026-06-17T15:24:37.659365Z","steps":["trace[766480463] 'agreement among raft nodes before linearized reading' (duration: 282.772332ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:24:37.659543Z","caller":"traceutil/trace.go:171","msg":"trace[310615752] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"329.580959ms","start":"2026-06-17T15:24:37.329908Z","end":"2026-06-17T15:24:37.659489Z","steps":["trace[310615752] 'process raft request' (duration: 117.310458ms)","trace[310615752] 'compare' (duration: 211.636253ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:24:37.659778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:24:37.329883Z","time spent":"329.779145ms","remote":"127.0.0.1:34678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T15:26:01.584312Z","caller":"traceutil/trace.go:171","msg":"trace[1980335161] linearizableReadLoop","detail":"{readStateIndex:2949; appliedIndex:2947; }","duration":"206.776604ms","start":"2026-06-17T15:26:01.37751Z","end":"2026-06-17T15:26:01.584287Z","steps":["trace[1980335161] 'read index received' (duration: 108.747851ms)","trace[1980335161] 'applied index is now lower than readState.Index' (duration: 98.027773ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:26:01.584495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.96307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:26:01.584532Z","caller":"traceutil/trace.go:171","msg":"trace[2093399053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2839; }","duration":"207.035351ms","start":"2026-06-17T15:26:01.377485Z","end":"2026-06-17T15:26:01.58452Z","steps":["trace[2093399053] 'agreement among raft nodes before linearized reading' (duration: 206.928358ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:26:01.584574Z","caller":"traceutil/trace.go:171","msg":"trace[1054782002] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"261.470329ms","start":"2026-06-17T15:26:01.323079Z","end":"2026-06-17T15:26:01.584549Z","steps":["trace[1054782002] 'process raft request' (duration: 163.776626ms)","trace[1054782002] 'compare' (duration: 97.244651ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:26:01.584598Z","caller":"traceutil/trace.go:171","msg":"trace[603843554] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"255.412365ms","start":"2026-06-17T15:26:01.329152Z","end":"2026-06-17T15:26:01.584565Z","steps":["trace[603843554] 'process raft request' (duration: 255.083755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:54.999424Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533136293300944,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T15:26:55.429038Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.001015557s","expected-duration":"1s"} {"level":"info","ts":"2026-06-17T15:26:55.429514Z","caller":"traceutil/trace.go:171","msg":"trace[2052362546] linearizableReadLoop","detail":"{readStateIndex:3249; appliedIndex:3248; }","duration":"930.854234ms","start":"2026-06-17T15:26:54.498636Z","end":"2026-06-17T15:26:55.42949Z","steps":["trace[2052362546] 'read index received' (duration: 930.732609ms)","trace[2052362546] 'applied index is now lower than readState.Index' (duration: 120.685µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:26:55.429606Z","caller":"traceutil/trace.go:171","msg":"trace[1753842092] transaction","detail":"{read_only:false; response_revision:3127; number_of_response:1; }","duration":"1.001620495s","start":"2026-06-17T15:26:54.427949Z","end":"2026-06-17T15:26:55.42957Z","steps":["trace[1753842092] 'process raft request' (duration: 1.001379437s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:55.429808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:26:54.427936Z","time spent":"1.00178635s","remote":"127.0.0.1:34678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T15:26:55.429881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.220754ms","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-06-17T15:26:55.429999Z","caller":"traceutil/trace.go:171","msg":"trace[467156064] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3127; }","duration":"931.370838ms","start":"2026-06-17T15:26:54.498598Z","end":"2026-06-17T15:26:55.429968Z","steps":["trace[467156064] 'agreement among raft nodes before linearized reading' (duration: 931.013698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:55.430085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:26:54.498582Z","time spent":"931.483672ms","remote":"127.0.0.1:34612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-06-17T15:26:55.430988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.864588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-17T15:26:55.431033Z","caller":"traceutil/trace.go:171","msg":"trace[1914811509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3128; }","duration":"648.97005ms","start":"2026-06-17T15:26:54.782053Z","end":"2026-06-17T15:26:55.431023Z","steps":["trace[1914811509] 'agreement among raft nodes before linearized reading' (duration: 648.849387ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:26:55.430998Z","caller":"traceutil/trace.go:171","msg":"trace[26950380] transaction","detail":"{read_only:false; response_revision:3128; number_of_response:1; }","duration":"145.940289ms","start":"2026-06-17T15:26:55.285024Z","end":"2026-06-17T15:26:55.430965Z","steps":["trace[26950380] 'process raft request' (duration: 145.767944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:55.430997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.375615ms","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":"warn","ts":"2026-06-17T15:26:55.431062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:26:54.782034Z","time spent":"649.020772ms","remote":"127.0.0.1:34678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-17T15:26:55.431089Z","caller":"traceutil/trace.go:171","msg":"trace[940901495] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3128; }","duration":"193.503738ms","start":"2026-06-17T15:26:55.237571Z","end":"2026-06-17T15:26:55.431075Z","steps":["trace[940901495] 'agreement among raft nodes before linearized reading' (duration: 193.371995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:55.431103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.936265ms","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-06-17T15:26:55.431185Z","caller":"traceutil/trace.go:171","msg":"trace[763167854] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3128; }","duration":"282.053508ms","start":"2026-06-17T15:26:55.149089Z","end":"2026-06-17T15:26:55.431142Z","steps":["trace[763167854] 'agreement among raft nodes before linearized reading' (duration: 281.879883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:55.431224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.067774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b9e7c027c20b71\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-17T15:26:55.431278Z","caller":"traceutil/trace.go:171","msg":"trace[1984692067] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b9e7c027c20b71; range_end:; response_count:1; response_revision:3128; }","duration":"340.162637ms","start":"2026-06-17T15:26:55.091093Z","end":"2026-06-17T15:26:55.431255Z","steps":["trace[1984692067] 'agreement among raft nodes before linearized reading' (duration: 339.992173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:26:55.431319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:26:55.09107Z","time spent":"340.238639ms","remote":"127.0.0.1:34500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":805,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b9e7c027c20b71\" "} {"level":"info","ts":"2026-06-17T15:28:32.436814Z","caller":"traceutil/trace.go:171","msg":"trace[757456464] transaction","detail":"{read_only:false; response_revision:3836; number_of_response:1; }","duration":"202.763949ms","start":"2026-06-17T15:28:32.234007Z","end":"2026-06-17T15:28:32.436771Z","steps":["trace[757456464] 'process raft request' (duration: 181.160212ms)","trace[757456464] 'compare' (duration: 21.418112ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:29:54.451976Z","caller":"traceutil/trace.go:171","msg":"trace[1669322997] linearizableReadLoop","detail":"{readStateIndex:5045; appliedIndex:5044; }","duration":"119.048569ms","start":"2026-06-17T15:29:54.332883Z","end":"2026-06-17T15:29:54.451932Z","steps":["trace[1669322997] 'read index received' (duration: 49.852736ms)","trace[1669322997] 'applied index is now lower than readState.Index' (duration: 69.193763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:29:54.452374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.406141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-06-17T15:29:54.452456Z","caller":"traceutil/trace.go:171","msg":"trace[2093731728] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4860; }","duration":"119.623796ms","start":"2026-06-17T15:29:54.332812Z","end":"2026-06-17T15:29:54.452436Z","steps":["trace[2093731728] 'agreement among raft nodes before linearized reading' (duration: 119.302676ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:29:54.452663Z","caller":"traceutil/trace.go:171","msg":"trace[2135262586] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"119.934494ms","start":"2026-06-17T15:29:54.332175Z","end":"2026-06-17T15:29:54.45211Z","steps":["trace[2135262586] 'process raft request' (duration: 50.641919ms)","trace[2135262586] 'compare' (duration: 68.829732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:29:58.665591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.637066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-17T15:29:58.665678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.090116ms","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-06-17T15:29:58.665722Z","caller":"traceutil/trace.go:171","msg":"trace[1721765984] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5032; }","duration":"121.80617ms","start":"2026-06-17T15:29:58.543891Z","end":"2026-06-17T15:29:58.665697Z","steps":["trace[1721765984] 'range keys from in-memory index tree' (duration: 121.508971ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:29:58.665772Z","caller":"traceutil/trace.go:171","msg":"trace[542832358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5032; }","duration":"175.24268ms","start":"2026-06-17T15:29:58.490508Z","end":"2026-06-17T15:29:58.665751Z","steps":["trace[542832358] 'range keys from in-memory index tree' (duration: 174.820716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:29:58.665591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.109699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-17T15:29:58.666069Z","caller":"traceutil/trace.go:171","msg":"trace[456329524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5032; }","duration":"122.662795ms","start":"2026-06-17T15:29:58.543392Z","end":"2026-06-17T15:29:58.666055Z","steps":["trace[456329524] 'range keys from in-memory index tree' (duration: 121.897172ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:29:58.666194Z","caller":"traceutil/trace.go:171","msg":"trace[550420478] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"115.188129ms","start":"2026-06-17T15:29:58.550891Z","end":"2026-06-17T15:29:58.666079Z","steps":["trace[550420478] 'process raft request' (duration: 63.351395ms)","trace[550420478] 'compare' (duration: 51.169424ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:29:58.859504Z","caller":"traceutil/trace.go:171","msg":"trace[1162856866] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"188.293125ms","start":"2026-06-17T15:29:58.671166Z","end":"2026-06-17T15:29:58.859459Z","steps":["trace[1162856866] 'process raft request' (duration: 188.221853ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:29:58.859913Z","caller":"traceutil/trace.go:171","msg":"trace[1394812070] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"188.763009ms","start":"2026-06-17T15:29:58.67113Z","end":"2026-06-17T15:29:58.859893Z","steps":["trace[1394812070] 'process raft request' (duration: 188.052239ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:29:58.864156Z","caller":"traceutil/trace.go:171","msg":"trace[790644774] linearizableReadLoop","detail":"{readStateIndex:5229; appliedIndex:5226; }","duration":"102.828042ms","start":"2026-06-17T15:29:58.761301Z","end":"2026-06-17T15:29:58.864129Z","steps":["trace[790644774] 'read index received' (duration: 97.911341ms)","trace[790644774] 'applied index is now lower than readState.Index' (duration: 4.915121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:29:58.864321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.988927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T15:29:58.864347Z","caller":"traceutil/trace.go:171","msg":"trace[347752431] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5038; }","duration":"103.08743ms","start":"2026-06-17T15:29:58.761251Z","end":"2026-06-17T15:29:58.864338Z","steps":["trace[347752431] 'agreement among raft nodes before linearized reading' (duration: 102.983347ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:29:58.8644Z","caller":"traceutil/trace.go:171","msg":"trace[1814639956] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"110.71459ms","start":"2026-06-17T15:29:58.753666Z","end":"2026-06-17T15:29:58.86438Z","steps":["trace[1814639956] 'process raft request' (duration: 110.293978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:30:25.415674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.147497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T15:30:25.415801Z","caller":"traceutil/trace.go:171","msg":"trace[557258117] linearizableReadLoop","detail":"{readStateIndex:5749; appliedIndex:5748; }","duration":"158.387323ms","start":"2026-06-17T15:30:25.257395Z","end":"2026-06-17T15:30:25.415782Z","steps":["trace[557258117] 'read index received' (duration: 34.02464ms)","trace[557258117] 'applied index is now lower than readState.Index' (duration: 124.360533ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:30:25.415909Z","caller":"traceutil/trace.go:171","msg":"trace[25854447] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"242.803945ms","start":"2026-06-17T15:30:25.173085Z","end":"2026-06-17T15:30:25.415888Z","steps":["trace[25854447] 'process raft request' (duration: 118.3454ms)","trace[25854447] 'compare' (duration: 123.92817ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:30:25.416206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.815256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-35ff2896-6d6f-4cf4-a19e-783633dbe62d\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-17T15:30:25.416239Z","caller":"traceutil/trace.go:171","msg":"trace[778278877] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-35ff2896-6d6f-4cf4-a19e-783633dbe62d; range_end:; response_count:1; response_revision:5543; }","duration":"158.899289ms","start":"2026-06-17T15:30:25.257328Z","end":"2026-06-17T15:30:25.416227Z","steps":["trace[778278877] 'agreement among raft nodes before linearized reading' (duration: 158.724964ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:31:24.684149Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2966} {"level":"info","ts":"2026-06-17T15:31:24.759405Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2966,"took":"73.026042ms","hash":77659546,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":33742848,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-17T15:31:24.759506Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":77659546,"revision":2966,"compact-revision":-1} {"level":"info","ts":"2026-06-17T15:32:51.547946Z","caller":"traceutil/trace.go:171","msg":"trace[513128809] linearizableReadLoop","detail":"{readStateIndex:6838; appliedIndex:6837; }","duration":"169.450645ms","start":"2026-06-17T15:32:51.378458Z","end":"2026-06-17T15:32:51.547908Z","steps":["trace[513128809] 'read index received' (duration: 168.119646ms)","trace[513128809] 'applied index is now lower than readState.Index' (duration: 1.329289ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:32:51.547975Z","caller":"traceutil/trace.go:171","msg":"trace[1703727060] transaction","detail":"{read_only:false; response_revision:6598; number_of_response:1; }","duration":"185.264891ms","start":"2026-06-17T15:32:51.362674Z","end":"2026-06-17T15:32:51.547939Z","steps":["trace[1703727060] 'process raft request' (duration: 183.86631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:32:51.548125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.631419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:32:51.548224Z","caller":"traceutil/trace.go:171","msg":"trace[1749847654] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6598; }","duration":"169.799114ms","start":"2026-06-17T15:32:51.378399Z","end":"2026-06-17T15:32:51.548198Z","steps":["trace[1749847654] 'agreement among raft nodes before linearized reading' (duration: 169.594878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:32:51.548368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.152154ms","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-06-17T15:32:51.548479Z","caller":"traceutil/trace.go:171","msg":"trace[312122136] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6598; }","duration":"128.295118ms","start":"2026-06-17T15:32:51.420165Z","end":"2026-06-17T15:32:51.54846Z","steps":["trace[312122136] 'agreement among raft nodes before linearized reading' (duration: 128.077832ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:36:24.691188Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6040} {"level":"info","ts":"2026-06-17T15:36:24.794197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6040,"took":"100.877097ms","hash":229168765,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":21704704,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-17T15:36:24.794298Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":229168765,"revision":6040,"compact-revision":2966} {"level":"info","ts":"2026-06-17T15:36:50.342967Z","caller":"traceutil/trace.go:171","msg":"trace[1887412084] transaction","detail":"{read_only:false; response_revision:8402; number_of_response:1; }","duration":"167.26054ms","start":"2026-06-17T15:36:50.175674Z","end":"2026-06-17T15:36:50.342934Z","steps":["trace[1887412084] 'process raft request' (duration: 167.118096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:37:01.684165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.118588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19406"} {"level":"info","ts":"2026-06-17T15:37:01.684246Z","caller":"traceutil/trace.go:171","msg":"trace[360348477] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8462; }","duration":"140.247271ms","start":"2026-06-17T15:37:01.54398Z","end":"2026-06-17T15:37:01.684228Z","steps":["trace[360348477] 'range keys from in-memory index tree' (duration: 139.925432ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:03.52799Z","caller":"traceutil/trace.go:171","msg":"trace[160811779] transaction","detail":"{read_only:false; response_revision:8471; number_of_response:1; }","duration":"130.600055ms","start":"2026-06-17T15:37:03.397346Z","end":"2026-06-17T15:37:03.527946Z","steps":["trace[160811779] 'process raft request' (duration: 130.366328ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:31.169975Z","caller":"traceutil/trace.go:171","msg":"trace[900368725] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"458.35181ms","start":"2026-06-17T15:37:30.711578Z","end":"2026-06-17T15:37:31.16993Z","steps":["trace[900368725] 'process raft request' (duration: 458.184215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:37:31.170184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:37:30.711557Z","time spent":"458.559415ms","remote":"127.0.0.1:34678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T15:37:31.185322Z","caller":"traceutil/trace.go:171","msg":"trace[1727687071] linearizableReadLoop","detail":"{readStateIndex:8984; appliedIndex:8982; }","duration":"260.205429ms","start":"2026-06-17T15:37:30.925092Z","end":"2026-06-17T15:37:31.185297Z","steps":["trace[1727687071] 'read index received' (duration: 244.725633ms)","trace[1727687071] 'applied index is now lower than readState.Index' (duration: 15.475436ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:37:31.18569Z","caller":"traceutil/trace.go:171","msg":"trace[176904037] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"472.485497ms","start":"2026-06-17T15:37:30.713185Z","end":"2026-06-17T15:37:31.18567Z","steps":["trace[176904037] 'process raft request' (duration: 471.944771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:37:31.185877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T15:37:30.713173Z","time spent":"472.608201ms","remote":"127.0.0.1:34678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T15:37:31.186281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.034324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-17T15:37:31.186376Z","caller":"traceutil/trace.go:171","msg":"trace[494268625] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8674; }","duration":"235.185149ms","start":"2026-06-17T15:37:30.951171Z","end":"2026-06-17T15:37:31.186357Z","steps":["trace[494268625] 'agreement among raft nodes before linearized reading' (duration: 234.87377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:37:31.186643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.547007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jw4sz\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-17T15:37:31.186715Z","caller":"traceutil/trace.go:171","msg":"trace[1685456906] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jw4sz; range_end:; response_count:1; response_revision:8674; }","duration":"261.64174ms","start":"2026-06-17T15:37:30.925056Z","end":"2026-06-17T15:37:31.186698Z","steps":["trace[1685456906] 'agreement among raft nodes before linearized reading' (duration: 261.27967ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:43.540752Z","caller":"traceutil/trace.go:171","msg":"trace[263225844] linearizableReadLoop","detail":"{readStateIndex:9094; appliedIndex:9093; }","duration":"163.199913ms","start":"2026-06-17T15:37:43.377525Z","end":"2026-06-17T15:37:43.540725Z","steps":["trace[263225844] 'read index received' (duration: 163.08112ms)","trace[263225844] 'applied index is now lower than readState.Index' (duration: 117.573µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:37:43.540799Z","caller":"traceutil/trace.go:171","msg":"trace[682571036] transaction","detail":"{read_only:false; response_revision:8777; number_of_response:1; }","duration":"178.781512ms","start":"2026-06-17T15:37:43.361992Z","end":"2026-06-17T15:37:43.540773Z","steps":["trace[682571036] 'process raft request' (duration: 178.559546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:37:43.540911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.365997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:37:43.540954Z","caller":"traceutil/trace.go:171","msg":"trace[1916824254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8777; }","duration":"163.46048ms","start":"2026-06-17T15:37:43.377481Z","end":"2026-06-17T15:37:43.540942Z","steps":["trace[1916824254] 'agreement among raft nodes before linearized reading' (duration: 163.369608ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:43.686596Z","caller":"traceutil/trace.go:171","msg":"trace[2099308069] linearizableReadLoop","detail":"{readStateIndex:9095; appliedIndex:9094; }","duration":"145.7455ms","start":"2026-06-17T15:37:43.540824Z","end":"2026-06-17T15:37:43.68657Z","steps":["trace[2099308069] 'read index received' (duration: 98.762926ms)","trace[2099308069] 'applied index is now lower than readState.Index' (duration: 46.980924ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:37:43.686873Z","caller":"traceutil/trace.go:171","msg":"trace[2104996062] transaction","detail":"{read_only:false; response_revision:8778; number_of_response:1; }","duration":"163.601664ms","start":"2026-06-17T15:37:43.523255Z","end":"2026-06-17T15:37:43.686856Z","steps":["trace[2104996062] 'process raft request' (duration: 116.451455ms)","trace[2104996062] 'compare' (duration: 46.523601ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:37:43.687157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.990377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-17T15:37:43.687144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.11297ms","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-06-17T15:37:43.687229Z","caller":"traceutil/trace.go:171","msg":"trace[991734996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8778; }","duration":"214.12291ms","start":"2026-06-17T15:37:43.473092Z","end":"2026-06-17T15:37:43.687215Z","steps":["trace[991734996] 'agreement among raft nodes before linearized reading' (duration: 213.908344ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:43.687263Z","caller":"traceutil/trace.go:171","msg":"trace[859305594] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8778; }","duration":"248.280705ms","start":"2026-06-17T15:37:43.438955Z","end":"2026-06-17T15:37:43.687235Z","steps":["trace[859305594] 'agreement among raft nodes before linearized reading' (duration: 247.998767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:37:43.687179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.797379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-17T15:37:43.687336Z","caller":"traceutil/trace.go:171","msg":"trace[290591945] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8778; }","duration":"122.986794ms","start":"2026-06-17T15:37:43.56434Z","end":"2026-06-17T15:37:43.687327Z","steps":["trace[290591945] 'agreement among raft nodes before linearized reading' (duration: 122.739537ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:37:59.236124Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002418.wal"} {"level":"info","ts":"2026-06-17T15:39:03.166431Z","caller":"traceutil/trace.go:171","msg":"trace[43249855] linearizableReadLoop","detail":"{readStateIndex:9889; appliedIndex:9888; }","duration":"138.321517ms","start":"2026-06-17T15:39:03.028084Z","end":"2026-06-17T15:39:03.166405Z","steps":["trace[43249855] 'read index received' (duration: 138.239634ms)","trace[43249855] 'applied index is now lower than readState.Index' (duration: 80.133µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T15:39:03.166603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.497342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T15:39:03.166631Z","caller":"traceutil/trace.go:171","msg":"trace[1927643402] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:9550; }","duration":"138.577794ms","start":"2026-06-17T15:39:03.028044Z","end":"2026-06-17T15:39:03.166622Z","steps":["trace[1927643402] 'agreement among raft nodes before linearized reading' (duration: 138.471821ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:39:03.166608Z","caller":"traceutil/trace.go:171","msg":"trace[1770713144] transaction","detail":"{read_only:false; response_revision:9550; number_of_response:1; }","duration":"158.821447ms","start":"2026-06-17T15:39:03.007739Z","end":"2026-06-17T15:39:03.16656Z","steps":["trace[1770713144] 'process raft request' (duration: 158.486578ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:39:15.138344Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-17T15:39:15.143148Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-17T15:39:15.143225Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-17T15:41:24.698896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8087} {"level":"info","ts":"2026-06-17T15:41:24.76291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8087,"took":"61.700747ms","hash":2797010034,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":27983872,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-17T15:41:24.762989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2797010034,"revision":8087,"compact-revision":6040} {"level":"info","ts":"2026-06-17T15:44:38.64803Z","caller":"traceutil/trace.go:171","msg":"trace[334396545] transaction","detail":"{read_only:false; response_revision:11965; number_of_response:1; }","duration":"169.067116ms","start":"2026-06-17T15:44:38.478924Z","end":"2026-06-17T15:44:38.647991Z","steps":["trace[334396545] 'process raft request' (duration: 168.811408ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:46:24.704927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10496} {"level":"info","ts":"2026-06-17T15:46:24.787722Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10496,"took":"80.089584ms","hash":3413764236,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":25841664,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-17T15:46:24.787795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3413764236,"revision":10496,"compact-revision":8087} {"level":"info","ts":"2026-06-17T15:51:24.711621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12666} {"level":"info","ts":"2026-06-17T15:51:24.794247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12666,"took":"80.040486ms","hash":2637053887,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":27254784,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-17T15:51:24.794319Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2637053887,"revision":12666,"compact-revision":10496} {"level":"info","ts":"2026-06-17T15:51:46.258299Z","caller":"traceutil/trace.go:171","msg":"trace[1965484352] transaction","detail":"{read_only:false; response_revision:14971; number_of_response:1; }","duration":"141.871698ms","start":"2026-06-17T15:51:46.116402Z","end":"2026-06-17T15:51:46.258274Z","steps":["trace[1965484352] 'process raft request' (duration: 141.731294ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:51:46.426787Z","caller":"traceutil/trace.go:171","msg":"trace[1908409778] transaction","detail":"{read_only:false; response_revision:14972; number_of_response:1; }","duration":"130.074358ms","start":"2026-06-17T15:51:46.29669Z","end":"2026-06-17T15:51:46.426765Z","steps":["trace[1908409778] 'process raft request' (duration: 128.106222ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:53:02.910407Z","caller":"traceutil/trace.go:171","msg":"trace[315625670] transaction","detail":"{read_only:false; response_revision:15731; number_of_response:1; }","duration":"258.785479ms","start":"2026-06-17T15:53:02.651597Z","end":"2026-06-17T15:53:02.910382Z","steps":["trace[315625670] 'process raft request' (duration: 258.610294ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:53:02.911534Z","caller":"traceutil/trace.go:171","msg":"trace[1978885005] transaction","detail":"{read_only:false; response_revision:15732; number_of_response:1; }","duration":"222.808042ms","start":"2026-06-17T15:53:02.688705Z","end":"2026-06-17T15:53:02.911513Z","steps":["trace[1978885005] 'process raft request' (duration: 222.641737ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:53:02.911756Z","caller":"traceutil/trace.go:171","msg":"trace[1672038860] transaction","detail":"{read_only:false; response_revision:15733; number_of_response:1; }","duration":"220.001821ms","start":"2026-06-17T15:53:02.691734Z","end":"2026-06-17T15:53:02.911736Z","steps":["trace[1672038860] 'process raft request' (duration: 219.726433ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:53:02.911958Z","caller":"traceutil/trace.go:171","msg":"trace[1923852449] linearizableReadLoop","detail":"{readStateIndex:16283; appliedIndex:16280; }","duration":"139.483ms","start":"2026-06-17T15:53:02.772461Z","end":"2026-06-17T15:53:02.911944Z","steps":["trace[1923852449] 'read index received' (duration: 137.74419ms)","trace[1923852449] 'applied index is now lower than readState.Index' (duration: 1.7375ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T15:53:02.912091Z","caller":"traceutil/trace.go:171","msg":"trace[1026639688] transaction","detail":"{read_only:false; response_revision:15734; number_of_response:1; }","duration":"116.986862ms","start":"2026-06-17T15:53:02.795092Z","end":"2026-06-17T15:53:02.912079Z","steps":["trace[1026639688] 'process raft request' (duration: 116.57142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:53:02.912437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.960264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-06-17T15:53:02.912484Z","caller":"traceutil/trace.go:171","msg":"trace[1274522591] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15734; }","duration":"140.057557ms","start":"2026-06-17T15:53:02.772414Z","end":"2026-06-17T15:53:02.912471Z","steps":["trace[1274522591] 'agreement among raft nodes before linearized reading' (duration: 139.920243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:53:02.9127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.064747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T15:53:02.912772Z","caller":"traceutil/trace.go:171","msg":"trace[1911806480] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15734; }","duration":"140.15996ms","start":"2026-06-17T15:53:02.772591Z","end":"2026-06-17T15:53:02.912751Z","steps":["trace[1911806480] 'agreement among raft nodes before linearized reading' (duration: 140.044717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T15:53:02.913278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.488441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-17T15:53:02.913335Z","caller":"traceutil/trace.go:171","msg":"trace[1999240763] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15734; }","duration":"138.594044ms","start":"2026-06-17T15:53:02.774726Z","end":"2026-06-17T15:53:02.913321Z","steps":["trace[1999240763] 'agreement among raft nodes before linearized reading' (duration: 138.462431ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:54:29.338486Z","caller":"traceutil/trace.go:171","msg":"trace[1188118941] transaction","detail":"{read_only:false; response_revision:16275; number_of_response:1; }","duration":"117.787585ms","start":"2026-06-17T15:54:29.220672Z","end":"2026-06-17T15:54:29.33846Z","steps":["trace[1188118941] 'process raft request' (duration: 117.561789ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:54:29.341855Z","caller":"traceutil/trace.go:171","msg":"trace[626978510] transaction","detail":"{read_only:false; response_revision:16276; number_of_response:1; }","duration":"119.868454ms","start":"2026-06-17T15:54:29.221969Z","end":"2026-06-17T15:54:29.341837Z","steps":["trace[626978510] 'process raft request' (duration: 119.72008ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:54:29.342329Z","caller":"traceutil/trace.go:171","msg":"trace[1763078986] transaction","detail":"{read_only:false; response_revision:16277; number_of_response:1; }","duration":"118.722412ms","start":"2026-06-17T15:54:29.223511Z","end":"2026-06-17T15:54:29.342233Z","steps":["trace[1763078986] 'process raft request' (duration: 118.268248ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T15:56:24.717598Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14673} {"level":"info","ts":"2026-06-17T15:56:24.798746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14673,"took":"76.551825ms","hash":216378941,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":33697792,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-17T15:56:24.798826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":216378941,"revision":14673,"compact-revision":12666} {"level":"info","ts":"2026-06-17T16:01:24.724632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17337} {"level":"info","ts":"2026-06-17T16:01:24.825476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17337,"took":"97.621648ms","hash":3100563654,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":30908416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-17T16:01:24.829797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3100563654,"revision":17337,"compact-revision":14673} {"level":"info","ts":"2026-06-17T16:01:57.742659Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":20004,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-17T16:01:57.747198Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20004} {"level":"info","ts":"2026-06-17T16:01:57.747306Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15004} {"level":"info","ts":"2026-06-17T16:06:24.734799Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19156} {"level":"info","ts":"2026-06-17T16:06:24.82017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19156,"took":"82.962516ms","hash":3277207991,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":24596480,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-17T16:06:24.820225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3277207991,"revision":19156,"compact-revision":17337}