{"level":"warn","ts":"2026-04-08T01:18:22.824697Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T01:18:22.824806Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-08T01:18:22.824878Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T01:18:22.824891Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-08T01:18:22.824911Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T01:18:22.825539Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-04-08T01:18:22.825616Z","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.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-08T01:18:22.830278Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.350878ms"} {"level":"info","ts":"2026-04-08T01:18:22.838628Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-04-08T01:18:22.838742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T01:18:22.838776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-04-08T01:18:22.838806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T01:18:22.838819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-04-08T01:18:22.83888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-04-08T01:18:22.844704Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T01:18:22.846108Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T01:18:22.847304Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-08T01:18:22.849494Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T01:18:22.850176Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T01:18:22.85027Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T01:18:22.850282Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T01:18:22.850358Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T01:18:22.852439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-04-08T01:18:22.853068Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-08T01:18:22.85435Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T01:18:22.854567Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-08T01:18:22.854626Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T01:18:22.854658Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T01:18:22.854659Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-08T01:18:23.740036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T01:18:23.7401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T01:18:23.740122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-04-08T01:18:23.740142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-04-08T01:18:23.740154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-08T01:18:23.740179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-04-08T01:18:23.740198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-08T01:18:23.741099Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:18:23.741117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T01:18:23.74115Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:18:23.741197Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:23.741415Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T01:18:23.741471Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T01:18:23.742131Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:23.742222Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:23.742241Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:23.744593Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T01:18:23.744679Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"info","ts":"2026-04-08T01:18:39.380707Z","caller":"traceutil/trace.go:171","msg":"trace[471836406] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"145.083139ms","start":"2026-04-08T01:18:39.235598Z","end":"2026-04-08T01:18:39.380681Z","steps":["trace[471836406] 'process raft request' (duration: 144.929816ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:18:39.907492Z","caller":"traceutil/trace.go:171","msg":"trace[1157363767] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"132.571754ms","start":"2026-04-08T01:18:39.774879Z","end":"2026-04-08T01:18:39.907451Z","steps":["trace[1157363767] 'process raft request' (duration: 131.695897ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:19:00.240389Z","caller":"traceutil/trace.go:171","msg":"trace[1860731620] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"355.2148ms","start":"2026-04-08T01:18:59.885133Z","end":"2026-04-08T01:19:00.240348Z","steps":["trace[1860731620] 'read index received' (duration: 354.914234ms)","trace[1860731620] 'applied index is now lower than readState.Index' (duration: 299.046µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:19:00.24053Z","caller":"traceutil/trace.go:171","msg":"trace[1713494111] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"396.349396ms","start":"2026-04-08T01:18:59.844137Z","end":"2026-04-08T01:19:00.240486Z","steps":["trace[1713494111] 'process raft request' (duration: 396.01952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:19:00.240724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.563797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T01:19:00.240862Z","caller":"traceutil/trace.go:171","msg":"trace[1383491843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"355.776301ms","start":"2026-04-08T01:18:59.885065Z","end":"2026-04-08T01:19:00.240841Z","steps":["trace[1383491843] 'agreement among raft nodes before linearized reading' (duration: 355.509326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:19:00.240869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.785203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-25xqd\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-08T01:19:00.241164Z","caller":"traceutil/trace.go:171","msg":"trace[106154210] range","detail":"{range_begin:/registry/pods/kube-system/cilium-25xqd; range_end:; response_count:1; response_revision:578; }","duration":"331.137652ms","start":"2026-04-08T01:18:59.909985Z","end":"2026-04-08T01:19:00.241122Z","steps":["trace[106154210] 'agreement among raft nodes before linearized reading' (duration: 330.675062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:19:00.241173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:18:59.844097Z","time spent":"396.51509ms","remote":"127.0.0.1:54896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:19:00.240838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.078574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-08T01:19:00.241239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:18:59.909974Z","time spent":"331.248264ms","remote":"127.0.0.1:54552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-25xqd\" "} {"level":"info","ts":"2026-04-08T01:19:00.241297Z","caller":"traceutil/trace.go:171","msg":"trace[231953455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"224.614986ms","start":"2026-04-08T01:19:00.016661Z","end":"2026-04-08T01:19:00.241276Z","steps":["trace[231953455] 'agreement among raft nodes before linearized reading' (duration: 224.020523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:19:00.24091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:18:59.885031Z","time spent":"355.866853ms","remote":"127.0.0.1:54630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T01:19:15.780466Z","caller":"traceutil/trace.go:171","msg":"trace[163647825] linearizableReadLoop","detail":"{readStateIndex:761; appliedIndex:760; }","duration":"116.717622ms","start":"2026-04-08T01:19:15.663719Z","end":"2026-04-08T01:19:15.780437Z","steps":["trace[163647825] 'read index received' (duration: 116.481038ms)","trace[163647825] 'applied index is now lower than readState.Index' (duration: 235.244µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:19:15.780505Z","caller":"traceutil/trace.go:171","msg":"trace[1112211375] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"157.90034ms","start":"2026-04-08T01:19:15.622583Z","end":"2026-04-08T01:19:15.780483Z","steps":["trace[1112211375] 'process raft request' (duration: 157.685166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:19:15.780668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.940047ms","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-04-08T01:19:15.780714Z","caller":"traceutil/trace.go:171","msg":"trace[1378072023] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:736; }","duration":"117.026928ms","start":"2026-04-08T01:19:15.663676Z","end":"2026-04-08T01:19:15.780703Z","steps":["trace[1378072023] 'agreement among raft nodes before linearized reading' (duration: 116.880486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:27.155713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.848788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T01:20:27.155755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.961381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-08T01:20:27.155811Z","caller":"traceutil/trace.go:171","msg":"trace[325407189] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1801; }","duration":"108.008451ms","start":"2026-04-08T01:20:27.047784Z","end":"2026-04-08T01:20:27.155792Z","steps":["trace[325407189] 'count revisions from in-memory index tree' (duration: 107.761626ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:27.155833Z","caller":"traceutil/trace.go:171","msg":"trace[1001575542] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:1801; }","duration":"158.082374ms","start":"2026-04-08T01:20:26.997732Z","end":"2026-04-08T01:20:27.155815Z","steps":["trace[1001575542] 'range keys from in-memory index tree' (duration: 157.762867ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:27.810075Z","caller":"traceutil/trace.go:171","msg":"trace[1128209898] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"430.12735ms","start":"2026-04-08T01:20:27.379921Z","end":"2026-04-08T01:20:27.810049Z","steps":["trace[1128209898] 'process raft request' (duration: 429.940546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:27.810515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:20:27.379901Z","time spent":"430.263872ms","remote":"127.0.0.1:54552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:20:27.829536Z","caller":"traceutil/trace.go:171","msg":"trace[335237376] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"327.70138ms","start":"2026-04-08T01:20:27.501806Z","end":"2026-04-08T01:20:27.829507Z","steps":["trace[335237376] 'process raft request' (duration: 327.541677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:27.829873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:20:27.501779Z","time spent":"327.851592ms","remote":"127.0.0.1:54630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:20:40.385014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.97002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T01:20:40.385107Z","caller":"traceutil/trace.go:171","msg":"trace[593806410] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1911; }","duration":"107.107493ms","start":"2026-04-08T01:20:40.27798Z","end":"2026-04-08T01:20:40.385087Z","steps":["trace[593806410] 'range keys from in-memory index tree' (duration: 106.781347ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:44.051417Z","caller":"traceutil/trace.go:171","msg":"trace[404019361] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"161.039934ms","start":"2026-04-08T01:20:43.890349Z","end":"2026-04-08T01:20:44.051389Z","steps":["trace[404019361] 'process raft request' (duration: 160.86639ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:44.056534Z","caller":"traceutil/trace.go:171","msg":"trace[299356963] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"156.673824ms","start":"2026-04-08T01:20:43.899844Z","end":"2026-04-08T01:20:44.056518Z","steps":["trace[299356963] 'process raft request' (duration: 156.573252ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:21:23.176309Z","caller":"traceutil/trace.go:171","msg":"trace[167276644] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2233; }","duration":"164.361415ms","start":"2026-04-08T01:21:23.011923Z","end":"2026-04-08T01:21:23.176285Z","steps":["trace[167276644] 'read index received' (duration: 164.10966ms)","trace[167276644] 'applied index is now lower than readState.Index' (duration: 250.665µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:21:23.176474Z","caller":"traceutil/trace.go:171","msg":"trace[77786804] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"164.693761ms","start":"2026-04-08T01:21:23.011741Z","end":"2026-04-08T01:21:23.176434Z","steps":["trace[77786804] 'process raft request' (duration: 164.387125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:21:23.176597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.65145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-08T01:21:23.176642Z","caller":"traceutil/trace.go:171","msg":"trace[1654299877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2155; }","duration":"164.733832ms","start":"2026-04-08T01:21:23.011898Z","end":"2026-04-08T01:21:23.176632Z","steps":["trace[1654299877] 'agreement among raft nodes before linearized reading' (duration: 164.508537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:21:23.526265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.445244ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:21:23.526438Z","caller":"traceutil/trace.go:171","msg":"trace[1709064539] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"345.725745ms","start":"2026-04-08T01:21:23.180689Z","end":"2026-04-08T01:21:23.526415Z","steps":["trace[1709064539] 'process raft request' (duration: 127.830263ms)","trace[1709064539] 'compare' (duration: 217.301571ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:21:23.526503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:21:23.180672Z","time spent":"345.800496ms","remote":"127.0.0.1:54630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:21:23.52654Z","caller":"traceutil/trace.go:171","msg":"trace[213779124] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"344.596074ms","start":"2026-04-08T01:21:23.181913Z","end":"2026-04-08T01:21:23.526509Z","steps":["trace[213779124] 'process raft request' (duration: 344.447721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:21:23.526886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:21:23.181888Z","time spent":"344.917389ms","remote":"127.0.0.1:54630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:22:06.597295Z","caller":"traceutil/trace.go:171","msg":"trace[1701137610] transaction","detail":"{read_only:false; response_revision:2563; number_of_response:1; }","duration":"105.582907ms","start":"2026-04-08T01:22:06.491681Z","end":"2026-04-08T01:22:06.597264Z","steps":["trace[1701137610] 'process raft request' (duration: 105.464465ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:34.952879Z","caller":"traceutil/trace.go:171","msg":"trace[742135915] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"184.134421ms","start":"2026-04-08T01:22:34.768715Z","end":"2026-04-08T01:22:34.952849Z","steps":["trace[742135915] 'process raft request' (duration: 145.530889ms)","trace[742135915] 'compare' (duration: 38.48479ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:35.119358Z","caller":"traceutil/trace.go:171","msg":"trace[1362029885] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"107.579889ms","start":"2026-04-08T01:22:35.011748Z","end":"2026-04-08T01:22:35.119328Z","steps":["trace[1362029885] 'process raft request' (duration: 99.829433ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:40.852322Z","caller":"traceutil/trace.go:171","msg":"trace[1595562014] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"155.167084ms","start":"2026-04-08T01:22:40.697124Z","end":"2026-04-08T01:22:40.852292Z","steps":["trace[1595562014] 'process raft request' (duration: 154.98178ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:41.03209Z","caller":"traceutil/trace.go:171","msg":"trace[1127167345] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"278.635006ms","start":"2026-04-08T01:22:40.753423Z","end":"2026-04-08T01:22:41.032058Z","steps":["trace[1127167345] 'process raft request' (duration: 205.713028ms)","trace[1127167345] 'compare' (duration: 72.721784ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:26:27.5054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.895559ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:26:27.505698Z","caller":"traceutil/trace.go:171","msg":"trace[675620405] linearizableReadLoop","detail":"{readStateIndex:4946; appliedIndex:4944; }","duration":"150.461551ms","start":"2026-04-08T01:26:27.355217Z","end":"2026-04-08T01:26:27.505678Z","steps":["trace[675620405] 'read index received' (duration: 10.322327ms)","trace[675620405] 'applied index is now lower than readState.Index' (duration: 140.137674ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:26:27.505733Z","caller":"traceutil/trace.go:171","msg":"trace[562178430] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"153.835638ms","start":"2026-04-08T01:26:27.351872Z","end":"2026-04-08T01:26:27.505708Z","steps":["trace[562178430] 'process raft request' (duration: 153.679695ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:27.505775Z","caller":"traceutil/trace.go:171","msg":"trace[883291615] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"156.808208ms","start":"2026-04-08T01:26:27.348927Z","end":"2026-04-08T01:26:27.505735Z","steps":["trace[883291615] 'process raft request' (duration: 16.448629ms)","trace[883291615] 'compare' (duration: 139.722466ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:26:27.505956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.738227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4848"} {"level":"info","ts":"2026-04-08T01:26:27.506295Z","caller":"traceutil/trace.go:171","msg":"trace[3167500] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4765; }","duration":"150.820439ms","start":"2026-04-08T01:26:27.355173Z","end":"2026-04-08T01:26:27.505993Z","steps":["trace[3167500] 'agreement among raft nodes before linearized reading' (duration: 150.613055ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:27.51413Z","caller":"traceutil/trace.go:171","msg":"trace[1979540636] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"127.122614ms","start":"2026-04-08T01:26:27.38697Z","end":"2026-04-08T01:26:27.514092Z","steps":["trace[1979540636] 'process raft request' (duration: 126.992101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:26:27.532291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.146785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kxssq\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-04-08T01:26:27.53239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.349499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-08T01:26:27.532443Z","caller":"traceutil/trace.go:171","msg":"trace[1483774030] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kxssq; range_end:; response_count:1; response_revision:4767; }","duration":"110.344859ms","start":"2026-04-08T01:26:27.422075Z","end":"2026-04-08T01:26:27.53242Z","steps":["trace[1483774030] 'agreement among raft nodes before linearized reading' (duration: 110.091484ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:27.532496Z","caller":"traceutil/trace.go:171","msg":"trace[939842415] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4767; }","duration":"175.473482ms","start":"2026-04-08T01:26:27.356996Z","end":"2026-04-08T01:26:27.53247Z","steps":["trace[939842415] 'agreement among raft nodes before linearized reading' (duration: 175.204117ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:27.649675Z","caller":"traceutil/trace.go:171","msg":"trace[1076050544] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"101.267517ms","start":"2026-04-08T01:26:27.548346Z","end":"2026-04-08T01:26:27.649613Z","steps":["trace[1076050544] 'process raft request' (duration: 58.317417ms)","trace[1076050544] 'compare' (duration: 42.728925ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:26:27.652612Z","caller":"traceutil/trace.go:171","msg":"trace[885627509] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"100.189465ms","start":"2026-04-08T01:26:27.552405Z","end":"2026-04-08T01:26:27.652595Z","steps":["trace[885627509] 'process raft request' (duration: 99.584772ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:32.389034Z","caller":"traceutil/trace.go:171","msg":"trace[771965062] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"139.213075ms","start":"2026-04-08T01:26:32.249786Z","end":"2026-04-08T01:26:32.388999Z","steps":["trace[771965062] 'process raft request' (duration: 92.298917ms)","trace[771965062] 'compare' (duration: 46.683834ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:26:32.389082Z","caller":"traceutil/trace.go:171","msg":"trace[1854205950] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"138.235576ms","start":"2026-04-08T01:26:32.250819Z","end":"2026-04-08T01:26:32.389055Z","steps":["trace[1854205950] 'process raft request' (duration: 138.120444ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:32.389267Z","caller":"traceutil/trace.go:171","msg":"trace[210276702] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"137.894059ms","start":"2026-04-08T01:26:32.251315Z","end":"2026-04-08T01:26:32.389209Z","steps":["trace[210276702] 'process raft request' (duration: 137.684885ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:43.488499Z","caller":"traceutil/trace.go:171","msg":"trace[500048044] transaction","detail":"{read_only:false; response_revision:5135; number_of_response:1; }","duration":"131.023389ms","start":"2026-04-08T01:26:43.357448Z","end":"2026-04-08T01:26:43.488471Z","steps":["trace[500048044] 'process raft request' (duration: 130.836905ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:44.037353Z","caller":"traceutil/trace.go:171","msg":"trace[1756384510] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"216.252262ms","start":"2026-04-08T01:26:43.821049Z","end":"2026-04-08T01:26:44.037301Z","steps":["trace[1756384510] 'process raft request' (duration: 215.6641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:26:51.820988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.650678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:26:51.821123Z","caller":"traceutil/trace.go:171","msg":"trace[202715805] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5321; }","duration":"113.839282ms","start":"2026-04-08T01:26:51.707243Z","end":"2026-04-08T01:26:51.821082Z","steps":["trace[202715805] 'count revisions from in-memory index tree' (duration: 113.532986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:26:51.821107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.586964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:26:51.821309Z","caller":"traceutil/trace.go:171","msg":"trace[1322711750] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5321; }","duration":"102.84554ms","start":"2026-04-08T01:26:51.718436Z","end":"2026-04-08T01:26:51.821281Z","steps":["trace[1322711750] 'range keys from in-memory index tree' (duration: 102.486643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:26:51.821177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.976804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80197"} {"level":"info","ts":"2026-04-08T01:26:51.821447Z","caller":"traceutil/trace.go:171","msg":"trace[1819732798] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5321; }","duration":"111.26894ms","start":"2026-04-08T01:26:51.710157Z","end":"2026-04-08T01:26:51.821426Z","steps":["trace[1819732798] 'range keys from in-memory index tree' (duration: 110.634067ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:23.761367Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3004} {"level":"info","ts":"2026-04-08T01:28:23.839794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3004,"took":"76.565381ms","hash":208885905,"current-db-size-bytes":57815040,"current-db-size":"58 MB","current-db-size-in-use-bytes":31907840,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-08T01:28:23.839866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":208885905,"revision":3004,"compact-revision":-1} {"level":"info","ts":"2026-04-08T01:32:55.175471Z","caller":"traceutil/trace.go:171","msg":"trace[358955828] linearizableReadLoop","detail":"{readStateIndex:8411; appliedIndex:8410; }","duration":"152.753664ms","start":"2026-04-08T01:32:55.022695Z","end":"2026-04-08T01:32:55.175448Z","steps":["trace[358955828] 'read index received' (duration: 152.654262ms)","trace[358955828] 'applied index is now lower than readState.Index' (duration: 98.502µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:32:55.175617Z","caller":"traceutil/trace.go:171","msg":"trace[1968148286] transaction","detail":"{read_only:false; response_revision:8128; number_of_response:1; }","duration":"164.45823ms","start":"2026-04-08T01:32:55.011111Z","end":"2026-04-08T01:32:55.175569Z","steps":["trace[1968148286] 'process raft request' (duration: 164.194905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:32:55.175743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.028769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-08T01:32:55.175819Z","caller":"traceutil/trace.go:171","msg":"trace[1884766873] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8128; }","duration":"153.135972ms","start":"2026-04-08T01:32:55.022669Z","end":"2026-04-08T01:32:55.175805Z","steps":["trace[1884766873] 'agreement among raft nodes before linearized reading' (duration: 152.899107ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:32:55.277086Z","caller":"traceutil/trace.go:171","msg":"trace[1331896504] transaction","detail":"{read_only:false; response_revision:8129; number_of_response:1; }","duration":"233.454819ms","start":"2026-04-08T01:32:55.043606Z","end":"2026-04-08T01:32:55.277061Z","steps":["trace[1331896504] 'process raft request' (duration: 230.476509ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:32:55.277233Z","caller":"traceutil/trace.go:171","msg":"trace[2082628855] linearizableReadLoop","detail":"{readStateIndex:8413; appliedIndex:8411; }","duration":"101.658966ms","start":"2026-04-08T01:32:55.175548Z","end":"2026-04-08T01:32:55.277207Z","steps":["trace[2082628855] 'read index received' (duration: 98.490693ms)","trace[2082628855] 'applied index is now lower than readState.Index' (duration: 3.166993ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:32:55.277547Z","caller":"traceutil/trace.go:171","msg":"trace[742353367] transaction","detail":"{read_only:false; response_revision:8130; number_of_response:1; }","duration":"153.410599ms","start":"2026-04-08T01:32:55.124122Z","end":"2026-04-08T01:32:55.277533Z","steps":["trace[742353367] 'process raft request' (duration: 152.897248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:32:55.277551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.178116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T01:32:55.277677Z","caller":"traceutil/trace.go:171","msg":"trace[873153328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8130; }","duration":"244.302768ms","start":"2026-04-08T01:32:55.033314Z","end":"2026-04-08T01:32:55.277616Z","steps":["trace[873153328] 'agreement among raft nodes before linearized reading' (duration: 244.076503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:32:55.277837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.400761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T01:32:55.277869Z","caller":"traceutil/trace.go:171","msg":"trace[1205331081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8130; }","duration":"241.463841ms","start":"2026-04-08T01:32:55.036398Z","end":"2026-04-08T01:32:55.277862Z","steps":["trace[1205331081] 'agreement among raft nodes before linearized reading' (duration: 241.3817ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:33:23.768066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6117} {"level":"info","ts":"2026-04-08T01:33:23.87939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6117,"took":"109.082431ms","hash":1207238140,"current-db-size-bytes":57815040,"current-db-size":"58 MB","current-db-size-in-use-bytes":23031808,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-08T01:33:23.87948Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1207238140,"revision":6117,"compact-revision":3004} {"level":"info","ts":"2026-04-08T01:33:36.141378Z","caller":"traceutil/trace.go:171","msg":"trace[2033942110] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"134.320998ms","start":"2026-04-08T01:33:36.007029Z","end":"2026-04-08T01:33:36.14135Z","steps":["trace[2033942110] 'process raft request' (duration: 134.160674ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:33:36.346902Z","caller":"traceutil/trace.go:171","msg":"trace[803844502] linearizableReadLoop","detail":"{readStateIndex:8699; appliedIndex:8698; }","duration":"161.644885ms","start":"2026-04-08T01:33:36.18511Z","end":"2026-04-08T01:33:36.346755Z","steps":["trace[803844502] 'read index received' (duration: 160.268017ms)","trace[803844502] 'applied index is now lower than readState.Index' (duration: 1.375668ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:33:36.347214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.095144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kxssq\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-08T01:33:36.347302Z","caller":"traceutil/trace.go:171","msg":"trace[1390872942] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kxssq; range_end:; response_count:1; response_revision:8404; }","duration":"162.243607ms","start":"2026-04-08T01:33:36.185038Z","end":"2026-04-08T01:33:36.347281Z","steps":["trace[1390872942] 'agreement among raft nodes before linearized reading' (duration: 162.005683ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:33:36.346956Z","caller":"traceutil/trace.go:171","msg":"trace[18634966] transaction","detail":"{read_only:false; response_revision:8404; number_of_response:1; }","duration":"259.535484ms","start":"2026-04-08T01:33:36.087368Z","end":"2026-04-08T01:33:36.346903Z","steps":["trace[18634966] 'process raft request' (duration: 258.635656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:33:49.011851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.537712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T01:33:49.011928Z","caller":"traceutil/trace.go:171","msg":"trace[2002308859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8512; }","duration":"136.659675ms","start":"2026-04-08T01:33:48.875254Z","end":"2026-04-08T01:33:49.011914Z","steps":["trace[2002308859] 'range keys from in-memory index tree' (duration: 136.36324ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:33:49.148244Z","caller":"traceutil/trace.go:171","msg":"trace[1074849579] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"125.754767ms","start":"2026-04-08T01:33:49.022456Z","end":"2026-04-08T01:33:49.148211Z","steps":["trace[1074849579] 'process raft request' (duration: 114.027011ms)","trace[1074849579] 'compare' (duration: 11.589643ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:33:49.771467Z","caller":"traceutil/trace.go:171","msg":"trace[166470434] transaction","detail":"{read_only:false; response_revision:8522; number_of_response:1; }","duration":"165.902799ms","start":"2026-04-08T01:33:49.605522Z","end":"2026-04-08T01:33:49.771425Z","steps":["trace[166470434] 'process raft request' (duration: 165.656294ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:33:49.85276Z","caller":"traceutil/trace.go:171","msg":"trace[1309113940] linearizableReadLoop","detail":"{readStateIndex:8824; appliedIndex:8822; }","duration":"135.90762ms","start":"2026-04-08T01:33:49.716828Z","end":"2026-04-08T01:33:49.852736Z","steps":["trace[1309113940] 'read index received' (duration: 54.49191ms)","trace[1309113940] 'applied index is now lower than readState.Index' (duration: 81.41477ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:33:49.853052Z","caller":"traceutil/trace.go:171","msg":"trace[1006020010] transaction","detail":"{read_only:false; response_revision:8523; number_of_response:1; }","duration":"244.876049ms","start":"2026-04-08T01:33:49.608162Z","end":"2026-04-08T01:33:49.853038Z","steps":["trace[1006020010] 'process raft request' (duration: 203.45024ms)","trace[1006020010] 'compare' (duration: 40.94805ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:33:49.853503Z","caller":"traceutil/trace.go:171","msg":"trace[233936565] transaction","detail":"{read_only:false; response_revision:8524; number_of_response:1; }","duration":"129.796887ms","start":"2026-04-08T01:33:49.723695Z","end":"2026-04-08T01:33:49.853492Z","steps":["trace[233936565] 'process raft request' (duration: 128.993852ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:33:49.853806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.970881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:33:49.853849Z","caller":"traceutil/trace.go:171","msg":"trace[1971018777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8524; }","duration":"137.072563ms","start":"2026-04-08T01:33:49.716766Z","end":"2026-04-08T01:33:49.853839Z","steps":["trace[1971018777] 'agreement among raft nodes before linearized reading' (duration: 136.989242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:33:49.854082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.817407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210982"} {"level":"info","ts":"2026-04-08T01:33:49.854169Z","caller":"traceutil/trace.go:171","msg":"trace[1477234521] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8524; }","duration":"114.9678ms","start":"2026-04-08T01:33:49.739176Z","end":"2026-04-08T01:33:49.854144Z","steps":["trace[1477234521] 'agreement among raft nodes before linearized reading' (duration: 113.912678ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:33:50.148326Z","caller":"traceutil/trace.go:171","msg":"trace[2112476619] transaction","detail":"{read_only:false; response_revision:8525; number_of_response:1; }","duration":"196.398499ms","start":"2026-04-08T01:33:49.951908Z","end":"2026-04-08T01:33:50.148306Z","steps":["trace[2112476619] 'process raft request' (duration: 196.262967ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:34:24.820382Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d4.wal"} {"level":"info","ts":"2026-04-08T01:34:35.408907Z","caller":"traceutil/trace.go:171","msg":"trace[424328303] transaction","detail":"{read_only:false; response_revision:8924; number_of_response:1; }","duration":"115.183525ms","start":"2026-04-08T01:34:35.293694Z","end":"2026-04-08T01:34:35.408878Z","steps":["trace[424328303] 'process raft request' (duration: 115.034062ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:01.892646Z","caller":"traceutil/trace.go:171","msg":"trace[1934879804] transaction","detail":"{read_only:false; response_revision:9242; number_of_response:1; }","duration":"110.487921ms","start":"2026-04-08T01:35:01.782128Z","end":"2026-04-08T01:35:01.892616Z","steps":["trace[1934879804] 'process raft request' (duration: 108.647714ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:01.892904Z","caller":"traceutil/trace.go:171","msg":"trace[1849247415] transaction","detail":"{read_only:false; response_revision:9243; number_of_response:1; }","duration":"103.94455ms","start":"2026-04-08T01:35:01.788925Z","end":"2026-04-08T01:35:01.89287Z","steps":["trace[1849247415] 'process raft request' (duration: 103.591023ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:36:00.509768Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"791a7e25b533cd26","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T01:36:00.516647Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T01:36:00.516761Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T01:38:23.77538Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8290} {"level":"info","ts":"2026-04-08T01:38:23.8558Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8290,"took":"78.003109ms","hash":3858077828,"current-db-size-bytes":57815040,"current-db-size":"58 MB","current-db-size-in-use-bytes":24924160,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T01:38:23.855883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3858077828,"revision":8290,"compact-revision":6117} {"level":"info","ts":"2026-04-08T01:43:23.781672Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10682} {"level":"info","ts":"2026-04-08T01:43:23.86297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10682,"took":"78.653233ms","hash":1958060682,"current-db-size-bytes":57815040,"current-db-size":"58 MB","current-db-size-in-use-bytes":20393984,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T01:43:23.863038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1958060682,"revision":10682,"compact-revision":8290}