{"level":"warn","ts":"2026-06-26T02:14:32.318496Z","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-26T02:14:32.318586Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-26T02:14:32.318664Z","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-26T02:14:32.318677Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-06-26T02:14:32.31874Z","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-26T02:14:32.319493Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-06-26T02:14:32.319604Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-26T02:14:32.324595Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.560918ms"} {"level":"info","ts":"2026-06-26T02:14:32.330363Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-06-26T02:14:32.330475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T02:14:32.330504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-06-26T02:14:32.33052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T02:14:32.330546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.330612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-06-26T02:14:32.33569Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T02:14:32.337783Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T02:14:32.338799Z","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-26T02:14:32.343228Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T02:14:32.343495Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T02:14:32.343808Z","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-26T02:14:32.34391Z","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-26T02:14:32.343925Z","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-26T02:14:32.344875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-06-26T02:14:32.34507Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-06-26T02:14:32.349905Z","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-26T02:14:32.350048Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-06-26T02:14:32.350112Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-06-26T02:14:32.350189Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T02:14:32.350243Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T02:14:32.731155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.731368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.731464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.731525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.731574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.731646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.731717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.733106Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T02:14:32.733201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:14:32.733159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:14:32.733384Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T02:14:32.733424Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T02:14:32.733177Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.735674Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.735875Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.735983Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.738298Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-06-26T02:14:32.744135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T02:15:16.596849Z","caller":"traceutil/trace.go:171","msg":"trace[1453653362] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"146.522962ms","start":"2026-06-26T02:15:16.45029Z","end":"2026-06-26T02:15:16.596813Z","steps":["trace[1453653362] 'process raft request' (duration: 145.661425ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:16.926341Z","caller":"traceutil/trace.go:171","msg":"trace[272736564] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"209.78775ms","start":"2026-06-26T02:15:16.716508Z","end":"2026-06-26T02:15:16.926296Z","steps":["trace[272736564] 'process raft request' (duration: 198.089225ms)","trace[272736564] 'compare' (duration: 11.43493ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:17.392436Z","caller":"traceutil/trace.go:171","msg":"trace[186241655] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"320.797388ms","start":"2026-06-26T02:15:17.071609Z","end":"2026-06-26T02:15:17.392407Z","steps":["trace[186241655] 'process raft request' (duration: 320.147196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:17.393157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:17.071563Z","time spent":"320.965431ms","remote":"127.0.0.1:53144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:16:45.340016Z","caller":"traceutil/trace.go:171","msg":"trace[686164172] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"220.481256ms","start":"2026-06-26T02:16:45.119494Z","end":"2026-06-26T02:16:45.339976Z","steps":["trace[686164172] 'read index received' (duration: 220.18789ms)","trace[686164172] 'applied index is now lower than readState.Index' (duration: 291.696µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:16:45.340096Z","caller":"traceutil/trace.go:171","msg":"trace[468432680] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"226.88962ms","start":"2026-06-26T02:16:45.113142Z","end":"2026-06-26T02:16:45.340032Z","steps":["trace[468432680] 'process raft request' (duration: 226.556804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:45.340381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.809612ms","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-26T02:16:45.34045Z","caller":"traceutil/trace.go:171","msg":"trace[1075385074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1850; }","duration":"221.006105ms","start":"2026-06-26T02:16:45.119431Z","end":"2026-06-26T02:16:45.340437Z","steps":["trace[1075385074] 'agreement among raft nodes before linearized reading' (duration: 220.72622ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:45.428482Z","caller":"traceutil/trace.go:171","msg":"trace[437212171] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"240.936872ms","start":"2026-06-26T02:16:45.187493Z","end":"2026-06-26T02:16:45.42843Z","steps":["trace[437212171] 'process raft request' (duration: 194.488312ms)","trace[437212171] 'compare' (duration: 46.213766ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:16:45.428682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.100097ms","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-06-26T02:16:45.42878Z","caller":"traceutil/trace.go:171","msg":"trace[593074939] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1852; }","duration":"304.240539ms","start":"2026-06-26T02:16:45.124519Z","end":"2026-06-26T02:16:45.42876Z","steps":["trace[593074939] 'agreement among raft nodes before linearized reading' (duration: 303.966214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:45.428837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:45.124508Z","time spent":"304.319691ms","remote":"127.0.0.1:53314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T02:17:29.773559Z","caller":"traceutil/trace.go:171","msg":"trace[2043241545] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"114.411879ms","start":"2026-06-26T02:17:29.659096Z","end":"2026-06-26T02:17:29.773508Z","steps":["trace[2043241545] 'process raft request' (duration: 114.118993ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:36.026206Z","caller":"traceutil/trace.go:171","msg":"trace[195203184] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2263; }","duration":"212.710495ms","start":"2026-06-26T02:17:35.813466Z","end":"2026-06-26T02:17:36.026176Z","steps":["trace[195203184] 'read index received' (duration: 168.999356ms)","trace[195203184] 'applied index is now lower than readState.Index' (duration: 43.710069ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:36.026445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.963639ms","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-26T02:17:36.026488Z","caller":"traceutil/trace.go:171","msg":"trace[502797247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2182; }","duration":"213.080821ms","start":"2026-06-26T02:17:35.813396Z","end":"2026-06-26T02:17:36.026476Z","steps":["trace[502797247] 'agreement among raft nodes before linearized reading' (duration: 212.933549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:36.026543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.427798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-26T02:17:36.026631Z","caller":"traceutil/trace.go:171","msg":"trace[186914858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2182; }","duration":"181.564621ms","start":"2026-06-26T02:17:35.845047Z","end":"2026-06-26T02:17:36.026612Z","steps":["trace[186914858] 'agreement among raft nodes before linearized reading' (duration: 181.362277ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:36.026318Z","caller":"traceutil/trace.go:171","msg":"trace[819744509] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"219.603058ms","start":"2026-06-26T02:17:35.806667Z","end":"2026-06-26T02:17:36.02627Z","steps":["trace[819744509] 'process raft request' (duration: 175.811139ms)","trace[819744509] 'compare' (duration: 43.577205ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:36.027242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.275068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-26T02:17:36.027382Z","caller":"traceutil/trace.go:171","msg":"trace[1038643248] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:2182; }","duration":"126.450373ms","start":"2026-06-26T02:17:35.900904Z","end":"2026-06-26T02:17:36.027354Z","steps":["trace[1038643248] 'agreement among raft nodes before linearized reading' (duration: 125.83713ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:36.588631Z","caller":"traceutil/trace.go:171","msg":"trace[665627219] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2268; }","duration":"124.913072ms","start":"2026-06-26T02:17:36.463687Z","end":"2026-06-26T02:17:36.5886Z","steps":["trace[665627219] 'read index received' (duration: 124.79894ms)","trace[665627219] 'applied index is now lower than readState.Index' (duration: 112.892µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:36.588881Z","caller":"traceutil/trace.go:171","msg":"trace[955309104] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"154.013446ms","start":"2026-06-26T02:17:36.434804Z","end":"2026-06-26T02:17:36.588818Z","steps":["trace[955309104] 'process raft request' (duration: 153.614068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:36.589103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.405222ms","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-26T02:17:36.589155Z","caller":"traceutil/trace.go:171","msg":"trace[1338756080] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2186; }","duration":"125.523484ms","start":"2026-06-26T02:17:36.463617Z","end":"2026-06-26T02:17:36.58914Z","steps":["trace[1338756080] 'agreement among raft nodes before linearized reading' (duration: 125.100135ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:41.956604Z","caller":"traceutil/trace.go:171","msg":"trace[2029899495] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"210.059933ms","start":"2026-06-26T02:17:41.746495Z","end":"2026-06-26T02:17:41.956555Z","steps":["trace[2029899495] 'process raft request' (duration: 163.198084ms)","trace[2029899495] 'compare' (duration: 46.337339ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:02.911725Z","caller":"traceutil/trace.go:171","msg":"trace[1599353709] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"122.064352ms","start":"2026-06-26T02:19:02.789632Z","end":"2026-06-26T02:19:02.911696Z","steps":["trace[1599353709] 'process raft request' (duration: 121.853868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:23:03.471543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.216734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ec6cd36b-1b34-4303-a9da-b07fb6a9a6cb\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-06-26T02:23:03.471677Z","caller":"traceutil/trace.go:171","msg":"trace[102194313] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ec6cd36b-1b34-4303-a9da-b07fb6a9a6cb; range_end:; response_count:1; response_revision:4960; }","duration":"111.424808ms","start":"2026-06-26T02:23:03.360226Z","end":"2026-06-26T02:23:03.471651Z","steps":["trace[102194313] 'range keys from in-memory index tree' (duration: 111.016271ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:16.651422Z","caller":"traceutil/trace.go:171","msg":"trace[2134384304] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"102.315312ms","start":"2026-06-26T02:23:16.549063Z","end":"2026-06-26T02:23:16.651378Z","steps":["trace[2134384304] 'process raft request' (duration: 102.072248ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:16.894557Z","caller":"traceutil/trace.go:171","msg":"trace[56973410] linearizableReadLoop","detail":"{readStateIndex:5466; appliedIndex:5465; }","duration":"228.873402ms","start":"2026-06-26T02:23:16.665631Z","end":"2026-06-26T02:23:16.894504Z","steps":["trace[56973410] 'read index received' (duration: 187.773939ms)","trace[56973410] 'applied index is now lower than readState.Index' (duration: 41.096983ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:23:16.894809Z","caller":"traceutil/trace.go:171","msg":"trace[1790806890] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"229.596116ms","start":"2026-06-26T02:23:16.665156Z","end":"2026-06-26T02:23:16.894752Z","steps":["trace[1790806890] 'process raft request' (duration: 188.490354ms)","trace[1790806890] 'compare' (duration: 40.353167ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:23:16.895136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.480693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:131065"} {"level":"info","ts":"2026-06-26T02:23:16.895817Z","caller":"traceutil/trace.go:171","msg":"trace[83847367] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5267; }","duration":"230.225979ms","start":"2026-06-26T02:23:16.665542Z","end":"2026-06-26T02:23:16.895768Z","steps":["trace[83847367] 'agreement among raft nodes before linearized reading' (duration: 229.314221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:23:16.896479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.814763ms","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":"warn","ts":"2026-06-26T02:23:16.896474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.932178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:23:16.89662Z","caller":"traceutil/trace.go:171","msg":"trace[763357193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5267; }","duration":"194.137682ms","start":"2026-06-26T02:23:16.702444Z","end":"2026-06-26T02:23:16.896582Z","steps":["trace[763357193] 'agreement among raft nodes before linearized reading' (duration: 193.886047ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:16.896581Z","caller":"traceutil/trace.go:171","msg":"trace[1677831783] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:5267; }","duration":"128.972096ms","start":"2026-06-26T02:23:16.767585Z","end":"2026-06-26T02:23:16.896557Z","steps":["trace[1677831783] 'agreement among raft nodes before linearized reading' (duration: 128.789413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:23:16.896636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.058093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-06-26T02:23:16.896953Z","caller":"traceutil/trace.go:171","msg":"trace[555754535] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:5267; }","duration":"134.377419ms","start":"2026-06-26T02:23:16.762495Z","end":"2026-06-26T02:23:16.896872Z","steps":["trace[555754535] 'agreement among raft nodes before linearized reading' (duration: 133.935061ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:25.412462Z","caller":"traceutil/trace.go:171","msg":"trace[1147944911] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"228.31407ms","start":"2026-06-26T02:23:25.184102Z","end":"2026-06-26T02:23:25.412416Z","steps":["trace[1147944911] 'process raft request' (duration: 215.487673ms)","trace[1147944911] 'compare' (duration: 12.41736ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:23:25.412654Z","caller":"traceutil/trace.go:171","msg":"trace[1291556582] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"163.516322ms","start":"2026-06-26T02:23:25.249117Z","end":"2026-06-26T02:23:25.412634Z","steps":["trace[1291556582] 'process raft request' (duration: 163.253136ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:25.41267Z","caller":"traceutil/trace.go:171","msg":"trace[1875385823] transaction","detail":"{read_only:false; response_revision:5420; number_of_response:1; }","duration":"228.102587ms","start":"2026-06-26T02:23:25.184515Z","end":"2026-06-26T02:23:25.412617Z","steps":["trace[1875385823] 'process raft request' (duration: 227.76734ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:25.412936Z","caller":"traceutil/trace.go:171","msg":"trace[1149541808] linearizableReadLoop","detail":"{readStateIndex:5620; appliedIndex:5618; }","duration":"202.515394ms","start":"2026-06-26T02:23:25.210408Z","end":"2026-06-26T02:23:25.412924Z","steps":["trace[1149541808] 'read index received' (duration: 189.159376ms)","trace[1149541808] 'applied index is now lower than readState.Index' (duration: 13.354888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:23:25.413221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.796013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9jzbv\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-26T02:23:25.413274Z","caller":"traceutil/trace.go:171","msg":"trace[1055265597] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9jzbv; range_end:; response_count:1; response_revision:5422; }","duration":"197.907474ms","start":"2026-06-26T02:23:25.215353Z","end":"2026-06-26T02:23:25.41326Z","steps":["trace[1055265597] 'agreement among raft nodes before linearized reading' (duration: 197.66935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:23:25.413419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.775561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-26T02:23:25.413416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.989502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana.18bc804154c1a7b0\" ","response":"range_response_count:1 size:736"} {"level":"info","ts":"2026-06-26T02:23:25.41346Z","caller":"traceutil/trace.go:171","msg":"trace[1153828912] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5422; }","duration":"129.881044ms","start":"2026-06-26T02:23:25.283571Z","end":"2026-06-26T02:23:25.413452Z","steps":["trace[1153828912] 'agreement among raft nodes before linearized reading' (duration: 129.465256ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:25.413473Z","caller":"traceutil/trace.go:171","msg":"trace[766849742] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana.18bc804154c1a7b0; range_end:; response_count:1; response_revision:5422; }","duration":"203.099245ms","start":"2026-06-26T02:23:25.21036Z","end":"2026-06-26T02:23:25.413459Z","steps":["trace[766849742] 'agreement among raft nodes before linearized reading' (duration: 202.667027ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:37.684118Z","caller":"traceutil/trace.go:171","msg":"trace[1311978675] linearizableReadLoop","detail":"{readStateIndex:5822; appliedIndex:5821; }","duration":"198.70902ms","start":"2026-06-26T02:23:37.485375Z","end":"2026-06-26T02:23:37.684084Z","steps":["trace[1311978675] 'read index received' (duration: 163.420091ms)","trace[1311978675] 'applied index is now lower than readState.Index' (duration: 35.287789ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:23:37.684422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.019306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9jzbv\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-26T02:23:37.684467Z","caller":"traceutil/trace.go:171","msg":"trace[923147496] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9jzbv; range_end:; response_count:1; response_revision:5616; }","duration":"199.124778ms","start":"2026-06-26T02:23:37.485327Z","end":"2026-06-26T02:23:37.684452Z","steps":["trace[923147496] 'agreement among raft nodes before linearized reading' (duration: 198.878714ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:23:37.684458Z","caller":"traceutil/trace.go:171","msg":"trace[816188903] transaction","detail":"{read_only:false; response_revision:5616; number_of_response:1; }","duration":"225.215381ms","start":"2026-06-26T02:23:37.459183Z","end":"2026-06-26T02:23:37.684398Z","steps":["trace[816188903] 'process raft request' (duration: 189.687147ms)","trace[816188903] 'compare' (duration: 35.025695ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:24:32.76602Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3011} {"level":"info","ts":"2026-06-26T02:24:32.850108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3011,"took":"82.727702ms","hash":619717162,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":31911936,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-26T02:24:32.850197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":619717162,"revision":3011,"compact-revision":-1} {"level":"info","ts":"2026-06-26T02:29:32.820571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6095} {"level":"info","ts":"2026-06-26T02:29:33.032135Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6095,"took":"209.027709ms","hash":997053410,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":21893120,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-26T02:29:33.032197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":997053410,"revision":6095,"compact-revision":3011} {"level":"info","ts":"2026-06-26T02:29:39.849008Z","caller":"traceutil/trace.go:171","msg":"trace[1019869125] linearizableReadLoop","detail":"{readStateIndex:8640; appliedIndex:8639; }","duration":"184.741176ms","start":"2026-06-26T02:29:39.664228Z","end":"2026-06-26T02:29:39.848969Z","steps":["trace[1019869125] 'read index received' (duration: 184.48345ms)","trace[1019869125] 'applied index is now lower than readState.Index' (duration: 255.886µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:29:39.849104Z","caller":"traceutil/trace.go:171","msg":"trace[815418606] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"270.672418ms","start":"2026-06-26T02:29:39.578395Z","end":"2026-06-26T02:29:39.849067Z","steps":["trace[815418606] 'process raft request' (duration: 270.349581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:29:39.849281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.042122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-26T02:29:39.849329Z","caller":"traceutil/trace.go:171","msg":"trace[1038382173] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8345; }","duration":"185.154474ms","start":"2026-06-26T02:29:39.664162Z","end":"2026-06-26T02:29:39.849317Z","steps":["trace[1038382173] 'agreement among raft nodes before linearized reading' (duration: 184.980021ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:29:40.030186Z","caller":"traceutil/trace.go:171","msg":"trace[189791439] linearizableReadLoop","detail":"{readStateIndex:8641; appliedIndex:8640; }","duration":"181.048305ms","start":"2026-06-26T02:29:39.849109Z","end":"2026-06-26T02:29:40.030157Z","steps":["trace[189791439] 'read index received' (duration: 174.242716ms)","trace[189791439] 'applied index is now lower than readState.Index' (duration: 6.802599ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:29:40.030216Z","caller":"traceutil/trace.go:171","msg":"trace[1132420923] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"325.87456ms","start":"2026-06-26T02:29:39.704309Z","end":"2026-06-26T02:29:40.030183Z","steps":["trace[1132420923] 'process raft request' (duration: 319.019419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:29:40.030379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:29:39.704273Z","time spent":"326.025343ms","remote":"127.0.0.1:53314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:29:40.030477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.413319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:29:40.030585Z","caller":"traceutil/trace.go:171","msg":"trace[1595825203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8346; }","duration":"327.608473ms","start":"2026-06-26T02:29:39.702943Z","end":"2026-06-26T02:29:40.030551Z","steps":["trace[1595825203] 'agreement among raft nodes before linearized reading' (duration: 327.322237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:29:40.030564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.560832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9jzbv\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-06-26T02:29:40.030647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:29:39.702918Z","time spent":"327.709225ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:29:40.030662Z","caller":"traceutil/trace.go:171","msg":"trace[243713349] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9jzbv; range_end:; response_count:1; response_revision:8346; }","duration":"228.714545ms","start":"2026-06-26T02:29:39.801922Z","end":"2026-06-26T02:29:40.030636Z","steps":["trace[243713349] 'agreement among raft nodes before linearized reading' (duration: 228.297438ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:29:40.040784Z","caller":"traceutil/trace.go:171","msg":"trace[114173471] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"186.872537ms","start":"2026-06-26T02:29:39.853884Z","end":"2026-06-26T02:29:40.040757Z","steps":["trace[114173471] 'process raft request' (duration: 186.5369ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:29:52.603722Z","caller":"traceutil/trace.go:171","msg":"trace[139198051] linearizableReadLoop","detail":"{readStateIndex:8712; appliedIndex:8711; }","duration":"189.711561ms","start":"2026-06-26T02:29:52.413987Z","end":"2026-06-26T02:29:52.603698Z","steps":["trace[139198051] 'read index received' (duration: 189.585259ms)","trace[139198051] 'applied index is now lower than readState.Index' (duration: 125.142µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:29:52.603804Z","caller":"traceutil/trace.go:171","msg":"trace[481232289] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"250.216235ms","start":"2026-06-26T02:29:52.353546Z","end":"2026-06-26T02:29:52.603763Z","steps":["trace[481232289] 'process raft request' (duration: 249.982561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:29:52.603983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.975345ms","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-26T02:29:52.604061Z","caller":"traceutil/trace.go:171","msg":"trace[48623048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8414; }","duration":"190.107569ms","start":"2026-06-26T02:29:52.413936Z","end":"2026-06-26T02:29:52.604043Z","steps":["trace[48623048] 'agreement among raft nodes before linearized reading' (duration: 189.865134ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:30:06.701105Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000225c.wal"} {"level":"info","ts":"2026-06-26T02:30:20.519676Z","caller":"traceutil/trace.go:171","msg":"trace[954095406] linearizableReadLoop","detail":"{readStateIndex:8921; appliedIndex:8920; }","duration":"203.878409ms","start":"2026-06-26T02:30:20.315767Z","end":"2026-06-26T02:30:20.519646Z","steps":["trace[954095406] 'read index received' (duration: 195.999549ms)","trace[954095406] 'applied index is now lower than readState.Index' (duration: 7.8781ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:30:20.519868Z","caller":"traceutil/trace.go:171","msg":"trace[206371953] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"283.10305ms","start":"2026-06-26T02:30:20.236755Z","end":"2026-06-26T02:30:20.519858Z","steps":["trace[206371953] 'process raft request' (duration: 275.055598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:30:20.520165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.384759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-26T02:30:20.520204Z","caller":"traceutil/trace.go:171","msg":"trace[1086372622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8616; }","duration":"204.476731ms","start":"2026-06-26T02:30:20.315714Z","end":"2026-06-26T02:30:20.520191Z","steps":["trace[1086372622] 'agreement among raft nodes before linearized reading' (duration: 204.341268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:30:20.520404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.196644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-26T02:30:20.520433Z","caller":"traceutil/trace.go:171","msg":"trace[257325117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8616; }","duration":"173.259355ms","start":"2026-06-26T02:30:20.347165Z","end":"2026-06-26T02:30:20.520424Z","steps":["trace[257325117] 'agreement among raft nodes before linearized reading' (duration: 173.169923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:30:20.520539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.763373ms","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-26T02:30:20.520591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.492853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9jzbv\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-26T02:30:20.520602Z","caller":"traceutil/trace.go:171","msg":"trace[634857352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8616; }","duration":"164.851485ms","start":"2026-06-26T02:30:20.355734Z","end":"2026-06-26T02:30:20.520586Z","steps":["trace[634857352] 'agreement among raft nodes before linearized reading' (duration: 164.644671ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:30:20.520622Z","caller":"traceutil/trace.go:171","msg":"trace[206302902] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9jzbv; range_end:; response_count:1; response_revision:8616; }","duration":"170.538683ms","start":"2026-06-26T02:30:20.350075Z","end":"2026-06-26T02:30:20.520613Z","steps":["trace[206302902] 'agreement among raft nodes before linearized reading' (duration: 170.427991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:30:20.520616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.57786ms","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-06-26T02:30:20.52067Z","caller":"traceutil/trace.go:171","msg":"trace[698644899] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8616; }","duration":"163.650242ms","start":"2026-06-26T02:30:20.357008Z","end":"2026-06-26T02:30:20.520658Z","steps":["trace[698644899] 'agreement among raft nodes before linearized reading' (duration: 163.472849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:30:24.441187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.210189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:30:24.441297Z","caller":"traceutil/trace.go:171","msg":"trace[1982463175] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:8637; }","duration":"102.353272ms","start":"2026-06-26T02:30:24.338906Z","end":"2026-06-26T02:30:24.44126Z","steps":["trace[1982463175] 'count revisions from in-memory index tree' (duration: 102.133558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:30:33.869811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.780519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:30:33.869898Z","caller":"traceutil/trace.go:171","msg":"trace[1234170893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8730; }","duration":"168.946372ms","start":"2026-06-26T02:30:33.700934Z","end":"2026-06-26T02:30:33.86988Z","steps":["trace[1234170893] 'range keys from in-memory index tree' (duration: 168.673377ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:30:33.877259Z","caller":"traceutil/trace.go:171","msg":"trace[310060877] transaction","detail":"{read_only:false; response_revision:8731; number_of_response:1; }","duration":"175.328576ms","start":"2026-06-26T02:30:33.701899Z","end":"2026-06-26T02:30:33.877228Z","steps":["trace[310060877] 'process raft request' (duration: 175.0882ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:30:34.221251Z","caller":"traceutil/trace.go:171","msg":"trace[1926250004] transaction","detail":"{read_only:false; response_revision:8732; number_of_response:1; }","duration":"113.78792ms","start":"2026-06-26T02:30:34.107414Z","end":"2026-06-26T02:30:34.221201Z","steps":["trace[1926250004] 'process raft request' (duration: 105.145766ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:31:50.651372Z","caller":"traceutil/trace.go:171","msg":"trace[74682375] transaction","detail":"{read_only:false; response_revision:9480; number_of_response:1; }","duration":"108.108751ms","start":"2026-06-26T02:31:50.543231Z","end":"2026-06-26T02:31:50.65134Z","steps":["trace[74682375] 'process raft request' (duration: 38.737378ms)","trace[74682375] 'compare' (duration: 69.245931ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:32:14.582987Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-26T02:32:14.58915Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-26T02:32:14.589262Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-26T02:34:32.827563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8179} {"level":"info","ts":"2026-06-26T02:34:32.890948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8179,"took":"60.758229ms","hash":1532747247,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":28307456,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-26T02:34:32.891031Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1532747247,"revision":8179,"compact-revision":6095} {"level":"info","ts":"2026-06-26T02:39:32.835101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10537} {"level":"info","ts":"2026-06-26T02:39:32.913728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10537,"took":"76.054627ms","hash":302481104,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":26152960,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-26T02:39:32.913818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":302481104,"revision":10537,"compact-revision":8179} {"level":"info","ts":"2026-06-26T02:44:33.006929Z","caller":"traceutil/trace.go:171","msg":"trace[1250753109] transaction","detail":"{read_only:false; response_revision:14703; number_of_response:1; }","duration":"169.835062ms","start":"2026-06-26T02:44:32.83705Z","end":"2026-06-26T02:44:33.006885Z","steps":["trace[1250753109] 'process raft request' (duration: 169.619878ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:44:33.027853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12728} {"level":"info","ts":"2026-06-26T02:44:33.112445Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12728,"took":"80.45892ms","hash":1706205850,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":27357184,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-26T02:44:33.11265Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1706205850,"revision":12728,"compact-revision":10537} {"level":"info","ts":"2026-06-26T02:44:41.907424Z","caller":"traceutil/trace.go:171","msg":"trace[2021953812] transaction","detail":"{read_only:false; response_revision:14878; number_of_response:1; }","duration":"111.148745ms","start":"2026-06-26T02:44:41.796244Z","end":"2026-06-26T02:44:41.907393Z","steps":["trace[2021953812] 'process raft request' (duration: 28.421212ms)","trace[2021953812] 'compare' (duration: 82.600391ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:46:12.457805Z","caller":"traceutil/trace.go:171","msg":"trace[17940606] transaction","detail":"{read_only:false; response_revision:15918; number_of_response:1; }","duration":"132.98478ms","start":"2026-06-26T02:46:12.324794Z","end":"2026-06-26T02:46:12.457779Z","steps":["trace[17940606] 'process raft request' (duration: 132.778846ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:49:33.034465Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14703} {"level":"info","ts":"2026-06-26T02:49:33.113765Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14703,"took":"76.327021ms","hash":3554863160,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":33857536,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-26T02:49:33.113822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3554863160,"revision":14703,"compact-revision":12728} {"level":"info","ts":"2026-06-26T02:52:02.273661Z","caller":"traceutil/trace.go:171","msg":"trace[1061864334] transaction","detail":"{read_only:false; response_revision:18464; number_of_response:1; }","duration":"132.305316ms","start":"2026-06-26T02:52:02.141277Z","end":"2026-06-26T02:52:02.273583Z","steps":["trace[1061864334] 'process raft request' (duration: 132.026311ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:52:04.194862Z","caller":"traceutil/trace.go:171","msg":"trace[1363681733] transaction","detail":"{read_only:false; response_revision:18480; number_of_response:1; }","duration":"138.380702ms","start":"2026-06-26T02:52:04.056452Z","end":"2026-06-26T02:52:04.194833Z","steps":["trace[1363681733] 'process raft request' (duration: 138.188549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:52:04.513105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.546321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-26T02:52:04.513211Z","caller":"traceutil/trace.go:171","msg":"trace[659152541] transaction","detail":"{read_only:false; response_revision:18481; number_of_response:1; }","duration":"231.610006ms","start":"2026-06-26T02:52:04.281586Z","end":"2026-06-26T02:52:04.513196Z","steps":["trace[659152541] 'process raft request' (duration: 57.746278ms)","trace[659152541] 'compare' (duration: 173.166744ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:54:27.007403Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-26T02:54:27.01287Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-26T02:54:27.012965Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-26T02:54:33.042573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17478} {"level":"info","ts":"2026-06-26T02:54:33.149662Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17478,"took":"102.278785ms","hash":147654428,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":30281728,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-26T02:54:33.149741Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":147654428,"revision":17478,"compact-revision":14703} {"level":"info","ts":"2026-06-26T02:59:33.051724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19367} {"level":"info","ts":"2026-06-26T02:59:33.144473Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19367,"took":"89.036154ms","hash":1238056035,"current-db-size-bytes":58814464,"current-db-size":"59 MB","current-db-size-in-use-bytes":24244224,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-26T02:59:33.144523Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1238056035,"revision":19367,"compact-revision":17478}