{"level":"warn","ts":"2026-04-22T00:28:08.221228Z","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-22T00:28:08.22131Z","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-04-22T00:28:08.221396Z","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-22T00:28:08.221412Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-04-22T00:28:08.221454Z","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-22T00:28:08.222097Z","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-04-22T00:28:08.222201Z","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-04-22T00:28:08.225951Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.450501ms"} {"level":"info","ts":"2026-04-22T00:28:08.233189Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-04-22T00:28:08.233288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:28:08.233318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-04-22T00:28:08.23333Z","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-04-22T00:28:08.233367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-04-22T00:28:08.233428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-04-22T00:28:08.246466Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:28:08.248356Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:28:08.249954Z","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-22T00:28:08.252768Z","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-04-22T00:28:08.252932Z","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-04-22T00:28:08.253013Z","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-22T00:28:08.253143Z","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-22T00:28:08.253183Z","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-22T00:28:08.254091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-04-22T00:28:08.254706Z","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-04-22T00:28:08.256086Z","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-22T00:28:08.25615Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-04-22T00:28:08.256182Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-04-22T00:28:08.256321Z","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-04-22T00:28:08.256368Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:28:08.333894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:28:08.333948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:28:08.333981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-04-22T00:28:08.333996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:28:08.334006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-04-22T00:28:08.334022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-04-22T00:28:08.334033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-04-22T00:28:08.335046Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:28:08.335956Z","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-04-22T00:28:08.33596Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:28:08.335978Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:28:08.336248Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:28:08.336291Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:28:08.336335Z","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-04-22T00:28:08.336411Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:28:08.336436Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:28:08.34012Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-04-22T00:28:08.341109Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:28:19.420391Z","caller":"traceutil/trace.go:171","msg":"trace[312374856] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"440.879235ms","start":"2026-04-22T00:28:18.979477Z","end":"2026-04-22T00:28:19.420357Z","steps":["trace[312374856] 'process raft request' (duration: 440.729612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:19.421133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:18.979438Z","time spent":"441.074689ms","remote":"127.0.0.1:60334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4467,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:28:19.663261Z","caller":"traceutil/trace.go:171","msg":"trace[143242294] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"236.270301ms","start":"2026-04-22T00:28:19.426964Z","end":"2026-04-22T00:28:19.663234Z","steps":["trace[143242294] 'process raft request' (duration: 236.093147ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:54.661104Z","caller":"traceutil/trace.go:171","msg":"trace[522294617] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"299.784507ms","start":"2026-04-22T00:28:54.361283Z","end":"2026-04-22T00:28:54.661067Z","steps":["trace[522294617] 'process raft request' (duration: 299.135554ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:54.919588Z","caller":"traceutil/trace.go:171","msg":"trace[1910808984] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"132.195127ms","start":"2026-04-22T00:28:54.787367Z","end":"2026-04-22T00:28:54.919562Z","steps":["trace[1910808984] 'process raft request' (duration: 132.053684ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:54.919722Z","caller":"traceutil/trace.go:171","msg":"trace[902482741] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:625; }","duration":"111.574917ms","start":"2026-04-22T00:28:54.808114Z","end":"2026-04-22T00:28:54.919689Z","steps":["trace[902482741] 'read index received' (duration: 111.561876ms)","trace[902482741] 'applied index is now lower than readState.Index' (duration: 10.571µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:28:54.920006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.087565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:54.920107Z","caller":"traceutil/trace.go:171","msg":"trace[1824370975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"136.229799ms","start":"2026-04-22T00:28:54.783854Z","end":"2026-04-22T00:28:54.920084Z","steps":["trace[1824370975] 'agreement among raft nodes before linearized reading' (duration: 135.976934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:54.920157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.421148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:54.920232Z","caller":"traceutil/trace.go:171","msg":"trace[1680754786] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:599; }","duration":"125.53241ms","start":"2026-04-22T00:28:54.794681Z","end":"2026-04-22T00:28:54.920213Z","steps":["trace[1680754786] 'agreement among raft nodes before linearized reading' (duration: 125.412038ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:54.941164Z","caller":"traceutil/trace.go:171","msg":"trace[1432172171] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"128.458141ms","start":"2026-04-22T00:28:54.812675Z","end":"2026-04-22T00:28:54.941133Z","steps":["trace[1432172171] 'process raft request' (duration: 128.290727ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:55.267874Z","caller":"traceutil/trace.go:171","msg":"trace[1619303940] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"123.10032ms","start":"2026-04-22T00:28:55.144725Z","end":"2026-04-22T00:28:55.267825Z","steps":["trace[1619303940] 'process raft request' (duration: 120.849705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:55.267972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.492088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xz52z\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-22T00:28:55.268122Z","caller":"traceutil/trace.go:171","msg":"trace[783346582] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xz52z; range_end:; response_count:1; response_revision:600; }","duration":"191.707052ms","start":"2026-04-22T00:28:55.076367Z","end":"2026-04-22T00:28:55.268074Z","steps":["trace[783346582] 'range keys from in-memory index tree' (duration: 191.181691ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:55.50957Z","caller":"traceutil/trace.go:171","msg":"trace[25337708] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"226.865319ms","start":"2026-04-22T00:28:55.282678Z","end":"2026-04-22T00:28:55.509544Z","steps":["trace[25337708] 'process raft request' (duration: 226.693916ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:55.523395Z","caller":"traceutil/trace.go:171","msg":"trace[1156779928] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"196.630212ms","start":"2026-04-22T00:28:55.326739Z","end":"2026-04-22T00:28:55.52337Z","steps":["trace[1156779928] 'process raft request' (duration: 195.980958ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:29:11.663188Z","caller":"traceutil/trace.go:171","msg":"trace[1498832311] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"117.854905ms","start":"2026-04-22T00:29:11.545307Z","end":"2026-04-22T00:29:11.663162Z","steps":["trace[1498832311] 'process raft request' (duration: 117.682332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:41.26553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.901607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T00:29:41.265802Z","caller":"traceutil/trace.go:171","msg":"trace[6966577] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1162; }","duration":"223.180183ms","start":"2026-04-22T00:29:41.042573Z","end":"2026-04-22T00:29:41.265754Z","steps":["trace[6966577] 'range keys from in-memory index tree' (duration: 222.711574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:41.265559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.567072ms","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-22T00:29:41.266058Z","caller":"traceutil/trace.go:171","msg":"trace[1773676672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1162; }","duration":"225.062071ms","start":"2026-04-22T00:29:41.040952Z","end":"2026-04-22T00:29:41.266014Z","steps":["trace[1773676672] 'range keys from in-memory index tree' (duration: 224.300846ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:29:41.297539Z","caller":"traceutil/trace.go:171","msg":"trace[339444743] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1200; }","duration":"102.302068ms","start":"2026-04-22T00:29:41.195218Z","end":"2026-04-22T00:29:41.29752Z","steps":["trace[339444743] 'read index received' (duration: 102.188395ms)","trace[339444743] 'applied index is now lower than readState.Index' (duration: 112.953µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:29:41.297614Z","caller":"traceutil/trace.go:171","msg":"trace[1701913505] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"116.000637ms","start":"2026-04-22T00:29:41.18159Z","end":"2026-04-22T00:29:41.297591Z","steps":["trace[1701913505] 'process raft request' (duration: 115.778603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:41.297841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.614924ms","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-22T00:29:41.297909Z","caller":"traceutil/trace.go:171","msg":"trace[1818276658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1163; }","duration":"102.719906ms","start":"2026-04-22T00:29:41.195173Z","end":"2026-04-22T00:29:41.297893Z","steps":["trace[1818276658] 'agreement among raft nodes before linearized reading' (duration: 102.541693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:41.297926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.658935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T00:29:41.298031Z","caller":"traceutil/trace.go:171","msg":"trace[762183592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1163; }","duration":"102.818418ms","start":"2026-04-22T00:29:41.195188Z","end":"2026-04-22T00:29:41.298006Z","steps":["trace[762183592] 'agreement among raft nodes before linearized reading' (duration: 102.455411ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:28.725454Z","caller":"traceutil/trace.go:171","msg":"trace[589527620] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"133.975612ms","start":"2026-04-22T00:30:28.591448Z","end":"2026-04-22T00:30:28.725424Z","steps":["trace[589527620] 'process raft request' (duration: 133.724316ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:19.676069Z","caller":"traceutil/trace.go:171","msg":"trace[234413327] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2257; }","duration":"115.642581ms","start":"2026-04-22T00:31:19.560395Z","end":"2026-04-22T00:31:19.676038Z","steps":["trace[234413327] 'read index received' (duration: 115.463548ms)","trace[234413327] 'applied index is now lower than readState.Index' (duration: 178.023µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:31:19.676206Z","caller":"traceutil/trace.go:171","msg":"trace[1774995919] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"165.693937ms","start":"2026-04-22T00:31:19.510488Z","end":"2026-04-22T00:31:19.676182Z","steps":["trace[1774995919] 'process raft request' (duration: 165.35786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:19.676395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.973958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:19.676516Z","caller":"traceutil/trace.go:171","msg":"trace[230658457] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2169; }","duration":"116.150192ms","start":"2026-04-22T00:31:19.560339Z","end":"2026-04-22T00:31:19.676489Z","steps":["trace[230658457] 'agreement among raft nodes before linearized reading' (duration: 115.872436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:12.4329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.922331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:32:12.43307Z","caller":"traceutil/trace.go:171","msg":"trace[1625270510] linearizableReadLoop","detail":"{readStateIndex:2738; appliedIndex:2737; }","duration":"208.713452ms","start":"2026-04-22T00:32:12.224331Z","end":"2026-04-22T00:32:12.433045Z","steps":["trace[1625270510] 'read index received' (duration: 3.560784ms)","trace[1625270510] 'applied index is now lower than readState.Index' (duration: 205.150078ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:32:12.433142Z","caller":"traceutil/trace.go:171","msg":"trace[1631609018] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"210.275325ms","start":"2026-04-22T00:32:12.222821Z","end":"2026-04-22T00:32:12.433097Z","steps":["trace[1631609018] 'process raft request' (duration: 66.914445ms)","trace[1631609018] 'compare' (duration: 142.654995ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:32:12.433361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.995017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T00:32:12.433465Z","caller":"traceutil/trace.go:171","msg":"trace[1573744684] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2631; }","duration":"209.411356ms","start":"2026-04-22T00:32:12.22403Z","end":"2026-04-22T00:32:12.433441Z","steps":["trace[1573744684] 'agreement among raft nodes before linearized reading' (duration: 209.086409ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:45.778072Z","caller":"traceutil/trace.go:171","msg":"trace[1537464359] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"179.7481ms","start":"2026-04-22T00:36:45.598291Z","end":"2026-04-22T00:36:45.778039Z","steps":["trace[1537464359] 'process raft request' (duration: 138.984032ms)","trace[1537464359] 'compare' (duration: 40.629575ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:45.824843Z","caller":"traceutil/trace.go:171","msg":"trace[1077457549] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"221.977189ms","start":"2026-04-22T00:36:45.602826Z","end":"2026-04-22T00:36:45.824803Z","steps":["trace[1077457549] 'process raft request' (duration: 221.751904ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:45.824913Z","caller":"traceutil/trace.go:171","msg":"trace[774570820] linearizableReadLoop","detail":"{readStateIndex:5229; appliedIndex:5226; }","duration":"194.366199ms","start":"2026-04-22T00:36:45.630525Z","end":"2026-04-22T00:36:45.824891Z","steps":["trace[774570820] 'read index received' (duration: 106.764415ms)","trace[774570820] 'applied index is now lower than readState.Index' (duration: 87.600434ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:45.824974Z","caller":"traceutil/trace.go:171","msg":"trace[635525980] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"210.252673ms","start":"2026-04-22T00:36:45.61468Z","end":"2026-04-22T00:36:45.824933Z","steps":["trace[635525980] 'process raft request' (duration: 210.046117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:45.825136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.562283ms","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-22T00:36:45.825201Z","caller":"traceutil/trace.go:171","msg":"trace[436623424] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5033; }","duration":"194.693236ms","start":"2026-04-22T00:36:45.630494Z","end":"2026-04-22T00:36:45.825187Z","steps":["trace[436623424] 'agreement among raft nodes before linearized reading' (duration: 194.484192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:46.222383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.445479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:36:46.222536Z","caller":"traceutil/trace.go:171","msg":"trace[792909246] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:5036; }","duration":"204.673164ms","start":"2026-04-22T00:36:46.017839Z","end":"2026-04-22T00:36:46.222513Z","steps":["trace[792909246] 'count revisions from in-memory index tree' (duration: 204.268896ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:46.267784Z","caller":"traceutil/trace.go:171","msg":"trace[503229801] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"215.358ms","start":"2026-04-22T00:36:46.052393Z","end":"2026-04-22T00:36:46.267751Z","steps":["trace[503229801] 'process raft request' (duration: 215.112904ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:37:05.92089Z","caller":"traceutil/trace.go:171","msg":"trace[1328256135] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"194.97404ms","start":"2026-04-22T00:37:05.725889Z","end":"2026-04-22T00:37:05.920863Z","steps":["trace[1328256135] 'process raft request' (duration: 125.485468ms)","trace[1328256135] 'compare' (duration: 69.327389ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:37:05.921182Z","caller":"traceutil/trace.go:171","msg":"trace[1716440358] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"195.279616ms","start":"2026-04-22T00:37:05.725887Z","end":"2026-04-22T00:37:05.921166Z","steps":["trace[1716440358] 'process raft request' (duration: 194.938439ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:37:05.921324Z","caller":"traceutil/trace.go:171","msg":"trace[771241575] linearizableReadLoop","detail":"{readStateIndex:5625; appliedIndex:5620; }","duration":"172.400065ms","start":"2026-04-22T00:37:05.748892Z","end":"2026-04-22T00:37:05.921292Z","steps":["trace[771241575] 'read index received' (duration: 102.472214ms)","trace[771241575] 'applied index is now lower than readState.Index' (duration: 69.926511ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:37:05.921412Z","caller":"traceutil/trace.go:171","msg":"trace[19732429] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"195.48096ms","start":"2026-04-22T00:37:05.72592Z","end":"2026-04-22T00:37:05.921401Z","steps":["trace[19732429] 'process raft request' (duration: 195.114173ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:37:05.921476Z","caller":"traceutil/trace.go:171","msg":"trace[1429278148] transaction","detail":"{read_only:false; response_revision:5420; number_of_response:1; }","duration":"193.283936ms","start":"2026-04-22T00:37:05.728178Z","end":"2026-04-22T00:37:05.921462Z","steps":["trace[1429278148] 'process raft request' (duration: 193.057371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:37:05.921581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.670851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:37:05.921647Z","caller":"traceutil/trace.go:171","msg":"trace[625845887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5420; }","duration":"172.775473ms","start":"2026-04-22T00:37:05.748856Z","end":"2026-04-22T00:37:05.921631Z","steps":["trace[625845887] 'agreement among raft nodes before linearized reading' (duration: 172.63555ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:37:05.921344Z","caller":"traceutil/trace.go:171","msg":"trace[2042734357] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"194.571822ms","start":"2026-04-22T00:37:05.726744Z","end":"2026-04-22T00:37:05.921316Z","steps":["trace[2042734357] 'process raft request' (duration: 194.416858ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:37:17.131367Z","caller":"traceutil/trace.go:171","msg":"trace[1776466103] linearizableReadLoop","detail":"{readStateIndex:5785; appliedIndex:5784; }","duration":"249.033338ms","start":"2026-04-22T00:37:16.882297Z","end":"2026-04-22T00:37:17.13133Z","steps":["trace[1776466103] 'read index received' (duration: 248.832414ms)","trace[1776466103] 'applied index is now lower than readState.Index' (duration: 199.574µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:37:17.13142Z","caller":"traceutil/trace.go:171","msg":"trace[1400852394] transaction","detail":"{read_only:false; response_revision:5575; number_of_response:1; }","duration":"250.326994ms","start":"2026-04-22T00:37:16.881059Z","end":"2026-04-22T00:37:17.131386Z","steps":["trace[1400852394] 'process raft request' (duration: 250.031068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:37:17.131641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.308483ms","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-22T00:37:17.131696Z","caller":"traceutil/trace.go:171","msg":"trace[379680572] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5575; }","duration":"249.414065ms","start":"2026-04-22T00:37:16.882268Z","end":"2026-04-22T00:37:17.131682Z","steps":["trace[379680572] 'agreement among raft nodes before linearized reading' (duration: 249.199691ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:37:17.227743Z","caller":"traceutil/trace.go:171","msg":"trace[665500659] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"123.782924ms","start":"2026-04-22T00:37:17.103891Z","end":"2026-04-22T00:37:17.227674Z","steps":["trace[665500659] 'process raft request' (duration: 58.828478ms)","trace[665500659] 'compare' (duration: 64.715051ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:38:08.931111Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2963} {"level":"info","ts":"2026-04-22T00:38:09.118191Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2963,"took":"185.463629ms","hash":2393314265,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":33345536,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-22T00:38:09.11828Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2393314265,"revision":2963,"compact-revision":-1} {"level":"warn","ts":"2026-04-22T00:43:02.915852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.110409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-22T00:43:02.915944Z","caller":"traceutil/trace.go:171","msg":"trace[1271342254] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8075; }","duration":"160.251941ms","start":"2026-04-22T00:43:02.755671Z","end":"2026-04-22T00:43:02.915923Z","steps":["trace[1271342254] 'range keys from in-memory index tree' (duration: 159.972156ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:08.941807Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6019} {"level":"info","ts":"2026-04-22T00:43:09.043161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6019,"took":"98.499292ms","hash":1940744915,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":23232512,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-22T00:43:09.043239Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1940744915,"revision":6019,"compact-revision":2963} {"level":"warn","ts":"2026-04-22T00:43:10.066196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.485847ms","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-04-22T00:43:10.066286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.849564ms","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-04-22T00:43:10.066297Z","caller":"traceutil/trace.go:171","msg":"trace[1606493981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8242; }","duration":"251.625369ms","start":"2026-04-22T00:43:09.814644Z","end":"2026-04-22T00:43:10.066269Z","steps":["trace[1606493981] 'range keys from in-memory index tree' (duration: 251.302433ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:10.066338Z","caller":"traceutil/trace.go:171","msg":"trace[459906389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8242; }","duration":"250.922335ms","start":"2026-04-22T00:43:09.8154Z","end":"2026-04-22T00:43:10.066323Z","steps":["trace[459906389] 'range keys from in-memory index tree' (duration: 250.725422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:10.066517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.726047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-22T00:43:10.066565Z","caller":"traceutil/trace.go:171","msg":"trace[645183669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8242; }","duration":"319.804488ms","start":"2026-04-22T00:43:09.746748Z","end":"2026-04-22T00:43:10.066552Z","steps":["trace[645183669] 'range keys from in-memory index tree' (duration: 319.539333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:10.066603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:09.746722Z","time spent":"319.869391ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T00:43:10.06679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.941109ms","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-22T00:43:10.066868Z","caller":"traceutil/trace.go:171","msg":"trace[496101172] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8242; }","duration":"310.063512ms","start":"2026-04-22T00:43:09.756786Z","end":"2026-04-22T00:43:10.066849Z","steps":["trace[496101172] 'range keys from in-memory index tree' (duration: 309.780656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:10.066908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:09.75677Z","time spent":"310.130333ms","remote":"127.0.0.1:60334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-22T00:43:10.066923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.802014ms","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":"info","ts":"2026-04-22T00:43:10.066968Z","caller":"traceutil/trace.go:171","msg":"trace[259993637] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8242; }","duration":"253.873256ms","start":"2026-04-22T00:43:09.813082Z","end":"2026-04-22T00:43:10.066955Z","steps":["trace[259993637] 'range keys from in-memory index tree' (duration: 253.693102ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:21.938867Z","caller":"traceutil/trace.go:171","msg":"trace[495015083] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"134.580312ms","start":"2026-04-22T00:43:21.804262Z","end":"2026-04-22T00:43:21.938842Z","steps":["trace[495015083] 'process raft request' (duration: 134.422559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:22.973672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.877265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:43:22.973988Z","caller":"traceutil/trace.go:171","msg":"trace[1259972596] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"310.542101ms","start":"2026-04-22T00:43:22.663363Z","end":"2026-04-22T00:43:22.973905Z","steps":["trace[1259972596] 'process raft request' (duration: 51.339949ms)","trace[1259972596] 'compare' (duration: 258.681821ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:22.974114Z","caller":"traceutil/trace.go:171","msg":"trace[486426119] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"308.5368ms","start":"2026-04-22T00:43:22.665555Z","end":"2026-04-22T00:43:22.974092Z","steps":["trace[486426119] 'process raft request' (duration: 308.222334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:22.974242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:22.66553Z","time spent":"308.655692ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:43:22.974278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:22.663328Z","time spent":"310.810096ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:43:22.974302Z","caller":"traceutil/trace.go:171","msg":"trace[390182224] transaction","detail":"{read_only:false; response_revision:8314; number_of_response:1; }","duration":"303.415136ms","start":"2026-04-22T00:43:22.670857Z","end":"2026-04-22T00:43:22.974273Z","steps":["trace[390182224] 'process raft request' (duration: 303.12929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:22.974373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.870626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:43:22.974228Z","caller":"traceutil/trace.go:171","msg":"trace[963389346] linearizableReadLoop","detail":"{readStateIndex:8614; appliedIndex:8611; }","duration":"260.720514ms","start":"2026-04-22T00:43:22.713481Z","end":"2026-04-22T00:43:22.974202Z","steps":["trace[963389346] 'read index received' (duration: 1.151594ms)","trace[963389346] 'applied index is now lower than readState.Index' (duration: 259.56712ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:22.974461Z","caller":"traceutil/trace.go:171","msg":"trace[1208298394] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:8314; }","duration":"261.018239ms","start":"2026-04-22T00:43:22.713419Z","end":"2026-04-22T00:43:22.974437Z","steps":["trace[1208298394] 'agreement among raft nodes before linearized reading' (duration: 260.867116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:22.974464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:22.67084Z","time spent":"303.540279ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:43:22.974565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.346358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:43:22.974612Z","caller":"traceutil/trace.go:171","msg":"trace[1948092712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8314; }","duration":"228.42587ms","start":"2026-04-22T00:43:22.746174Z","end":"2026-04-22T00:43:22.974599Z","steps":["trace[1948092712] 'agreement among raft nodes before linearized reading' (duration: 228.323368ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:51.256359Z","caller":"traceutil/trace.go:171","msg":"trace[1560271767] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"190.398052ms","start":"2026-04-22T00:43:51.065935Z","end":"2026-04-22T00:43:51.256333Z","steps":["trace[1560271767] 'process raft request' (duration: 190.232568ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:51.349365Z","caller":"traceutil/trace.go:171","msg":"trace[1645232002] linearizableReadLoop","detail":"{readStateIndex:8824; appliedIndex:8821; }","duration":"277.252608ms","start":"2026-04-22T00:43:51.07209Z","end":"2026-04-22T00:43:51.349343Z","steps":["trace[1645232002] 'read index received' (duration: 184.072113ms)","trace[1645232002] 'applied index is now lower than readState.Index' (duration: 93.179665ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:51.349435Z","caller":"traceutil/trace.go:171","msg":"trace[1956686264] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"283.425183ms","start":"2026-04-22T00:43:51.065983Z","end":"2026-04-22T00:43:51.349408Z","steps":["trace[1956686264] 'process raft request' (duration: 283.202969ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:51.349505Z","caller":"traceutil/trace.go:171","msg":"trace[579975049] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"283.353811ms","start":"2026-04-22T00:43:51.066109Z","end":"2026-04-22T00:43:51.349463Z","steps":["trace[579975049] 'process raft request' (duration: 283.186368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:51.349551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.452072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-22T00:43:51.349601Z","caller":"traceutil/trace.go:171","msg":"trace[850724329] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8517; }","duration":"277.541174ms","start":"2026-04-22T00:43:51.072046Z","end":"2026-04-22T00:43:51.349587Z","steps":["trace[850724329] 'agreement among raft nodes before linearized reading' (duration: 277.388811ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:54.933414Z","caller":"traceutil/trace.go:171","msg":"trace[1899235921] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"130.132852ms","start":"2026-04-22T00:43:54.80325Z","end":"2026-04-22T00:43:54.933382Z","steps":["trace[1899235921] 'process raft request' (duration: 129.921718ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:04.664043Z","caller":"traceutil/trace.go:171","msg":"trace[1807303863] linearizableReadLoop","detail":"{readStateIndex:8938; appliedIndex:8937; }","duration":"169.472858ms","start":"2026-04-22T00:44:04.49454Z","end":"2026-04-22T00:44:04.664012Z","steps":["trace[1807303863] 'read index received' (duration: 169.237763ms)","trace[1807303863] 'applied index is now lower than readState.Index' (duration: 233.925µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:44:04.664223Z","caller":"traceutil/trace.go:171","msg":"trace[1266080429] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"170.422697ms","start":"2026-04-22T00:44:04.493768Z","end":"2026-04-22T00:44:04.66419Z","steps":["trace[1266080429] 'process raft request' (duration: 170.04535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:44:04.664388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.239362ms","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-04-22T00:44:04.664447Z","caller":"traceutil/trace.go:171","msg":"trace[423998472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8626; }","duration":"163.340993ms","start":"2026-04-22T00:44:04.501093Z","end":"2026-04-22T00:44:04.664434Z","steps":["trace[423998472] 'agreement among raft nodes before linearized reading' (duration: 163.17977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:44:04.664616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.072569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xf7lv\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-22T00:44:04.664666Z","caller":"traceutil/trace.go:171","msg":"trace[442822481] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xf7lv; range_end:; response_count:1; response_revision:8626; }","duration":"119.179321ms","start":"2026-04-22T00:44:04.545474Z","end":"2026-04-22T00:44:04.664653Z","steps":["trace[442822481] 'agreement among raft nodes before linearized reading' (duration: 119.064248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:44:04.664752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.204953ms","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-04-22T00:44:04.664764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.19779ms","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":"info","ts":"2026-04-22T00:44:04.664801Z","caller":"traceutil/trace.go:171","msg":"trace[1354111142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8626; }","duration":"170.269034ms","start":"2026-04-22T00:44:04.494522Z","end":"2026-04-22T00:44:04.664791Z","steps":["trace[1354111142] 'agreement among raft nodes before linearized reading' (duration: 170.076539ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:04.665571Z","caller":"traceutil/trace.go:171","msg":"trace[1621937642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8626; }","duration":"155.280772ms","start":"2026-04-22T00:44:04.509523Z","end":"2026-04-22T00:44:04.664804Z","steps":["trace[1621937642] 'agreement among raft nodes before linearized reading' (duration: 155.102517ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:05.402112Z","caller":"traceutil/trace.go:171","msg":"trace[98909360] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"261.136071ms","start":"2026-04-22T00:44:05.140945Z","end":"2026-04-22T00:44:05.402081Z","steps":["trace[98909360] 'process raft request' (duration: 260.925367ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:05.425911Z","caller":"traceutil/trace.go:171","msg":"trace[318857117] transaction","detail":"{read_only:false; response_revision:8636; number_of_response:1; }","duration":"120.622299ms","start":"2026-04-22T00:44:05.305264Z","end":"2026-04-22T00:44:05.425887Z","steps":["trace[318857117] 'process raft request' (duration: 120.457076ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:05.571041Z","caller":"traceutil/trace.go:171","msg":"trace[156827364] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"168.961777ms","start":"2026-04-22T00:44:05.402034Z","end":"2026-04-22T00:44:05.570996Z","steps":["trace[156827364] 'process raft request' (duration: 146.011823ms)","trace[156827364] 'compare' (duration: 22.618598ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:44:05.570964Z","caller":"traceutil/trace.go:171","msg":"trace[98530849] linearizableReadLoop","detail":"{readStateIndex:8950; appliedIndex:8947; }","duration":"158.641939ms","start":"2026-04-22T00:44:05.412288Z","end":"2026-04-22T00:44:05.57093Z","steps":["trace[98530849] 'read index received' (duration: 13.452742ms)","trace[98530849] 'applied index is now lower than readState.Index' (duration: 145.187587ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:44:05.571203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.895884ms","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-22T00:44:05.571326Z","caller":"traceutil/trace.go:171","msg":"trace[246228503] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8638; }","duration":"159.030746ms","start":"2026-04-22T00:44:05.412272Z","end":"2026-04-22T00:44:05.571302Z","steps":["trace[246228503] 'agreement among raft nodes before linearized reading' (duration: 158.857633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:44:05.571445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.040408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-22T00:44:05.571569Z","caller":"traceutil/trace.go:171","msg":"trace[796458791] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8638; }","duration":"120.215411ms","start":"2026-04-22T00:44:05.451325Z","end":"2026-04-22T00:44:05.57154Z","steps":["trace[796458791] 'agreement among raft nodes before linearized reading' (duration: 119.977416ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:46.672214Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002472.wal"} {"level":"info","ts":"2026-04-22T00:45:22.079811Z","caller":"traceutil/trace.go:171","msg":"trace[1729817000] transaction","detail":"{read_only:false; response_revision:9383; number_of_response:1; }","duration":"210.493221ms","start":"2026-04-22T00:45:21.869295Z","end":"2026-04-22T00:45:22.079789Z","steps":["trace[1729817000] 'process raft request' (duration: 210.334097ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:45:59.824505Z","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-04-22T00:45:59.830868Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T00:45:59.831037Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T00:46:14.873449Z","caller":"traceutil/trace.go:171","msg":"trace[584790727] transaction","detail":"{read_only:false; response_revision:9761; number_of_response:1; }","duration":"107.835731ms","start":"2026-04-22T00:46:14.765562Z","end":"2026-04-22T00:46:14.873397Z","steps":["trace[584790727] 'process raft request' (duration: 96.732395ms)","trace[584790727] 'compare' (duration: 10.611826ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:46:14.873584Z","caller":"traceutil/trace.go:171","msg":"trace[1780528044] transaction","detail":"{read_only:false; response_revision:9763; number_of_response:1; }","duration":"106.4385ms","start":"2026-04-22T00:46:14.767116Z","end":"2026-04-22T00:46:14.873554Z","steps":["trace[1780528044] 'process raft request' (duration: 106.334668ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:46:14.873671Z","caller":"traceutil/trace.go:171","msg":"trace[1445872491] transaction","detail":"{read_only:false; response_revision:9762; number_of_response:1; }","duration":"108.041726ms","start":"2026-04-22T00:46:14.765581Z","end":"2026-04-22T00:46:14.873622Z","steps":["trace[1445872491] 'process raft request' (duration: 107.681638ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:48:08.949771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8240} {"level":"info","ts":"2026-04-22T00:48:09.035493Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8240,"took":"81.88098ms","hash":1641288302,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":25985024,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-22T00:48:09.035606Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1641288302,"revision":8240,"compact-revision":6019} {"level":"info","ts":"2026-04-22T00:53:08.955485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10636} {"level":"info","ts":"2026-04-22T00:53:09.034914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10636,"took":"76.850453ms","hash":2473460574,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":20660224,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-22T00:53:09.034987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2473460574,"revision":10636,"compact-revision":8240}