{"level":"warn","ts":"2026-04-08T01:18:45.171661Z","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:45.171774Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.221: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.221:2380","--initial-cluster=instance=https://162.253.55.221:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.221:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.221: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:45.171863Z","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:45.17188Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.221:2380"]} {"level":"info","ts":"2026-04-08T01:18:45.171903Z","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:45.172608Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"]} {"level":"info","ts":"2026-04-08T01:18:45.17271Z","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.221:2380"],"listen-peer-urls":["https://162.253.55.221:2380"],"advertise-client-urls":["https://162.253.55.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.221: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:45.179046Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.799804ms"} {"level":"info","ts":"2026-04-08T01:18:45.18706Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c187bdee547e8fd1","cluster-id":"ee7528b898b8b18e"} {"level":"info","ts":"2026-04-08T01:18:45.187176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T01:18:45.187208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became follower at term 0"} {"level":"info","ts":"2026-04-08T01:18:45.187227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c187bdee547e8fd1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T01:18:45.187308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became follower at term 1"} {"level":"info","ts":"2026-04-08T01:18:45.187445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=(13945323602493476817)"} {"level":"warn","ts":"2026-04-08T01:18:45.196715Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T01:18:45.200242Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T01:18:45.201446Z","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:45.204993Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c187bdee547e8fd1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T01:18:45.205171Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c187bdee547e8fd1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T01:18:45.209857Z","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:45.210123Z","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:45.210311Z","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:45.210932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=(13945323602493476817)"} {"level":"info","ts":"2026-04-08T01:18:45.211182Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee7528b898b8b18e","local-member-id":"c187bdee547e8fd1","added-peer-id":"c187bdee547e8fd1","added-peer-peer-urls":["https://162.253.55.221:2380"]} {"level":"info","ts":"2026-04-08T01:18:45.215199Z","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:45.215309Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.221:2380"} {"level":"info","ts":"2026-04-08T01:18:45.215414Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.221:2380"} {"level":"info","ts":"2026-04-08T01:18:45.215814Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c187bdee547e8fd1","initial-advertise-peer-urls":["https://162.253.55.221:2380"],"listen-peer-urls":["https://162.253.55.221:2380"],"advertise-client-urls":["https://162.253.55.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T01:18:45.21589Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T01:18:45.487811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T01:18:45.48789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T01:18:45.487933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 received MsgPreVoteResp from c187bdee547e8fd1 at term 1"} {"level":"info","ts":"2026-04-08T01:18:45.487956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became candidate at term 2"} {"level":"info","ts":"2026-04-08T01:18:45.487966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 received MsgVoteResp from c187bdee547e8fd1 at term 2"} {"level":"info","ts":"2026-04-08T01:18:45.487984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became leader at term 2"} {"level":"info","ts":"2026-04-08T01:18:45.48819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c187bdee547e8fd1 elected leader c187bdee547e8fd1 at term 2"} {"level":"info","ts":"2026-04-08T01:18:45.489474Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c187bdee547e8fd1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.221:2379]}","request-path":"/0/members/c187bdee547e8fd1/attributes","cluster-id":"ee7528b898b8b18e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T01:18:45.48949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:18:45.489257Z","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:45.489619Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:18:45.489916Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T01:18:45.489981Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T01:18:45.490666Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee7528b898b8b18e","local-member-id":"c187bdee547e8fd1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:45.490916Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:45.490966Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:18:45.495082Z","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:45.496106Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.221:2379"} {"level":"info","ts":"2026-04-08T01:18:48.9305Z","caller":"traceutil/trace.go:171","msg":"trace[1367167926] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"124.54517ms","start":"2026-04-08T01:18:48.805922Z","end":"2026-04-08T01:18:48.930468Z","steps":["trace[1367167926] 'process raft request' (duration: 114.91111ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:06.874401Z","caller":"traceutil/trace.go:171","msg":"trace[81034558] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"253.810857ms","start":"2026-04-08T01:20:06.62056Z","end":"2026-04-08T01:20:06.874371Z","steps":["trace[81034558] 'process raft request' (duration: 245.961431ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:06.874649Z","caller":"traceutil/trace.go:171","msg":"trace[1748739504] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"241.443561ms","start":"2026-04-08T01:20:06.633195Z","end":"2026-04-08T01:20:06.874639Z","steps":["trace[1748739504] 'process raft request' (duration: 241.230917ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:06.874818Z","caller":"traceutil/trace.go:171","msg":"trace[530094848] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"229.461654ms","start":"2026-04-08T01:20:06.645351Z","end":"2026-04-08T01:20:06.874812Z","steps":["trace[530094848] 'process raft request' (duration: 229.221259ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:06.874841Z","caller":"traceutil/trace.go:171","msg":"trace[1951231023] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"205.58053ms","start":"2026-04-08T01:20:06.669233Z","end":"2026-04-08T01:20:06.874814Z","steps":["trace[1951231023] 'process raft request' (duration: 205.407967ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:12.305738Z","caller":"traceutil/trace.go:171","msg":"trace[598048879] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"168.607606ms","start":"2026-04-08T01:20:12.137068Z","end":"2026-04-08T01:20:12.305675Z","steps":["trace[598048879] 'process raft request' (duration: 165.348832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:12.308408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.958744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T01:20:12.312679Z","caller":"traceutil/trace.go:171","msg":"trace[1621701276] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:738; }","duration":"106.29878ms","start":"2026-04-08T01:20:12.206342Z","end":"2026-04-08T01:20:12.312641Z","steps":["trace[1621701276] 'agreement among raft nodes before linearized reading' (duration: 98.931354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:12.669407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.504539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:20:12.669713Z","caller":"traceutil/trace.go:171","msg":"trace[373221588] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"299.231818ms","start":"2026-04-08T01:20:12.370459Z","end":"2026-04-08T01:20:12.669691Z","steps":["trace[373221588] 'process raft request' (duration: 299.172647ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:12.669695Z","caller":"traceutil/trace.go:171","msg":"trace[159306580] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"352.674569ms","start":"2026-04-08T01:20:12.316954Z","end":"2026-04-08T01:20:12.669629Z","steps":["trace[159306580] 'process raft request' (duration: 157.023826ms)","trace[159306580] 'compare' (duration: 194.329606ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:20:12.669929Z","caller":"traceutil/trace.go:171","msg":"trace[729453151] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"349.600129ms","start":"2026-04-08T01:20:12.320304Z","end":"2026-04-08T01:20:12.669905Z","steps":["trace[729453151] 'process raft request' (duration: 349.229311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:12.669946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:20:12.316943Z","time spent":"352.869053ms","remote":"127.0.0.1:39178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:20:12.670074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:20:12.320277Z","time spent":"349.730561ms","remote":"127.0.0.1:39104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:20:27.813164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.446858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kkkbd\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-08T01:20:27.813274Z","caller":"traceutil/trace.go:171","msg":"trace[130467938] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kkkbd; range_end:; response_count:1; response_revision:901; }","duration":"412.625082ms","start":"2026-04-08T01:20:27.400627Z","end":"2026-04-08T01:20:27.813252Z","steps":["trace[130467938] 'range keys from in-memory index tree' (duration: 412.242884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:20:27.813326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:20:27.400604Z","time spent":"412.711774ms","remote":"127.0.0.1:39104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kkkbd\" "} {"level":"info","ts":"2026-04-08T01:20:58.167063Z","caller":"traceutil/trace.go:171","msg":"trace[1818966928] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"112.084836ms","start":"2026-04-08T01:20:58.054953Z","end":"2026-04-08T01:20:58.167038Z","steps":["trace[1818966928] 'process raft request' (duration: 111.794781ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:20:58.316778Z","caller":"traceutil/trace.go:171","msg":"trace[1457353107] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"145.087253ms","start":"2026-04-08T01:20:58.171653Z","end":"2026-04-08T01:20:58.31674Z","steps":["trace[1457353107] 'process raft request' (duration: 114.199797ms)","trace[1457353107] 'compare' (duration: 30.735203ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:21:45.290627Z","caller":"traceutil/trace.go:171","msg":"trace[1384810194] linearizableReadLoop","detail":"{readStateIndex:2071; appliedIndex:2070; }","duration":"178.763498ms","start":"2026-04-08T01:21:45.11182Z","end":"2026-04-08T01:21:45.290584Z","steps":["trace[1384810194] 'read index received' (duration: 93.741386ms)","trace[1384810194] 'applied index is now lower than readState.Index' (duration: 85.020322ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:21:45.290697Z","caller":"traceutil/trace.go:171","msg":"trace[738635096] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"232.588506ms","start":"2026-04-08T01:21:45.058067Z","end":"2026-04-08T01:21:45.290655Z","steps":["trace[738635096] 'process raft request' (duration: 147.482182ms)","trace[738635096] 'compare' (duration: 84.641223ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:21:45.29086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.032293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T01:21:45.290934Z","caller":"traceutil/trace.go:171","msg":"trace[1174099719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1988; }","duration":"179.165716ms","start":"2026-04-08T01:21:45.111749Z","end":"2026-04-08T01:21:45.290915Z","steps":["trace[1174099719] 'agreement among raft nodes before linearized reading' (duration: 178.968052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:21:45.695093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.165818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:21:45.695258Z","caller":"traceutil/trace.go:171","msg":"trace[2015447745] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"358.355893ms","start":"2026-04-08T01:21:45.336874Z","end":"2026-04-08T01:21:45.69523Z","steps":["trace[2015447745] 'process raft request' (duration: 69.92932ms)","trace[2015447745] 'compare' (duration: 287.985014ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:21:45.695367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:21:45.336833Z","time spent":"358.480216ms","remote":"127.0.0.1:39178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:22:28.972213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.499482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:22:28.972411Z","caller":"traceutil/trace.go:171","msg":"trace[1637502590] linearizableReadLoop","detail":"{readStateIndex:2373; appliedIndex:2372; }","duration":"216.838781ms","start":"2026-04-08T01:22:28.755553Z","end":"2026-04-08T01:22:28.972392Z","steps":["trace[1637502590] 'read index received' (duration: 78.102993ms)","trace[1637502590] 'applied index is now lower than readState.Index' (duration: 138.734358ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:28.972515Z","caller":"traceutil/trace.go:171","msg":"trace[952331140] transaction","detail":"{read_only:false; response_revision:2281; number_of_response:1; }","duration":"223.518014ms","start":"2026-04-08T01:22:28.748937Z","end":"2026-04-08T01:22:28.972455Z","steps":["trace[952331140] 'process raft request' (duration: 84.632913ms)","trace[952331140] 'compare' (duration: 138.350089ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:28.972666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.107146ms","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:22:28.972754Z","caller":"traceutil/trace.go:171","msg":"trace[425647794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2281; }","duration":"217.211538ms","start":"2026-04-08T01:22:28.755526Z","end":"2026-04-08T01:22:28.972738Z","steps":["trace[425647794] 'agreement among raft nodes before linearized reading' (duration: 216.996284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:28.973091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.306219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a43d19bd4e1acd\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-08T01:22:28.973215Z","caller":"traceutil/trace.go:171","msg":"trace[1561461291] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a43d19bd4e1acd; range_end:; response_count:1; response_revision:2281; }","duration":"147.479742ms","start":"2026-04-08T01:22:28.825713Z","end":"2026-04-08T01:22:28.973192Z","steps":["trace[1561461291] 'agreement among raft nodes before linearized reading' (duration: 146.86974ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:35.287109Z","caller":"traceutil/trace.go:171","msg":"trace[1173043197] transaction","detail":"{read_only:false; response_revision:2316; number_of_response:1; }","duration":"192.319225ms","start":"2026-04-08T01:22:35.094759Z","end":"2026-04-08T01:22:35.287078Z","steps":["trace[1173043197] 'process raft request' (duration: 192.126571ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:35.417549Z","caller":"traceutil/trace.go:171","msg":"trace[1998011493] linearizableReadLoop","detail":"{readStateIndex:2411; appliedIndex:2409; }","duration":"150.161822ms","start":"2026-04-08T01:22:35.267365Z","end":"2026-04-08T01:22:35.417527Z","steps":["trace[1998011493] 'read index received' (duration: 19.653633ms)","trace[1998011493] 'applied index is now lower than readState.Index' (duration: 130.507388ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:35.417606Z","caller":"traceutil/trace.go:171","msg":"trace[1344787800] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"315.264452ms","start":"2026-04-08T01:22:35.102313Z","end":"2026-04-08T01:22:35.417578Z","steps":["trace[1344787800] 'process raft request' (duration: 298.138769ms)","trace[1344787800] 'compare' (duration: 16.914168ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:35.417715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.392226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:35.417749Z","caller":"traceutil/trace.go:171","msg":"trace[1863225110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2317; }","duration":"108.496018ms","start":"2026-04-08T01:22:35.309245Z","end":"2026-04-08T01:22:35.417741Z","steps":["trace[1863225110] 'agreement among raft nodes before linearized reading' (duration: 108.420946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:35.417755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:35.102297Z","time spent":"315.364564ms","remote":"127.0.0.1:39178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:22:35.417757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.390526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-08T01:22:35.417834Z","caller":"traceutil/trace.go:171","msg":"trace[2107712239] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2317; }","duration":"150.549029ms","start":"2026-04-08T01:22:35.267266Z","end":"2026-04-08T01:22:35.417815Z","steps":["trace[2107712239] 'agreement among raft nodes before linearized reading' (duration: 150.342565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:35.826479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.868616ms","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:22:35.826677Z","caller":"traceutil/trace.go:171","msg":"trace[813326450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2318; }","duration":"108.136471ms","start":"2026-04-08T01:22:35.718513Z","end":"2026-04-08T01:22:35.826649Z","steps":["trace[813326450] 'range keys from in-memory index tree' (duration: 107.676562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:35.82713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.815094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:22:35.82723Z","caller":"traceutil/trace.go:171","msg":"trace[572942663] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2318; }","duration":"250.183142ms","start":"2026-04-08T01:22:35.577027Z","end":"2026-04-08T01:22:35.82721Z","steps":["trace[572942663] 'count revisions from in-memory index tree' (duration: 249.686471ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:35.933282Z","caller":"traceutil/trace.go:171","msg":"trace[2048197717] transaction","detail":"{read_only:false; response_revision:2319; number_of_response:1; }","duration":"101.724883ms","start":"2026-04-08T01:22:35.83134Z","end":"2026-04-08T01:22:35.933065Z","steps":["trace[2048197717] 'process raft request' (duration: 101.592701ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:41.164095Z","caller":"traceutil/trace.go:171","msg":"trace[574377306] linearizableReadLoop","detail":"{readStateIndex:2440; appliedIndex:2439; }","duration":"113.231644ms","start":"2026-04-08T01:22:41.050805Z","end":"2026-04-08T01:22:41.164036Z","steps":["trace[574377306] 'read index received' (duration: 112.855526ms)","trace[574377306] 'applied index is now lower than readState.Index' (duration: 374.398µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:41.164252Z","caller":"traceutil/trace.go:171","msg":"trace[420435417] transaction","detail":"{read_only:false; response_revision:2345; number_of_response:1; }","duration":"119.362336ms","start":"2026-04-08T01:22:41.04486Z","end":"2026-04-08T01:22:41.164223Z","steps":["trace[420435417] 'process raft request' (duration: 118.971939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:41.164361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.519499ms","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:22:41.164406Z","caller":"traceutil/trace.go:171","msg":"trace[876587037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2345; }","duration":"113.603672ms","start":"2026-04-08T01:22:41.050791Z","end":"2026-04-08T01:22:41.164395Z","steps":["trace[876587037] 'agreement among raft nodes before linearized reading' (duration: 113.399488ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:41.325463Z","caller":"traceutil/trace.go:171","msg":"trace[407440723] transaction","detail":"{read_only:false; response_revision:2346; number_of_response:1; }","duration":"156.199603ms","start":"2026-04-08T01:22:41.169215Z","end":"2026-04-08T01:22:41.325414Z","steps":["trace[407440723] 'process raft request' (duration: 119.291495ms)","trace[407440723] 'compare' (duration: 36.725294ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:59.241115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.719113ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:23:59.241221Z","caller":"traceutil/trace.go:171","msg":"trace[1938396302] linearizableReadLoop","detail":"{readStateIndex:3081; appliedIndex:3080; }","duration":"101.858825ms","start":"2026-04-08T01:23:59.139346Z","end":"2026-04-08T01:23:59.241205Z","steps":["trace[1938396302] 'read index received' (duration: 30.981µs)","trace[1938396302] 'applied index is now lower than readState.Index' (duration: 101.826834ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:59.241361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.992638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.221\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-08T01:23:59.241394Z","caller":"traceutil/trace.go:171","msg":"trace[706089160] range","detail":"{range_begin:/registry/masterleases/162.253.55.221; range_end:; response_count:1; response_revision:2963; }","duration":"102.073839ms","start":"2026-04-08T01:23:59.139311Z","end":"2026-04-08T01:23:59.241385Z","steps":["trace[706089160] 'agreement among raft nodes before linearized reading' (duration: 101.939096ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:59.241377Z","caller":"traceutil/trace.go:171","msg":"trace[243856304] transaction","detail":"{read_only:false; response_revision:2963; number_of_response:1; }","duration":"120.516908ms","start":"2026-04-08T01:23:59.120793Z","end":"2026-04-08T01:23:59.241309Z","steps":["trace[243856304] 'compare' (duration: 112.629131ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:05.289741Z","caller":"traceutil/trace.go:171","msg":"trace[1216275792] linearizableReadLoop","detail":"{readStateIndex:3114; appliedIndex:3113; }","duration":"145.085872ms","start":"2026-04-08T01:24:05.144623Z","end":"2026-04-08T01:24:05.289708Z","steps":["trace[1216275792] 'read index received' (duration: 54.76372ms)","trace[1216275792] 'applied index is now lower than readState.Index' (duration: 90.320662ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:05.289795Z","caller":"traceutil/trace.go:171","msg":"trace[1913302025] transaction","detail":"{read_only:false; response_revision:2994; number_of_response:1; }","duration":"177.986692ms","start":"2026-04-08T01:24:05.111774Z","end":"2026-04-08T01:24:05.289761Z","steps":["trace[1913302025] 'process raft request' (duration: 87.584908ms)","trace[1913302025] 'compare' (duration: 90.21519ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:05.290029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.402598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-08T01:24:05.290228Z","caller":"traceutil/trace.go:171","msg":"trace[1595203701] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2994; }","duration":"145.53185ms","start":"2026-04-08T01:24:05.144531Z","end":"2026-04-08T01:24:05.290063Z","steps":["trace[1595203701] 'agreement among raft nodes before linearized reading' (duration: 145.333826ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:42.266615Z","caller":"traceutil/trace.go:171","msg":"trace[1600354567] transaction","detail":"{read_only:false; response_revision:4017; number_of_response:1; }","duration":"108.656488ms","start":"2026-04-08T01:26:42.157927Z","end":"2026-04-08T01:26:42.266583Z","steps":["trace[1600354567] 'process raft request' (duration: 108.496525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:26:42.415745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.442915ms","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:42.415894Z","caller":"traceutil/trace.go:171","msg":"trace[394280549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4017; }","duration":"106.666888ms","start":"2026-04-08T01:26:42.3092Z","end":"2026-04-08T01:26:42.415867Z","steps":["trace[394280549] 'range keys from in-memory index tree' (duration: 106.330282ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:16.194439Z","caller":"traceutil/trace.go:171","msg":"trace[1543428232] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"105.935865ms","start":"2026-04-08T01:28:16.088422Z","end":"2026-04-08T01:28:16.194358Z","steps":["trace[1543428232] 'process raft request' (duration: 105.089638ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:16.221637Z","caller":"traceutil/trace.go:171","msg":"trace[1622451573] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"100.302832ms","start":"2026-04-08T01:28:16.121298Z","end":"2026-04-08T01:28:16.221601Z","steps":["trace[1622451573] 'process raft request' (duration: 97.495806ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:16.365467Z","caller":"traceutil/trace.go:171","msg":"trace[718229052] linearizableReadLoop","detail":"{readStateIndex:5317; appliedIndex:5315; }","duration":"114.922005ms","start":"2026-04-08T01:28:16.250521Z","end":"2026-04-08T01:28:16.365443Z","steps":["trace[718229052] 'read index received' (duration: 42.567694ms)","trace[718229052] 'applied index is now lower than readState.Index' (duration: 72.353461ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:28:16.36556Z","caller":"traceutil/trace.go:171","msg":"trace[1826322318] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"115.1453ms","start":"2026-04-08T01:28:16.250366Z","end":"2026-04-08T01:28:16.365511Z","steps":["trace[1826322318] 'process raft request' (duration: 114.940676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:16.365719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.574318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-08T01:28:16.365754Z","caller":"traceutil/trace.go:171","msg":"trace[1103489720] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5115; }","duration":"113.678069ms","start":"2026-04-08T01:28:16.252067Z","end":"2026-04-08T01:28:16.365745Z","steps":["trace[1103489720] 'agreement among raft nodes before linearized reading' (duration: 113.522856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:16.365789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.231411ms","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:4849"} {"level":"info","ts":"2026-04-08T01:28:16.36588Z","caller":"traceutil/trace.go:171","msg":"trace[1640421708] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5115; }","duration":"115.363885ms","start":"2026-04-08T01:28:16.250496Z","end":"2026-04-08T01:28:16.36586Z","steps":["trace[1640421708] 'agreement among raft nodes before linearized reading' (duration: 115.051058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:16.365988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.1798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-08T01:28:16.36601Z","caller":"traceutil/trace.go:171","msg":"trace[234550972] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5115; }","duration":"107.244981ms","start":"2026-04-08T01:28:16.258759Z","end":"2026-04-08T01:28:16.366004Z","steps":["trace[234550972] 'agreement among raft nodes before linearized reading' (duration: 107.18894ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:22.126936Z","caller":"traceutil/trace.go:171","msg":"trace[1319939501] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"127.394956ms","start":"2026-04-08T01:28:21.999505Z","end":"2026-04-08T01:28:22.1269Z","steps":["trace[1319939501] 'process raft request' (duration: 126.853035ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:22.127221Z","caller":"traceutil/trace.go:171","msg":"trace[276103405] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"122.995468ms","start":"2026-04-08T01:28:22.004188Z","end":"2026-04-08T01:28:22.127183Z","steps":["trace[276103405] 'process raft request' (duration: 122.6167ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:22.127339Z","caller":"traceutil/trace.go:171","msg":"trace[462560989] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"120.495068ms","start":"2026-04-08T01:28:22.006797Z","end":"2026-04-08T01:28:22.127292Z","steps":["trace[462560989] 'process raft request' (duration: 120.247743ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:32.489889Z","caller":"traceutil/trace.go:171","msg":"trace[976003532] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"129.972868ms","start":"2026-04-08T01:28:32.35989Z","end":"2026-04-08T01:28:32.489863Z","steps":["trace[976003532] 'process raft request' (duration: 129.910826ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:32.489942Z","caller":"traceutil/trace.go:171","msg":"trace[1612932798] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"130.010048ms","start":"2026-04-08T01:28:32.359888Z","end":"2026-04-08T01:28:32.489898Z","steps":["trace[1612932798] 'process raft request' (duration: 47.862391ms)","trace[1612932798] 'compare' (duration: 81.850901ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:28:40.554246Z","caller":"traceutil/trace.go:171","msg":"trace[2037161359] linearizableReadLoop","detail":"{readStateIndex:5879; appliedIndex:5878; }","duration":"108.543138ms","start":"2026-04-08T01:28:40.445661Z","end":"2026-04-08T01:28:40.554204Z","steps":["trace[2037161359] 'read index received' (duration: 31.213486ms)","trace[2037161359] 'applied index is now lower than readState.Index' (duration: 77.328362ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:28:40.554319Z","caller":"traceutil/trace.go:171","msg":"trace[612632448] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"164.332177ms","start":"2026-04-08T01:28:40.389949Z","end":"2026-04-08T01:28:40.554281Z","steps":["trace[612632448] 'process raft request' (duration: 87.048706ms)","trace[612632448] 'compare' (duration: 77.043356ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:28:40.555646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.958046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"} {"level":"info","ts":"2026-04-08T01:28:40.555763Z","caller":"traceutil/trace.go:171","msg":"trace[78679062] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5662; }","duration":"110.092059ms","start":"2026-04-08T01:28:40.445644Z","end":"2026-04-08T01:28:40.555736Z","steps":["trace[78679062] 'agreement among raft nodes before linearized reading' (duration: 108.738582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:40.850241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.246137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-08T01:28:40.850366Z","caller":"traceutil/trace.go:171","msg":"trace[537440640] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5662; }","duration":"182.42204ms","start":"2026-04-08T01:28:40.667914Z","end":"2026-04-08T01:28:40.850336Z","steps":["trace[537440640] 'range keys from in-memory index tree' (duration: 182.004551ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:45.802703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2888} {"level":"info","ts":"2026-04-08T01:28:45.876561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2888,"took":"71.557246ms","hash":2371500409,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":31825920,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-08T01:28:45.876644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2371500409,"revision":2888,"compact-revision":-1} {"level":"info","ts":"2026-04-08T01:33:45.809384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5749} {"level":"info","ts":"2026-04-08T01:33:45.895276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5749,"took":"83.934813ms","hash":3374931093,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":27258880,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-08T01:33:45.895359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3374931093,"revision":5749,"compact-revision":2888} {"level":"info","ts":"2026-04-08T01:34:59.158637Z","caller":"traceutil/trace.go:171","msg":"trace[1651847812] linearizableReadLoop","detail":"{readStateIndex:8864; appliedIndex:8863; }","duration":"104.34523ms","start":"2026-04-08T01:34:59.054266Z","end":"2026-04-08T01:34:59.158611Z","steps":["trace[1651847812] 'read index received' (duration: 104.095515ms)","trace[1651847812] 'applied index is now lower than readState.Index' (duration: 248.575µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:34:59.158756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.484052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:34:59.158782Z","caller":"traceutil/trace.go:171","msg":"trace[15228567] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8558; }","duration":"104.583434ms","start":"2026-04-08T01:34:59.054192Z","end":"2026-04-08T01:34:59.158775Z","steps":["trace[15228567] 'agreement among raft nodes before linearized reading' (duration: 104.507613ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:34:59.158724Z","caller":"traceutil/trace.go:171","msg":"trace[1699791769] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"192.858562ms","start":"2026-04-08T01:34:58.96582Z","end":"2026-04-08T01:34:59.158678Z","steps":["trace[1699791769] 'process raft request' (duration: 192.648488ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:34:59.314206Z","caller":"traceutil/trace.go:171","msg":"trace[953643454] linearizableReadLoop","detail":"{readStateIndex:8865; appliedIndex:8864; }","duration":"139.646992ms","start":"2026-04-08T01:34:59.174527Z","end":"2026-04-08T01:34:59.314174Z","steps":["trace[953643454] 'read index received' (duration: 125.821487ms)","trace[953643454] 'applied index is now lower than readState.Index' (duration: 13.823875ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:34:59.314286Z","caller":"traceutil/trace.go:171","msg":"trace[922786306] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"144.408277ms","start":"2026-04-08T01:34:59.169835Z","end":"2026-04-08T01:34:59.314244Z","steps":["trace[922786306] 'process raft request' (duration: 130.51303ms)","trace[922786306] 'compare' (duration: 13.55845ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:34:59.31478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.225085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.221\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-08T01:34:59.314882Z","caller":"traceutil/trace.go:171","msg":"trace[415213414] range","detail":"{range_begin:/registry/masterleases/162.253.55.221; range_end:; response_count:1; response_revision:8560; }","duration":"140.390767ms","start":"2026-04-08T01:34:59.174472Z","end":"2026-04-08T01:34:59.314862Z","steps":["trace[415213414] 'agreement among raft nodes before linearized reading' (duration: 139.928018ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:10.158468Z","caller":"traceutil/trace.go:171","msg":"trace[1336109442] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"119.190004ms","start":"2026-04-08T01:35:10.039181Z","end":"2026-04-08T01:35:10.158371Z","steps":["trace[1336109442] 'process raft request' (duration: 100.756347ms)","trace[1336109442] 'compare' (duration: 18.177942ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:35:11.771365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.435646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414469"} {"level":"info","ts":"2026-04-08T01:35:11.771482Z","caller":"traceutil/trace.go:171","msg":"trace[889753362] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8625; }","duration":"165.61666ms","start":"2026-04-08T01:35:11.605843Z","end":"2026-04-08T01:35:11.77146Z","steps":["trace[889753362] 'range keys from in-memory index tree' (duration: 165.10371ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:40.372184Z","caller":"traceutil/trace.go:171","msg":"trace[1816067865] linearizableReadLoop","detail":"{readStateIndex:9152; appliedIndex:9151; }","duration":"186.532457ms","start":"2026-04-08T01:35:40.185626Z","end":"2026-04-08T01:35:40.372158Z","steps":["trace[1816067865] 'read index received' (duration: 186.316223ms)","trace[1816067865] 'applied index is now lower than readState.Index' (duration: 214.854µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:35:40.372268Z","caller":"traceutil/trace.go:171","msg":"trace[1438195534] transaction","detail":"{read_only:false; response_revision:8835; number_of_response:1; }","duration":"209.393103ms","start":"2026-04-08T01:35:40.162822Z","end":"2026-04-08T01:35:40.372215Z","steps":["trace[1438195534] 'process raft request' (duration: 209.116147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:35:40.372457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.807112ms","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:35:40.372511Z","caller":"traceutil/trace.go:171","msg":"trace[1586575936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8835; }","duration":"186.928414ms","start":"2026-04-08T01:35:40.185568Z","end":"2026-04-08T01:35:40.372496Z","steps":["trace[1586575936] 'agreement among raft nodes before linearized reading' (duration: 186.738611ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:40.573935Z","caller":"traceutil/trace.go:171","msg":"trace[123192637] transaction","detail":"{read_only:false; response_revision:8837; number_of_response:1; }","duration":"196.004305ms","start":"2026-04-08T01:35:40.377893Z","end":"2026-04-08T01:35:40.573897Z","steps":["trace[123192637] 'process raft request' (duration: 195.943244ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:40.574299Z","caller":"traceutil/trace.go:171","msg":"trace[970908173] linearizableReadLoop","detail":"{readStateIndex:9153; appliedIndex:9152; }","duration":"201.990394ms","start":"2026-04-08T01:35:40.37227Z","end":"2026-04-08T01:35:40.574261Z","steps":["trace[970908173] 'read index received' (duration: 119.115323ms)","trace[970908173] 'applied index is now lower than readState.Index' (duration: 82.871151ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:35:40.574457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.774596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:35:40.574262Z","caller":"traceutil/trace.go:171","msg":"trace[1717528432] transaction","detail":"{read_only:false; response_revision:8836; number_of_response:1; }","duration":"283.816216ms","start":"2026-04-08T01:35:40.290426Z","end":"2026-04-08T01:35:40.574242Z","steps":["trace[1717528432] 'process raft request' (duration: 200.939084ms)","trace[1717528432] 'compare' (duration: 82.2938ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:35:40.574542Z","caller":"traceutil/trace.go:171","msg":"trace[1660737314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8837; }","duration":"264.922868ms","start":"2026-04-08T01:35:40.309595Z","end":"2026-04-08T01:35:40.574518Z","steps":["trace[1660737314] 'agreement among raft nodes before linearized reading' (duration: 264.797856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:35:40.574698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.981401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pr6td\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-08T01:35:40.574793Z","caller":"traceutil/trace.go:171","msg":"trace[2010206061] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pr6td; range_end:; response_count:1; response_revision:8837; }","duration":"376.112543ms","start":"2026-04-08T01:35:40.198658Z","end":"2026-04-08T01:35:40.574771Z","steps":["trace[2010206061] 'agreement among raft nodes before linearized reading' (duration: 375.832588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:35:40.574835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:35:40.198648Z","time spent":"376.177774ms","remote":"127.0.0.1:39104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-pr6td\" "} {"level":"warn","ts":"2026-04-08T01:35:40.575193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.896317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:35:40.575252Z","caller":"traceutil/trace.go:171","msg":"trace[1026415214] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:8837; }","duration":"136.029709ms","start":"2026-04-08T01:35:40.439209Z","end":"2026-04-08T01:35:40.575238Z","steps":["trace[1026415214] 'agreement among raft nodes before linearized reading' (duration: 135.878956ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:44.594432Z","caller":"traceutil/trace.go:171","msg":"trace[1620321180] linearizableReadLoop","detail":"{readStateIndex:9172; appliedIndex:9171; }","duration":"158.003709ms","start":"2026-04-08T01:35:44.436388Z","end":"2026-04-08T01:35:44.594392Z","steps":["trace[1620321180] 'read index received' (duration: 118.528742ms)","trace[1620321180] 'applied index is now lower than readState.Index' (duration: 39.472757ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:35:44.594717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.277564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:35:44.594856Z","caller":"traceutil/trace.go:171","msg":"trace[491358776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:8854; }","duration":"158.511598ms","start":"2026-04-08T01:35:44.436313Z","end":"2026-04-08T01:35:44.594825Z","steps":["trace[491358776] 'agreement among raft nodes before linearized reading' (duration: 158.221403ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:54.812278Z","caller":"traceutil/trace.go:171","msg":"trace[1729141671] linearizableReadLoop","detail":"{readStateIndex:9280; appliedIndex:9279; }","duration":"112.314278ms","start":"2026-04-08T01:35:54.699937Z","end":"2026-04-08T01:35:54.812252Z","steps":["trace[1729141671] 'read index received' (duration: 71.002305ms)","trace[1729141671] 'applied index is now lower than readState.Index' (duration: 41.310853ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:35:54.81243Z","caller":"traceutil/trace.go:171","msg":"trace[1260747098] transaction","detail":"{read_only:false; response_revision:8957; number_of_response:1; }","duration":"118.46916ms","start":"2026-04-08T01:35:54.693945Z","end":"2026-04-08T01:35:54.812414Z","steps":["trace[1260747098] 'process raft request' (duration: 77.015415ms)","trace[1260747098] 'compare' (duration: 40.997196ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:35:54.813102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.129725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228779"} {"level":"info","ts":"2026-04-08T01:35:54.813197Z","caller":"traceutil/trace.go:171","msg":"trace[107991077] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8957; }","duration":"113.261538ms","start":"2026-04-08T01:35:54.699911Z","end":"2026-04-08T01:35:54.813173Z","steps":["trace[107991077] 'agreement among raft nodes before linearized reading' (duration: 112.666175ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:36:10.018657Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024d3.wal"} {"level":"info","ts":"2026-04-08T01:37:04.106482Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c187bdee547e8fd1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T01:37:04.112048Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T01:37:04.112208Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T01:38:45.816953Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7943} {"level":"info","ts":"2026-04-08T01:38:45.895673Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7943,"took":"75.830831ms","hash":2936498967,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":28180480,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-08T01:38:45.895785Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2936498967,"revision":7943,"compact-revision":5749} {"level":"info","ts":"2026-04-08T01:41:24.853778Z","caller":"traceutil/trace.go:171","msg":"trace[1006447550] transaction","detail":"{read_only:false; response_revision:11342; number_of_response:1; }","duration":"107.735387ms","start":"2026-04-08T01:41:24.746009Z","end":"2026-04-08T01:41:24.853745Z","steps":["trace[1006447550] 'process raft request' (duration: 106.326389ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:43:45.825979Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10342} {"level":"info","ts":"2026-04-08T01:43:45.905104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10342,"took":"76.72095ms","hash":1941094160,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":22773760,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-08T01:43:45.905169Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1941094160,"revision":10342,"compact-revision":7943}