{"level":"warn","ts":"2026-03-20T10:14:31.571169Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T10:14:31.571287Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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://162.253.55.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-03-20T10:14:31.571376Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T10:14:31.571392Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-03-20T10:14:31.571412Z","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-03-20T10:14:31.572124Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-03-20T10:14:31.572208Z","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://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-03-20T10:14:31.576163Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.714501ms"} {"level":"info","ts":"2026-03-20T10:14:31.58286Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-03-20T10:14:31.583075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T10:14:31.583108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-03-20T10:14:31.583127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T10:14:31.583175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-03-20T10:14:31.583263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-03-20T10:14:31.587847Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T10:14:31.589244Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T10:14:31.590472Z","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-03-20T10:14:31.59247Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T10:14:31.594194Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T10:14:31.594427Z","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-03-20T10:14:31.594618Z","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-03-20T10:14:31.594638Z","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-03-20T10:14:31.595584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-03-20T10:14:31.595751Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-03-20T10:14:31.596995Z","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-03-20T10:14:31.597178Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-03-20T10:14:31.59727Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-03-20T10:14:31.597319Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T10:14:31.597397Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T10:14:32.584453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T10:14:32.584516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T10:14:32.584563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-03-20T10:14:32.584584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-03-20T10:14:32.584596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-03-20T10:14:32.584612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-03-20T10:14:32.584631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-03-20T10:14:32.585875Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:14:32.586548Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T10:14:32.586567Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T10:14:32.586628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T10:14:32.586853Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T10:14:32.586929Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T10:14:32.58718Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:14:32.587376Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:14:32.587443Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:14:32.590478Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"info","ts":"2026-03-20T10:14:32.590735Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T10:14:48.338783Z","caller":"traceutil/trace.go:171","msg":"trace[2256230] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"170.425325ms","start":"2026-03-20T10:14:48.168336Z","end":"2026-03-20T10:14:48.338761Z","steps":["trace[2256230] 'process raft request' (duration: 170.277652ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:15:08.281267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.469103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:15:08.281388Z","caller":"traceutil/trace.go:171","msg":"trace[1301315924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"215.646716ms","start":"2026-03-20T10:15:08.065723Z","end":"2026-03-20T10:15:08.281369Z","steps":["trace[1301315924] 'range keys from in-memory index tree' (duration: 215.386561ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:08.551633Z","caller":"traceutil/trace.go:171","msg":"trace[1538536763] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"249.904236ms","start":"2026-03-20T10:15:08.301668Z","end":"2026-03-20T10:15:08.551573Z","steps":["trace[1538536763] 'process raft request' (duration: 249.633941ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:56.143832Z","caller":"traceutil/trace.go:171","msg":"trace[2002023106] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"102.417223ms","start":"2026-03-20T10:15:56.041385Z","end":"2026-03-20T10:15:56.143802Z","steps":["trace[2002023106] 'process raft request' (duration: 102.163048ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:16:17.94786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.006509ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:16:17.947998Z","caller":"traceutil/trace.go:171","msg":"trace[1005587501] linearizableReadLoop","detail":"{readStateIndex:1597; appliedIndex:1596; }","duration":"258.275103ms","start":"2026-03-20T10:16:17.689706Z","end":"2026-03-20T10:16:17.947981Z","steps":["trace[1005587501] 'read index received' (duration: 33.67µs)","trace[1005587501] 'applied index is now lower than readState.Index' (duration: 258.240163ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:16:17.948055Z","caller":"traceutil/trace.go:171","msg":"trace[2095256774] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"271.311568ms","start":"2026-03-20T10:16:17.676692Z","end":"2026-03-20T10:16:17.948003Z","steps":["trace[2095256774] 'process raft request' (duration: 12.374862ms)","trace[2095256774] 'compare' (duration: 257.886087ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:16:17.948346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.601401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-20T10:16:17.94842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.479182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-03-20T10:16:17.948464Z","caller":"traceutil/trace.go:171","msg":"trace[1733897179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1536; }","duration":"258.770744ms","start":"2026-03-20T10:16:17.689665Z","end":"2026-03-20T10:16:17.948436Z","steps":["trace[1733897179] 'agreement among raft nodes before linearized reading' (duration: 258.413536ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:16:17.948499Z","caller":"traceutil/trace.go:171","msg":"trace[1629469304] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1536; }","duration":"122.576253ms","start":"2026-03-20T10:16:17.825888Z","end":"2026-03-20T10:16:17.948465Z","steps":["trace[1629469304] 'agreement among raft nodes before linearized reading' (duration: 122.362688ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:16:18.087168Z","caller":"traceutil/trace.go:171","msg":"trace[1788310518] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"132.832365ms","start":"2026-03-20T10:16:17.95431Z","end":"2026-03-20T10:16:18.087143Z","steps":["trace[1788310518] 'process raft request' (duration: 132.729683ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:16:18.087201Z","caller":"traceutil/trace.go:171","msg":"trace[470910583] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"133.277054ms","start":"2026-03-20T10:16:17.953878Z","end":"2026-03-20T10:16:18.087155Z","steps":["trace[470910583] 'process raft request' (duration: 116.21922ms)","trace[470910583] 'compare' (duration: 16.8145ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:16:18.087322Z","caller":"traceutil/trace.go:171","msg":"trace[125397152] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"131.449477ms","start":"2026-03-20T10:16:17.955847Z","end":"2026-03-20T10:16:18.087296Z","steps":["trace[125397152] 'process raft request' (duration: 131.240773ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:17:02.592485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.13323ms","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-03-20T10:17:02.5926Z","caller":"traceutil/trace.go:171","msg":"trace[894819600] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1814; }","duration":"107.311783ms","start":"2026-03-20T10:17:02.485268Z","end":"2026-03-20T10:17:02.59258Z","steps":["trace[894819600] 'range keys from in-memory index tree' (duration: 106.859224ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:17:08.363602Z","caller":"traceutil/trace.go:171","msg":"trace[1165156673] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"110.844264ms","start":"2026-03-20T10:17:08.252689Z","end":"2026-03-20T10:17:08.363533Z","steps":["trace[1165156673] 'process raft request' (duration: 110.472617ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:18:30.824748Z","caller":"traceutil/trace.go:171","msg":"trace[1502111330] transaction","detail":"{read_only:false; response_revision:2438; number_of_response:1; }","duration":"109.799715ms","start":"2026-03-20T10:18:30.714917Z","end":"2026-03-20T10:18:30.824716Z","steps":["trace[1502111330] 'process raft request' (duration: 109.590391ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:18:30.999265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.131227ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-03-20T10:22:25.959363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.260005ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:22:25.959511Z","caller":"traceutil/trace.go:171","msg":"trace[1633141465] linearizableReadLoop","detail":"{readStateIndex:4661; appliedIndex:4660; }","duration":"256.098602ms","start":"2026-03-20T10:22:25.70339Z","end":"2026-03-20T10:22:25.959489Z","steps":["trace[1633141465] 'read index received' (duration: 95.548491ms)","trace[1633141465] 'applied index is now lower than readState.Index' (duration: 160.548411ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:22:25.959628Z","caller":"traceutil/trace.go:171","msg":"trace[1943473423] transaction","detail":"{read_only:false; response_revision:4482; number_of_response:1; }","duration":"283.938113ms","start":"2026-03-20T10:22:25.67563Z","end":"2026-03-20T10:22:25.959568Z","steps":["trace[1943473423] 'process raft request' (duration: 123.382363ms)","trace[1943473423] 'compare' (duration: 160.05285ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:22:25.960369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.955797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-20T10:22:25.960513Z","caller":"traceutil/trace.go:171","msg":"trace[77878214] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:4482; }","duration":"257.151761ms","start":"2026-03-20T10:22:25.703335Z","end":"2026-03-20T10:22:25.960487Z","steps":["trace[77878214] 'agreement among raft nodes before linearized reading' (duration: 256.238314ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:36.719603Z","caller":"traceutil/trace.go:171","msg":"trace[584176811] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4888; }","duration":"106.086309ms","start":"2026-03-20T10:22:36.613485Z","end":"2026-03-20T10:22:36.719571Z","steps":["trace[584176811] 'read index received' (duration: 44.973853ms)","trace[584176811] 'applied index is now lower than readState.Index' (duration: 61.110896ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:22:36.719775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.265172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:22:36.71982Z","caller":"traceutil/trace.go:171","msg":"trace[2039157555] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:4703; }","duration":"106.374225ms","start":"2026-03-20T10:22:36.613434Z","end":"2026-03-20T10:22:36.719808Z","steps":["trace[2039157555] 'agreement among raft nodes before linearized reading' (duration: 106.261683ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:36.719772Z","caller":"traceutil/trace.go:171","msg":"trace[1100879222] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"148.078616ms","start":"2026-03-20T10:22:36.571632Z","end":"2026-03-20T10:22:36.71971Z","steps":["trace[1100879222] 'process raft request' (duration: 86.840187ms)","trace[1100879222] 'compare' (duration: 60.957674ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:22:45.453916Z","caller":"traceutil/trace.go:171","msg":"trace[1097114550] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"234.616827ms","start":"2026-03-20T10:22:45.219259Z","end":"2026-03-20T10:22:45.453876Z","steps":["trace[1097114550] 'read index received' (duration: 180.881517ms)","trace[1097114550] 'applied index is now lower than readState.Index' (duration: 53.733ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:22:45.454317Z","caller":"traceutil/trace.go:171","msg":"trace[969139102] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"240.966256ms","start":"2026-03-20T10:22:45.213261Z","end":"2026-03-20T10:22:45.454227Z","steps":["trace[969139102] 'process raft request' (duration: 187.001543ms)","trace[969139102] 'compare' (duration: 53.374152ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:22:45.455015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.721977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-03-20T10:22:45.45513Z","caller":"traceutil/trace.go:171","msg":"trace[279197676] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:4872; }","duration":"235.897761ms","start":"2026-03-20T10:22:45.219201Z","end":"2026-03-20T10:22:45.455099Z","steps":["trace[279197676] 'agreement among raft nodes before linearized reading' (duration: 234.900802ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:45.643496Z","caller":"traceutil/trace.go:171","msg":"trace[205157104] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"117.215241ms","start":"2026-03-20T10:22:45.526239Z","end":"2026-03-20T10:22:45.643455Z","steps":["trace[205157104] 'process raft request' (duration: 57.968128ms)","trace[205157104] 'compare' (duration: 59.004168ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:22:45.655842Z","caller":"traceutil/trace.go:171","msg":"trace[1658998525] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"127.81262ms","start":"2026-03-20T10:22:45.527996Z","end":"2026-03-20T10:22:45.655809Z","steps":["trace[1658998525] 'process raft request' (duration: 127.555235ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:45.656197Z","caller":"traceutil/trace.go:171","msg":"trace[1904333196] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"127.873521ms","start":"2026-03-20T10:22:45.528252Z","end":"2026-03-20T10:22:45.656126Z","steps":["trace[1904333196] 'process raft request' (duration: 127.469604ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:45.656478Z","caller":"traceutil/trace.go:171","msg":"trace[1042335177] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"128.150787ms","start":"2026-03-20T10:22:45.5283Z","end":"2026-03-20T10:22:45.65645Z","steps":["trace[1042335177] 'process raft request' (duration: 127.724449ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:45.656522Z","caller":"traceutil/trace.go:171","msg":"trace[517949390] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"128.013405ms","start":"2026-03-20T10:22:45.528478Z","end":"2026-03-20T10:22:45.656491Z","steps":["trace[517949390] 'process raft request' (duration: 127.960024ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:45.656553Z","caller":"traceutil/trace.go:171","msg":"trace[1598333490] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"128.095316ms","start":"2026-03-20T10:22:45.528435Z","end":"2026-03-20T10:22:45.656531Z","steps":["trace[1598333490] 'process raft request' (duration: 127.758889ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:24:32.613863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2742} {"level":"info","ts":"2026-03-20T10:24:32.677118Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2742,"took":"60.948499ms","hash":109416606,"current-db-size-bytes":41807872,"current-db-size":"42 MB","current-db-size-in-use-bytes":31465472,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-20T10:24:32.67721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":109416606,"revision":2742,"compact-revision":-1} {"level":"info","ts":"2026-03-20T10:28:26.505933Z","caller":"traceutil/trace.go:171","msg":"trace[555708954] transaction","detail":"{read_only:false; response_revision:7224; number_of_response:1; }","duration":"185.392662ms","start":"2026-03-20T10:28:26.320507Z","end":"2026-03-20T10:28:26.5059Z","steps":["trace[555708954] 'process raft request' (duration: 156.468ms)","trace[555708954] 'compare' (duration: 28.708619ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:28:55.3314Z","caller":"traceutil/trace.go:171","msg":"trace[626069189] transaction","detail":"{read_only:false; response_revision:7541; number_of_response:1; }","duration":"139.801827ms","start":"2026-03-20T10:28:55.191561Z","end":"2026-03-20T10:28:55.331362Z","steps":["trace[626069189] 'process raft request' (duration: 139.606093ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:29:07.134816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.123687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:29:07.134947Z","caller":"traceutil/trace.go:171","msg":"trace[964949825] linearizableReadLoop","detail":"{readStateIndex:7880; appliedIndex:7879; }","duration":"182.156882ms","start":"2026-03-20T10:29:06.952771Z","end":"2026-03-20T10:29:07.134928Z","steps":["trace[964949825] 'read index received' (duration: 104.362µs)","trace[964949825] 'applied index is now lower than readState.Index' (duration: 182.05099ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:29:07.135117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.360045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ddcwl\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:29:07.135151Z","caller":"traceutil/trace.go:171","msg":"trace[1446658997] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ddcwl; range_end:; response_count:1; response_revision:7597; }","duration":"182.453968ms","start":"2026-03-20T10:29:06.952687Z","end":"2026-03-20T10:29:07.135141Z","steps":["trace[1446658997] 'agreement among raft nodes before linearized reading' (duration: 182.293165ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:07.135483Z","caller":"traceutil/trace.go:171","msg":"trace[1770177808] transaction","detail":"{read_only:false; response_revision:7597; number_of_response:1; }","duration":"311.759418ms","start":"2026-03-20T10:29:06.823694Z","end":"2026-03-20T10:29:07.135454Z","steps":["trace[1770177808] 'process raft request' (duration: 42.896126ms)","trace[1770177808] 'compare' (duration: 267.838742ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:29:07.135829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:29:06.823635Z","time spent":"312.003282ms","remote":"127.0.0.1:39374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:29:32.620166Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5748} {"level":"info","ts":"2026-03-20T10:29:32.710494Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5748,"took":"87.670573ms","hash":4182790529,"current-db-size-bytes":43913216,"current-db-size":"44 MB","current-db-size-in-use-bytes":23830528,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-20T10:29:32.710554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4182790529,"revision":5748,"compact-revision":2742} {"level":"warn","ts":"2026-03-20T10:29:49.143653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.696463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-20T10:29:49.143789Z","caller":"traceutil/trace.go:171","msg":"trace[236656465] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7894; }","duration":"139.465354ms","start":"2026-03-20T10:29:49.004302Z","end":"2026-03-20T10:29:49.143767Z","steps":["trace[236656465] 'process raft request' (duration: 35.498945ms)","trace[236656465] 'compare' (duration: 103.53797ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:29:49.173167Z","caller":"traceutil/trace.go:171","msg":"trace[617269914] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7896; }","duration":"162.076457ms","start":"2026-03-20T10:29:49.011055Z","end":"2026-03-20T10:29:49.173132Z","steps":["trace[617269914] 'process raft request' (duration: 162.030136ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:49.173303Z","caller":"traceutil/trace.go:171","msg":"trace[1324029957] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7896; }","duration":"167.936127ms","start":"2026-03-20T10:29:49.005337Z","end":"2026-03-20T10:29:49.173273Z","steps":["trace[1324029957] 'process raft request' (duration: 167.680672ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:49.173298Z","caller":"traceutil/trace.go:171","msg":"trace[751759554] transaction","detail":"{read_only:false; response_revision:7895; number_of_response:1; }","duration":"168.664351ms","start":"2026-03-20T10:29:49.004573Z","end":"2026-03-20T10:29:49.173238Z","steps":["trace[751759554] 'process raft request' (duration: 168.162691ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:49.201241Z","caller":"traceutil/trace.go:171","msg":"trace[1747481235] transaction","detail":"{read_only:false; response_revision:7897; number_of_response:1; }","duration":"146.578637ms","start":"2026-03-20T10:29:49.054614Z","end":"2026-03-20T10:29:49.201193Z","steps":["trace[1747481235] 'process raft request' (duration: 146.356523ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:50.020621Z","caller":"traceutil/trace.go:171","msg":"trace[805370469] transaction","detail":"{read_only:false; response_revision:7903; number_of_response:1; }","duration":"115.181439ms","start":"2026-03-20T10:29:49.90541Z","end":"2026-03-20T10:29:50.020591Z","steps":["trace[805370469] 'process raft request' (duration: 114.958795ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:51.011435Z","caller":"traceutil/trace.go:171","msg":"trace[1475141014] transaction","detail":"{read_only:false; response_revision:7908; number_of_response:1; }","duration":"157.029733ms","start":"2026-03-20T10:29:50.854372Z","end":"2026-03-20T10:29:51.011401Z","steps":["trace[1475141014] 'process raft request' (duration: 156.870979ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:51.023017Z","caller":"traceutil/trace.go:171","msg":"trace[723941771] linearizableReadLoop","detail":"{readStateIndex:8209; appliedIndex:8207; }","duration":"111.994518ms","start":"2026-03-20T10:29:50.910993Z","end":"2026-03-20T10:29:51.022988Z","steps":["trace[723941771] 'read index received' (duration: 100.376431ms)","trace[723941771] 'applied index is now lower than readState.Index' (duration: 11.616647ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:29:51.023038Z","caller":"traceutil/trace.go:171","msg":"trace[688526195] transaction","detail":"{read_only:false; response_revision:7909; number_of_response:1; }","duration":"167.978158ms","start":"2026-03-20T10:29:50.85503Z","end":"2026-03-20T10:29:51.023008Z","steps":["trace[688526195] 'process raft request' (duration: 167.728473ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:51.023245Z","caller":"traceutil/trace.go:171","msg":"trace[1836501762] transaction","detail":"{read_only:false; response_revision:7910; number_of_response:1; }","duration":"110.808237ms","start":"2026-03-20T10:29:50.912415Z","end":"2026-03-20T10:29:51.023223Z","steps":["trace[1836501762] 'process raft request' (duration: 110.509061ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:29:51.023416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.397956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-hsz2g\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-03-20T10:29:51.023497Z","caller":"traceutil/trace.go:171","msg":"trace[2123527598] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-hsz2g; range_end:; response_count:1; response_revision:7910; }","duration":"112.536568ms","start":"2026-03-20T10:29:50.910939Z","end":"2026-03-20T10:29:51.023476Z","steps":["trace[2123527598] 'agreement among raft nodes before linearized reading' (duration: 112.289394ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:31:06.061833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:31:05.738413Z","time spent":"323.4113ms","remote":"127.0.0.1:39126","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-03-20T10:31:06.061837Z","caller":"traceutil/trace.go:171","msg":"trace[1014680456] linearizableReadLoop","detail":"{readStateIndex:8932; appliedIndex:8931; }","duration":"193.825053ms","start":"2026-03-20T10:31:05.867965Z","end":"2026-03-20T10:31:06.06179Z","steps":["trace[1014680456] 'read index received' (duration: 193.616999ms)","trace[1014680456] 'applied index is now lower than readState.Index' (duration: 206.194µs)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:31:06.06206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.082787ms","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-03-20T10:31:06.062371Z","caller":"traceutil/trace.go:171","msg":"trace[2023847801] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8611; }","duration":"194.450124ms","start":"2026-03-20T10:31:05.867897Z","end":"2026-03-20T10:31:06.062347Z","steps":["trace[2023847801] 'agreement among raft nodes before linearized reading' (duration: 193.947685ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:33:28.507299Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a11c20306510c1f7","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-20T10:33:28.513069Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-20T10:33:28.513197Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-20T10:34:32.62719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7769} {"level":"info","ts":"2026-03-20T10:34:32.711423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7769,"took":"81.723794ms","hash":254352017,"current-db-size-bytes":43913216,"current-db-size":"44 MB","current-db-size-in-use-bytes":25792512,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-20T10:34:32.711519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":254352017,"revision":7769,"compact-revision":5748} {"level":"info","ts":"2026-03-20T10:39:32.635086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9974} {"level":"info","ts":"2026-03-20T10:39:32.723878Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9974,"took":"86.649244ms","hash":2356819690,"current-db-size-bytes":43913216,"current-db-size":"44 MB","current-db-size-in-use-bytes":17321984,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-03-20T10:39:32.723978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2356819690,"revision":9974,"compact-revision":7769}