{"level":"warn","ts":"2026-04-23T16:29:49.361262Z","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-23T16:29:49.361388Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.212:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.212:2380","--initial-cluster=instance=https://199.19.213.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.212: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-23T16:29:49.361493Z","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-23T16:29:49.361506Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.212:2380"]} {"level":"info","ts":"2026-04-23T16:29:49.361533Z","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-23T16:29:49.362396Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"]} {"level":"info","ts":"2026-04-23T16:29:49.3625Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.212: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-23T16:29:49.42864Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"65.8643ms"} {"level":"info","ts":"2026-04-23T16:29:49.539898Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e1ab0380b9290bdc","cluster-id":"a3ed131e36ad6843"} {"level":"info","ts":"2026-04-23T16:29:49.540131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T16:29:49.540257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 0"} {"level":"info","ts":"2026-04-23T16:29:49.540335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e1ab0380b9290bdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T16:29:49.540389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 1"} {"level":"info","ts":"2026-04-23T16:29:49.540553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"} {"level":"warn","ts":"2026-04-23T16:29:49.632466Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T16:29:49.652728Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T16:29:49.666116Z","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-23T16:29:49.673081Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e1ab0380b9290bdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T16:29:49.673429Z","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-23T16:29:49.673526Z","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-23T16:29:49.673564Z","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-23T16:29:49.673472Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e1ab0380b9290bdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T16:29:49.676894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"} {"level":"info","ts":"2026-04-23T16:29:49.677032Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","added-peer-id":"e1ab0380b9290bdc","added-peer-peer-urls":["https://199.19.213.212:2380"]} {"level":"info","ts":"2026-04-23T16:29:49.678429Z","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-23T16:29:49.678703Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.212:2380"} {"level":"info","ts":"2026-04-23T16:29:49.678745Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.212:2380"} {"level":"info","ts":"2026-04-23T16:29:49.679699Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e1ab0380b9290bdc","initial-advertise-peer-urls":["https://199.19.213.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T16:29:49.679739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T16:29:50.450588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T16:29:50.450637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T16:29:50.450655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgPreVoteResp from e1ab0380b9290bdc at term 1"} {"level":"info","ts":"2026-04-23T16:29:50.450801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became candidate at term 2"} {"level":"info","ts":"2026-04-23T16:29:50.45083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgVoteResp from e1ab0380b9290bdc at term 2"} {"level":"info","ts":"2026-04-23T16:29:50.450843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became leader at term 2"} {"level":"info","ts":"2026-04-23T16:29:50.450868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e1ab0380b9290bdc elected leader e1ab0380b9290bdc at term 2"} {"level":"info","ts":"2026-04-23T16:29:50.451991Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T16:29:50.456163Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e1ab0380b9290bdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.212:2379]}","request-path":"/0/members/e1ab0380b9290bdc/attributes","cluster-id":"a3ed131e36ad6843","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T16:29:50.456191Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T16:29:50.456342Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T16:29:50.456912Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T16:29:50.456986Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T16:29:50.459075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T16:29:50.460401Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.212:2379"} {"level":"info","ts":"2026-04-23T16:29:50.463647Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T16:29:50.463798Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T16:29:50.463887Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-23T16:29:52.296038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854731456534965634,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T16:29:52.604158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.264316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-23T16:29:52.604242Z","caller":"traceutil/trace.go:171","msg":"trace[1849344790] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"810.771389ms","start":"2026-04-23T16:29:51.793458Z","end":"2026-04-23T16:29:52.604229Z","steps":["trace[1849344790] 'process raft request' (duration: 551.997517ms)","trace[1849344790] 'compare' (duration: 258.160997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:29:52.604344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.79344Z","time spent":"810.880471ms","remote":"127.0.0.1:54240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T16:29:52.856617Z","caller":"traceutil/trace.go:171","msg":"trace[1734745059] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.059797172s","start":"2026-04-23T16:29:51.796799Z","end":"2026-04-23T16:29:52.856596Z","steps":["trace[1734745059] 'process raft request' (duration: 1.059517559s)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:29:52.856783Z","caller":"traceutil/trace.go:171","msg":"trace[1013010016] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"1.061602573s","start":"2026-04-23T16:29:51.79516Z","end":"2026-04-23T16:29:52.856762Z","steps":["trace[1013010016] 'read index received' (duration: 550.389494ms)","trace[1013010016] 'applied index is now lower than readState.Index' (duration: 511.211679ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:29:52.856802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.796783Z","time spent":"1.059967214s","remote":"127.0.0.1:54328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T16:29:52.857059Z","caller":"traceutil/trace.go:171","msg":"trace[453744703] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.059982577s","start":"2026-04-23T16:29:51.797066Z","end":"2026-04-23T16:29:52.857048Z","steps":["trace[453744703] 'process raft request' (duration: 1.059578821s)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:29:52.856899Z","caller":"traceutil/trace.go:171","msg":"trace[44183608] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.060058452s","start":"2026-04-23T16:29:51.796827Z","end":"2026-04-23T16:29:52.856885Z","steps":["trace[44183608] 'process raft request' (duration: 1.059669058s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.857152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.797056Z","time spent":"1.060045949s","remote":"127.0.0.1:54328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T16:29:52.857298Z","caller":"traceutil/trace.go:171","msg":"trace[369883075] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.042157166s","start":"2026-04-23T16:29:51.81513Z","end":"2026-04-23T16:29:52.857287Z","steps":["trace[369883075] 'process raft request' (duration: 1.041557803s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.857352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.815116Z","time spent":"1.042213976s","remote":"127.0.0.1:32848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T16:29:52.857166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.796816Z","time spent":"1.060306658s","remote":"127.0.0.1:54328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T16:29:52.85743Z","caller":"traceutil/trace.go:171","msg":"trace[1708887034] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.042045365s","start":"2026-04-23T16:29:51.815376Z","end":"2026-04-23T16:29:52.857422Z","steps":["trace[1708887034] 'process raft request' (duration: 1.041349064s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.857476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.815354Z","time spent":"1.042102165s","remote":"127.0.0.1:32928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T16:29:52.857495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.06226963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T16:29:52.857024Z","caller":"traceutil/trace.go:171","msg":"trace[2146325487] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.05999531s","start":"2026-04-23T16:29:51.797019Z","end":"2026-04-23T16:29:52.857014Z","steps":["trace[2146325487] 'process raft request' (duration: 1.059564379s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.857647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.79701Z","time spent":"1.060594622s","remote":"127.0.0.1:54328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T16:29:52.857614Z","caller":"traceutil/trace.go:171","msg":"trace[1549627065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"1.062447984s","start":"2026-04-23T16:29:51.795142Z","end":"2026-04-23T16:29:52.85759Z","steps":["trace[1549627065] 'agreement among raft nodes before linearized reading' (duration: 1.062150267s)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:29:52.856985Z","caller":"traceutil/trace.go:171","msg":"trace[488106487] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.060066453s","start":"2026-04-23T16:29:51.796905Z","end":"2026-04-23T16:29:52.856972Z","steps":["trace[488106487] 'process raft request' (duration: 1.059640733s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.857767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.795117Z","time spent":"1.0625936s","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T16:29:52.857913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.796898Z","time spent":"1.060895189s","remote":"127.0.0.1:54328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T16:29:52.948524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.261032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T16:29:52.948758Z","caller":"traceutil/trace.go:171","msg":"trace[108927109] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:12; }","duration":"254.509388ms","start":"2026-04-23T16:29:52.694237Z","end":"2026-04-23T16:29:52.948746Z","steps":["trace[108927109] 'agreement among raft nodes before linearized reading' (duration: 254.106532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.948537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.518816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T16:29:52.948905Z","caller":"traceutil/trace.go:171","msg":"trace[1100224904] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:12; }","duration":"963.924112ms","start":"2026-04-23T16:29:51.984955Z","end":"2026-04-23T16:29:52.948879Z","steps":["trace[1100224904] 'agreement among raft nodes before linearized reading' (duration: 963.535939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.94898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.984932Z","time spent":"964.030693ms","remote":"127.0.0.1:32942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-04-23T16:29:52.948602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101128999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T16:29:52.949084Z","caller":"traceutil/trace.go:171","msg":"trace[1398104742] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"1.101595987s","start":"2026-04-23T16:29:51.847467Z","end":"2026-04-23T16:29:52.949063Z","steps":["trace[1398104742] 'agreement among raft nodes before linearized reading' (duration: 1.101113406s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.948586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15284671s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T16:29:52.949147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.847423Z","time spent":"1.101709119s","remote":"127.0.0.1:32790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-23T16:29:52.949168Z","caller":"traceutil/trace.go:171","msg":"trace[1427671742] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"1.15343052s","start":"2026-04-23T16:29:51.795702Z","end":"2026-04-23T16:29:52.949132Z","steps":["trace[1427671742] 'agreement among raft nodes before linearized reading' (duration: 1.152828116s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.948645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.785655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T16:29:52.94934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.795694Z","time spent":"1.153631237s","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-04-23T16:29:52.949366Z","caller":"traceutil/trace.go:171","msg":"trace[368363958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"185.512632ms","start":"2026-04-23T16:29:52.763826Z","end":"2026-04-23T16:29:52.949338Z","steps":["trace[368363958] 'agreement among raft nodes before linearized reading' (duration: 184.802369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.94867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.690274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T16:29:52.950035Z","caller":"traceutil/trace.go:171","msg":"trace[1531765032] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:12; }","duration":"255.064053ms","start":"2026-04-23T16:29:52.694944Z","end":"2026-04-23T16:29:52.950008Z","steps":["trace[1531765032] 'agreement among raft nodes before linearized reading' (duration: 253.699586ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:29:52.948679Z","caller":"traceutil/trace.go:171","msg":"trace[1378164287] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"341.047176ms","start":"2026-04-23T16:29:52.607612Z","end":"2026-04-23T16:29:52.94866Z","steps":["trace[1378164287] 'process raft request' (duration: 340.575577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.950306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:52.607594Z","time spent":"342.660909ms","remote":"127.0.0.1:54240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T16:29:52.948605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103384275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T16:29:52.950438Z","caller":"traceutil/trace.go:171","msg":"trace[1151628638] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"1.105244967s","start":"2026-04-23T16:29:51.845183Z","end":"2026-04-23T16:29:52.950428Z","steps":["trace[1151628638] 'agreement among raft nodes before linearized reading' (duration: 1.103322454s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:52.950484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:29:51.845108Z","time spent":"1.105355199s","remote":"127.0.0.1:54188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-23T16:29:55.956339Z","caller":"traceutil/trace.go:171","msg":"trace[948548952] linearizableReadLoop","detail":"{readStateIndex:276; appliedIndex:275; }","duration":"226.277574ms","start":"2026-04-23T16:29:55.730018Z","end":"2026-04-23T16:29:55.956296Z","steps":["trace[948548952] 'read index received' (duration: 210.71319ms)","trace[948548952] 'applied index is now lower than readState.Index' (duration: 15.563013ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:29:55.956475Z","caller":"traceutil/trace.go:171","msg":"trace[45954293] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"253.306522ms","start":"2026-04-23T16:29:55.70309Z","end":"2026-04-23T16:29:55.956397Z","steps":["trace[45954293] 'process raft request' (duration: 237.70024ms)","trace[45954293] 'compare' (duration: 15.262437ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:29:55.956613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.569928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-23T16:29:55.9567Z","caller":"traceutil/trace.go:171","msg":"trace[1676085184] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:266; }","duration":"226.707534ms","start":"2026-04-23T16:29:55.729968Z","end":"2026-04-23T16:29:55.956676Z","steps":["trace[1676085184] 'agreement among raft nodes before linearized reading' (duration: 226.438143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:29:55.956628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.568499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-23T16:29:55.956946Z","caller":"traceutil/trace.go:171","msg":"trace[624251189] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:266; }","duration":"216.877848ms","start":"2026-04-23T16:29:55.740028Z","end":"2026-04-23T16:29:55.956906Z","steps":["trace[624251189] 'agreement among raft nodes before linearized reading' (duration: 216.480923ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:30:17.172765Z","caller":"traceutil/trace.go:171","msg":"trace[678820267] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"375.40669ms","start":"2026-04-23T16:30:16.797301Z","end":"2026-04-23T16:30:17.172708Z","steps":["trace[678820267] 'process raft request' (duration: 326.612363ms)","trace[678820267] 'compare' (duration: 48.3152ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:30:17.172838Z","caller":"traceutil/trace.go:171","msg":"trace[536911216] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"333.149196ms","start":"2026-04-23T16:30:16.839655Z","end":"2026-04-23T16:30:17.172805Z","steps":["trace[536911216] 'process raft request' (duration: 333.053088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:17.173037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:16.839636Z","time spent":"333.318406ms","remote":"127.0.0.1:60952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T16:30:17.173083Z","caller":"traceutil/trace.go:171","msg":"trace[525479032] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"372.496215ms","start":"2026-04-23T16:30:16.800539Z","end":"2026-04-23T16:30:17.173036Z","steps":["trace[525479032] 'process raft request' (duration: 372.023349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:17.173359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:16.797279Z","time spent":"375.648164ms","remote":"127.0.0.1:60952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T16:30:17.173464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:16.80052Z","time spent":"372.648774ms","remote":"127.0.0.1:60952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T16:30:17.35881Z","caller":"traceutil/trace.go:171","msg":"trace[20436558] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"113.519473ms","start":"2026-04-23T16:30:17.245267Z","end":"2026-04-23T16:30:17.358786Z","steps":["trace[20436558] 'process raft request' (duration: 113.422135ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:30:17.358836Z","caller":"traceutil/trace.go:171","msg":"trace[1484855966] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"113.622372ms","start":"2026-04-23T16:30:17.245175Z","end":"2026-04-23T16:30:17.358798Z","steps":["trace[1484855966] 'process raft request' (duration: 89.735553ms)","trace[1484855966] 'compare' (duration: 23.607848ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:30:21.515197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.084347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T16:30:21.515281Z","caller":"traceutil/trace.go:171","msg":"trace[23946250] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"160.206668ms","start":"2026-04-23T16:30:21.355056Z","end":"2026-04-23T16:30:21.515263Z","steps":["trace[23946250] 'range keys from in-memory index tree' (duration: 159.99572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:23.859495Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854731456534966702,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T16:30:23.940514Z","caller":"traceutil/trace.go:171","msg":"trace[143816948] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"694.08845ms","start":"2026-04-23T16:30:23.246393Z","end":"2026-04-23T16:30:23.940482Z","steps":["trace[143816948] 'process raft request' (duration: 693.369319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:23.94073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:23.246361Z","time spent":"694.243768ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T16:30:23.962402Z","caller":"traceutil/trace.go:171","msg":"trace[254152182] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:585; }","duration":"603.991241ms","start":"2026-04-23T16:30:23.358391Z","end":"2026-04-23T16:30:23.962383Z","steps":["trace[254152182] 'read index received' (duration: 581.282725ms)","trace[254152182] 'applied index is now lower than readState.Index' (duration: 22.707756ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:30:23.962493Z","caller":"traceutil/trace.go:171","msg":"trace[753808257] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"232.635862ms","start":"2026-04-23T16:30:23.729849Z","end":"2026-04-23T16:30:23.962485Z","steps":["trace[753808257] 'process raft request' (duration: 232.421153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:23.962698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.847543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sbcxb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-23T16:30:23.962756Z","caller":"traceutil/trace.go:171","msg":"trace[790229340] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sbcxb; range_end:; response_count:1; response_revision:569; }","duration":"564.950362ms","start":"2026-04-23T16:30:23.39779Z","end":"2026-04-23T16:30:23.96274Z","steps":["trace[790229340] 'agreement among raft nodes before linearized reading' (duration: 564.798594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:23.96277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.377261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T16:30:23.962784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:23.39777Z","time spent":"565.007224ms","remote":"127.0.0.1:32860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-sbcxb\" "} {"level":"info","ts":"2026-04-23T16:30:23.962801Z","caller":"traceutil/trace.go:171","msg":"trace[421121820] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"604.459416ms","start":"2026-04-23T16:30:23.358331Z","end":"2026-04-23T16:30:23.96279Z","steps":["trace[421121820] 'agreement among raft nodes before linearized reading' (duration: 604.406316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:23.962823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:23.358261Z","time spent":"604.556334ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T16:30:23.962932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.952043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.212\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T16:30:23.96299Z","caller":"traceutil/trace.go:171","msg":"trace[364018021] range","detail":"{range_begin:/registry/masterleases/199.19.213.212; range_end:; response_count:1; response_revision:569; }","duration":"199.056622ms","start":"2026-04-23T16:30:23.763916Z","end":"2026-04-23T16:30:23.962972Z","steps":["trace[364018021] 'agreement among raft nodes before linearized reading' (duration: 198.923808ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:30:24.243931Z","caller":"traceutil/trace.go:171","msg":"trace[1930973592] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"276.519836ms","start":"2026-04-23T16:30:23.967379Z","end":"2026-04-23T16:30:24.243899Z","steps":["trace[1930973592] 'read index received' (duration: 212.333946ms)","trace[1930973592] 'applied index is now lower than readState.Index' (duration: 64.18418ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:30:24.244136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.736796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T16:30:24.244198Z","caller":"traceutil/trace.go:171","msg":"trace[1190372192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"276.829673ms","start":"2026-04-23T16:30:23.967353Z","end":"2026-04-23T16:30:24.244183Z","steps":["trace[1190372192] 'agreement among raft nodes before linearized reading' (duration: 276.692508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:24.251017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.350163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-23T16:30:24.251038Z","caller":"traceutil/trace.go:171","msg":"trace[1228264389] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"249.883473ms","start":"2026-04-23T16:30:24.001115Z","end":"2026-04-23T16:30:24.250998Z","steps":["trace[1228264389] 'process raft request' (duration: 249.766501ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:30:24.251091Z","caller":"traceutil/trace.go:171","msg":"trace[1236367665] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"126.428247ms","start":"2026-04-23T16:30:24.124649Z","end":"2026-04-23T16:30:24.251078Z","steps":["trace[1236367665] 'agreement among raft nodes before linearized reading' (duration: 126.264587ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:30:24.25114Z","caller":"traceutil/trace.go:171","msg":"trace[1402310696] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"274.781579ms","start":"2026-04-23T16:30:23.976338Z","end":"2026-04-23T16:30:24.251119Z","steps":["trace[1402310696] 'process raft request' (duration: 274.429915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:24.928874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.674091ms","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-23T16:30:24.928974Z","caller":"traceutil/trace.go:171","msg":"trace[1795586075] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"431.818447ms","start":"2026-04-23T16:30:24.497132Z","end":"2026-04-23T16:30:24.928951Z","steps":["trace[1795586075] 'range keys from in-memory index tree' (duration: 431.473625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:24.929032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:24.497118Z","time spent":"431.900742ms","remote":"127.0.0.1:32942","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":"warn","ts":"2026-04-23T16:30:24.929394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.903624ms","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-23T16:30:24.929466Z","caller":"traceutil/trace.go:171","msg":"trace[1594603825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"514.022715ms","start":"2026-04-23T16:30:24.415429Z","end":"2026-04-23T16:30:24.929451Z","steps":["trace[1594603825] 'range keys from in-memory index tree' (duration: 513.753536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:24.929506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:30:24.41541Z","time spent":"514.083887ms","remote":"127.0.0.1:32942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-23T16:30:24.931494Z","caller":"traceutil/trace.go:171","msg":"trace[418911574] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"229.633838ms","start":"2026-04-23T16:30:24.701845Z","end":"2026-04-23T16:30:24.931478Z","steps":["trace[418911574] 'process raft request' (duration: 228.761619ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:30:28.124304Z","caller":"traceutil/trace.go:171","msg":"trace[1516077639] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"107.56881ms","start":"2026-04-23T16:30:28.01671Z","end":"2026-04-23T16:30:28.124279Z","steps":["trace[1516077639] 'process raft request' (duration: 107.40659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:41.240539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.910884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-23T16:30:41.240636Z","caller":"traceutil/trace.go:171","msg":"trace[1245870593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"220.042028ms","start":"2026-04-23T16:30:41.020575Z","end":"2026-04-23T16:30:41.240617Z","steps":["trace[1245870593] 'range keys from in-memory index tree' (duration: 219.712579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:30:41.24072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.876361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T16:30:41.240834Z","caller":"traceutil/trace.go:171","msg":"trace[2125051410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:739; }","duration":"223.029019ms","start":"2026-04-23T16:30:41.017771Z","end":"2026-04-23T16:30:41.2408Z","steps":["trace[2125051410] 'range keys from in-memory index tree' (duration: 222.639778ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:31:13.584796Z","caller":"traceutil/trace.go:171","msg":"trace[749001209] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"105.080184ms","start":"2026-04-23T16:31:13.479696Z","end":"2026-04-23T16:31:13.584776Z","steps":["trace[749001209] 'read index received' (duration: 104.94558ms)","trace[749001209] 'applied index is now lower than readState.Index' (duration: 133.684µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:31:13.584861Z","caller":"traceutil/trace.go:171","msg":"trace[30204825] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"112.765514ms","start":"2026-04-23T16:31:13.472081Z","end":"2026-04-23T16:31:13.584847Z","steps":["trace[30204825] 'process raft request' (duration: 112.57947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:31:13.584948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.237272ms","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-23T16:31:13.584978Z","caller":"traceutil/trace.go:171","msg":"trace[1522377071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:977; }","duration":"105.319537ms","start":"2026-04-23T16:31:13.479651Z","end":"2026-04-23T16:31:13.58497Z","steps":["trace[1522377071] 'agreement among raft nodes before linearized reading' (duration: 105.208237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:32:51.952554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.565293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-04-23T16:32:51.952653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.183468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:118955"} {"level":"info","ts":"2026-04-23T16:32:51.952677Z","caller":"traceutil/trace.go:171","msg":"trace[530579562] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1635; }","duration":"178.721071ms","start":"2026-04-23T16:32:51.77393Z","end":"2026-04-23T16:32:51.952651Z","steps":["trace[530579562] 'range keys from in-memory index tree' (duration: 178.475047ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:32:51.952725Z","caller":"traceutil/trace.go:171","msg":"trace[534788577] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1635; }","duration":"185.294119ms","start":"2026-04-23T16:32:51.767412Z","end":"2026-04-23T16:32:51.952706Z","steps":["trace[534788577] 'range keys from in-memory index tree' (duration: 184.898477ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:32:53.789703Z","caller":"traceutil/trace.go:171","msg":"trace[1036870008] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"102.878075ms","start":"2026-04-23T16:32:53.686805Z","end":"2026-04-23T16:32:53.789683Z","steps":["trace[1036870008] 'process raft request' (duration: 102.752102ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:32:53.78978Z","caller":"traceutil/trace.go:171","msg":"trace[2035373565] transaction","detail":"{read_only:false; response_revision:1648; number_of_response:1; }","duration":"104.451785ms","start":"2026-04-23T16:32:53.685295Z","end":"2026-04-23T16:32:53.789747Z","steps":["trace[2035373565] 'process raft request' (duration: 104.126477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:20.067488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.46699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T16:33:20.067613Z","caller":"traceutil/trace.go:171","msg":"trace[1222315734] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2223; }","duration":"118.642992ms","start":"2026-04-23T16:33:19.948955Z","end":"2026-04-23T16:33:20.067598Z","steps":["trace[1222315734] 'count revisions from in-memory index tree' (duration: 118.340687ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:20.253263Z","caller":"traceutil/trace.go:171","msg":"trace[943824797] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"103.450034ms","start":"2026-04-23T16:33:20.149775Z","end":"2026-04-23T16:33:20.253225Z","steps":["trace[943824797] 'process raft request' (duration: 103.231716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:20.731551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.911454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T16:33:20.73167Z","caller":"traceutil/trace.go:171","msg":"trace[715128363] linearizableReadLoop","detail":"{readStateIndex:2315; appliedIndex:2314; }","duration":"273.288414ms","start":"2026-04-23T16:33:20.458366Z","end":"2026-04-23T16:33:20.731654Z","steps":["trace[715128363] 'read index received' (duration: 31.675µs)","trace[715128363] 'applied index is now lower than readState.Index' (duration: 273.255608ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:33:20.731917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.497877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T16:33:20.731907Z","caller":"traceutil/trace.go:171","msg":"trace[1439870860] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"306.936502ms","start":"2026-04-23T16:33:20.424933Z","end":"2026-04-23T16:33:20.73187Z","steps":["trace[1439870860] 'process raft request' (duration: 30.425991ms)","trace[1439870860] 'compare' (duration: 275.801494ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:33:20.731952Z","caller":"traceutil/trace.go:171","msg":"trace[444559315] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2226; }","duration":"251.581572ms","start":"2026-04-23T16:33:20.480359Z","end":"2026-04-23T16:33:20.731941Z","steps":["trace[444559315] 'agreement among raft nodes before linearized reading' (duration: 251.519221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:20.73212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:20.424899Z","time spent":"307.080068ms","remote":"127.0.0.1:32942","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-23T16:33:20.732211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.800255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-23T16:33:20.7323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.440424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-481f57fa-95ca-48b1-9fcf-4d8199de6cb6\" ","response":"range_response_count:1 size:3737"} {"level":"info","ts":"2026-04-23T16:33:20.732349Z","caller":"traceutil/trace.go:171","msg":"trace[151888830] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-481f57fa-95ca-48b1-9fcf-4d8199de6cb6; range_end:; response_count:1; response_revision:2226; }","duration":"234.519338ms","start":"2026-04-23T16:33:20.497818Z","end":"2026-04-23T16:33:20.732337Z","steps":["trace[151888830] 'agreement among raft nodes before linearized reading' (duration: 234.353009ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:20.732355Z","caller":"traceutil/trace.go:171","msg":"trace[1681560225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2226; }","duration":"273.986158ms","start":"2026-04-23T16:33:20.458337Z","end":"2026-04-23T16:33:20.732324Z","steps":["trace[1681560225] 'agreement among raft nodes before linearized reading' (duration: 273.474917ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:21.160296Z","caller":"traceutil/trace.go:171","msg":"trace[1018113010] linearizableReadLoop","detail":"{readStateIndex:2316; appliedIndex:2315; }","duration":"359.929682ms","start":"2026-04-23T16:33:20.800326Z","end":"2026-04-23T16:33:21.160256Z","steps":["trace[1018113010] 'read index received' (duration: 359.725725ms)","trace[1018113010] 'applied index is now lower than readState.Index' (duration: 203.256µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:33:21.160345Z","caller":"traceutil/trace.go:171","msg":"trace[955924083] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"422.492702ms","start":"2026-04-23T16:33:20.737811Z","end":"2026-04-23T16:33:21.160304Z","steps":["trace[955924083] 'process raft request' (duration: 422.327753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:21.160504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:20.737792Z","time spent":"422.64763ms","remote":"127.0.0.1:32942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T16:33:21.160921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.557214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb24e9a5-c542-4c28-b7d3-23b7c01e1001\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-23T16:33:21.160967Z","caller":"traceutil/trace.go:171","msg":"trace[1353463289] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb24e9a5-c542-4c28-b7d3-23b7c01e1001; range_end:; response_count:1; response_revision:2227; }","duration":"360.634437ms","start":"2026-04-23T16:33:20.800319Z","end":"2026-04-23T16:33:21.160953Z","steps":["trace[1353463289] 'agreement among raft nodes before linearized reading' (duration: 360.064365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:21.161025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:20.80026Z","time spent":"360.754008ms","remote":"127.0.0.1:32860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb24e9a5-c542-4c28-b7d3-23b7c01e1001\" "} {"level":"warn","ts":"2026-04-23T16:33:33.586226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.689713ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T16:33:33.586613Z","caller":"traceutil/trace.go:171","msg":"trace[1671619579] transaction","detail":"{read_only:false; response_revision:2352; number_of_response:1; }","duration":"187.488616ms","start":"2026-04-23T16:33:33.399096Z","end":"2026-04-23T16:33:33.586584Z","steps":["trace[1671619579] 'compare' (duration: 177.501118ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:33.58672Z","caller":"traceutil/trace.go:171","msg":"trace[1812112838] linearizableReadLoop","detail":"{readStateIndex:2443; appliedIndex:2442; }","duration":"167.514053ms","start":"2026-04-23T16:33:33.419179Z","end":"2026-04-23T16:33:33.586694Z","steps":["trace[1812112838] 'read index received' (duration: 56.22µs)","trace[1812112838] 'applied index is now lower than readState.Index' (duration: 167.455353ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:33:33.586903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.72136ms","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-23T16:33:33.586934Z","caller":"traceutil/trace.go:171","msg":"trace[546716039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2352; }","duration":"167.812057ms","start":"2026-04-23T16:33:33.419113Z","end":"2026-04-23T16:33:33.586925Z","steps":["trace[546716039] 'agreement among raft nodes before linearized reading' (duration: 167.674362ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:33.587383Z","caller":"traceutil/trace.go:171","msg":"trace[652057708] transaction","detail":"{read_only:false; response_revision:2353; number_of_response:1; }","duration":"102.165554ms","start":"2026-04-23T16:33:33.485208Z","end":"2026-04-23T16:33:33.587374Z","steps":["trace[652057708] 'process raft request' (duration: 101.901377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:55.688159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.391487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T16:33:55.688304Z","caller":"traceutil/trace.go:171","msg":"trace[2134423614] linearizableReadLoop","detail":"{readStateIndex:2591; appliedIndex:2590; }","duration":"174.544619ms","start":"2026-04-23T16:33:55.513716Z","end":"2026-04-23T16:33:55.688261Z","steps":["trace[2134423614] 'read index received' (duration: 47.870152ms)","trace[2134423614] 'applied index is now lower than readState.Index' (duration: 126.672617ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:33:55.688397Z","caller":"traceutil/trace.go:171","msg":"trace[1535798899] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"178.318045ms","start":"2026-04-23T16:33:55.510031Z","end":"2026-04-23T16:33:55.688349Z","steps":["trace[1535798899] 'process raft request' (duration: 51.633375ms)","trace[1535798899] 'compare' (duration: 126.180249ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:33:55.688596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.872599ms","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-23T16:33:55.68867Z","caller":"traceutil/trace.go:171","msg":"trace[777835192] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2494; }","duration":"174.967146ms","start":"2026-04-23T16:33:55.51368Z","end":"2026-04-23T16:33:55.688647Z","steps":["trace[777835192] 'agreement among raft nodes before linearized reading' (duration: 174.674794ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:55.919371Z","caller":"traceutil/trace.go:171","msg":"trace[1749599064] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"195.703504ms","start":"2026-04-23T16:33:55.723644Z","end":"2026-04-23T16:33:55.919347Z","steps":["trace[1749599064] 'process raft request' (duration: 195.486825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:55.919913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.479483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-23T16:33:55.919969Z","caller":"traceutil/trace.go:171","msg":"trace[872456453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2497; }","duration":"187.580941ms","start":"2026-04-23T16:33:55.732375Z","end":"2026-04-23T16:33:55.919956Z","steps":["trace[872456453] 'agreement among raft nodes before linearized reading' (duration: 187.412851ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:55.920177Z","caller":"traceutil/trace.go:171","msg":"trace[1408100688] linearizableReadLoop","detail":"{readStateIndex:2594; appliedIndex:2591; }","duration":"187.603176ms","start":"2026-04-23T16:33:55.73255Z","end":"2026-04-23T16:33:55.920153Z","steps":["trace[1408100688] 'read index received' (duration: 52.479467ms)","trace[1408100688] 'applied index is now lower than readState.Index' (duration: 134.556807ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:33:55.920258Z","caller":"traceutil/trace.go:171","msg":"trace[1217235421] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"187.550787ms","start":"2026-04-23T16:33:55.732126Z","end":"2026-04-23T16:33:55.919677Z","steps":["trace[1217235421] 'process raft request' (duration: 187.183481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:56.002345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.076583ms","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-23T16:33:56.002425Z","caller":"traceutil/trace.go:171","msg":"trace[361484081] transaction","detail":"{read_only:false; response_revision:2498; number_of_response:1; }","duration":"155.272163ms","start":"2026-04-23T16:33:55.847134Z","end":"2026-04-23T16:33:56.002406Z","steps":["trace[361484081] 'process raft request' (duration: 154.950086ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:56.002453Z","caller":"traceutil/trace.go:171","msg":"trace[870502484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2498; }","duration":"160.195194ms","start":"2026-04-23T16:33:55.842215Z","end":"2026-04-23T16:33:56.00241Z","steps":["trace[870502484] 'agreement among raft nodes before linearized reading' (duration: 160.00749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:56.002346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.05315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T16:33:56.002686Z","caller":"traceutil/trace.go:171","msg":"trace[1371935719] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2498; }","duration":"114.447571ms","start":"2026-04-23T16:33:55.888218Z","end":"2026-04-23T16:33:56.002665Z","steps":["trace[1371935719] 'agreement among raft nodes before linearized reading' (duration: 114.061452ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:33:56.037714Z","caller":"traceutil/trace.go:171","msg":"trace[602322634] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"113.726881ms","start":"2026-04-23T16:33:55.923953Z","end":"2026-04-23T16:33:56.03768Z","steps":["trace[602322634] 'process raft request' (duration: 92.857318ms)","trace[602322634] 'compare' (duration: 20.667367ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:33:57.067128Z","caller":"traceutil/trace.go:171","msg":"trace[35499315] transaction","detail":"{read_only:false; response_revision:2502; number_of_response:1; }","duration":"129.197829ms","start":"2026-04-23T16:33:56.93791Z","end":"2026-04-23T16:33:57.067108Z","steps":["trace[35499315] 'process raft request' (duration: 129.070016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:57.458693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.941926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a9098dbf5d60f3\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-23T16:33:57.458774Z","caller":"traceutil/trace.go:171","msg":"trace[738157071] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a9098dbf5d60f3; range_end:; response_count:1; response_revision:2502; }","duration":"364.060008ms","start":"2026-04-23T16:33:57.09469Z","end":"2026-04-23T16:33:57.45875Z","steps":["trace[738157071] 'range keys from in-memory index tree' (duration: 363.711564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:57.45882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:57.094672Z","time spent":"364.134201ms","remote":"127.0.0.1:60984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":870,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a9098dbf5d60f3\" "} {"level":"info","ts":"2026-04-23T16:33:57.794344Z","caller":"traceutil/trace.go:171","msg":"trace[834945875] linearizableReadLoop","detail":"{readStateIndex:2600; appliedIndex:2599; }","duration":"284.317304ms","start":"2026-04-23T16:33:57.510006Z","end":"2026-04-23T16:33:57.794324Z","steps":["trace[834945875] 'read index received' (duration: 283.883216ms)","trace[834945875] 'applied index is now lower than readState.Index' (duration: 433.298µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:33:57.794439Z","caller":"traceutil/trace.go:171","msg":"trace[720394800] transaction","detail":"{read_only:false; response_revision:2503; number_of_response:1; }","duration":"332.968296ms","start":"2026-04-23T16:33:57.461463Z","end":"2026-04-23T16:33:57.794432Z","steps":["trace[720394800] 'process raft request' (duration: 332.706389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:57.794562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.547985ms","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-23T16:33:57.79461Z","caller":"traceutil/trace.go:171","msg":"trace[1323886413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2503; }","duration":"284.63293ms","start":"2026-04-23T16:33:57.509965Z","end":"2026-04-23T16:33:57.794598Z","steps":["trace[1323886413] 'agreement among raft nodes before linearized reading' (duration: 284.506417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:57.794663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:33:57.461433Z","time spent":"333.028186ms","remote":"127.0.0.1:60984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T16:33:57.822625Z","caller":"traceutil/trace.go:171","msg":"trace[283645102] transaction","detail":"{read_only:false; response_revision:2504; number_of_response:1; }","duration":"243.70171ms","start":"2026-04-23T16:33:57.578862Z","end":"2026-04-23T16:33:57.822563Z","steps":["trace[283645102] 'process raft request' (duration: 243.285546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:57.822733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.439832ms","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-23T16:33:57.822791Z","caller":"traceutil/trace.go:171","msg":"trace[1127815234] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2505; }","duration":"129.54179ms","start":"2026-04-23T16:33:57.693236Z","end":"2026-04-23T16:33:57.822778Z","steps":["trace[1127815234] 'agreement among raft nodes before linearized reading' (duration: 129.389683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:33:57.823442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.263242ms","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-23T16:33:57.823597Z","caller":"traceutil/trace.go:171","msg":"trace[324762077] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2505; }","duration":"119.461898ms","start":"2026-04-23T16:33:57.704078Z","end":"2026-04-23T16:33:57.823539Z","steps":["trace[324762077] 'agreement among raft nodes before linearized reading' (duration: 119.08812ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:35:42.338279Z","caller":"traceutil/trace.go:171","msg":"trace[228426970] transaction","detail":"{read_only:false; response_revision:3134; number_of_response:1; }","duration":"158.885228ms","start":"2026-04-23T16:35:42.179376Z","end":"2026-04-23T16:35:42.338261Z","steps":["trace[228426970] 'process raft request' (duration: 158.778666ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:36:13.724591Z","caller":"traceutil/trace.go:171","msg":"trace[673909836] linearizableReadLoop","detail":"{readStateIndex:3435; appliedIndex:3434; }","duration":"109.193182ms","start":"2026-04-23T16:36:13.615372Z","end":"2026-04-23T16:36:13.724565Z","steps":["trace[673909836] 'read index received' (duration: 108.886391ms)","trace[673909836] 'applied index is now lower than readState.Index' (duration: 305.541µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:36:13.724748Z","caller":"traceutil/trace.go:171","msg":"trace[27836382] transaction","detail":"{read_only:false; response_revision:3309; number_of_response:1; }","duration":"133.000307ms","start":"2026-04-23T16:36:13.591734Z","end":"2026-04-23T16:36:13.724734Z","steps":["trace[27836382] 'process raft request' (duration: 132.60094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:36:13.725202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.791248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T16:36:13.725259Z","caller":"traceutil/trace.go:171","msg":"trace[713247874] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:3309; }","duration":"109.922527ms","start":"2026-04-23T16:36:13.615317Z","end":"2026-04-23T16:36:13.72524Z","steps":["trace[713247874] 'agreement among raft nodes before linearized reading' (duration: 109.784759ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:36:19.007149Z","caller":"traceutil/trace.go:171","msg":"trace[449391599] transaction","detail":"{read_only:false; response_revision:3339; number_of_response:1; }","duration":"115.953359ms","start":"2026-04-23T16:36:18.891159Z","end":"2026-04-23T16:36:19.007112Z","steps":["trace[449391599] 'process raft request' (duration: 115.790072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:38:22.740915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.438792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-031fe10b-2a0a-49e1-a576-ca74782ef74b\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-23T16:38:22.740984Z","caller":"traceutil/trace.go:171","msg":"trace[991006007] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-031fe10b-2a0a-49e1-a576-ca74782ef74b; range_end:; response_count:1; response_revision:4145; }","duration":"136.591437ms","start":"2026-04-23T16:38:22.604379Z","end":"2026-04-23T16:38:22.740971Z","steps":["trace[991006007] 'range keys from in-memory index tree' (duration: 136.243716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:38:35.074395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.172209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-23T16:38:35.074469Z","caller":"traceutil/trace.go:171","msg":"trace[1700108052] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4242; }","duration":"316.286962ms","start":"2026-04-23T16:38:34.75816Z","end":"2026-04-23T16:38:35.074447Z","steps":["trace[1700108052] 'range keys from in-memory index tree' (duration: 316.028545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:38:35.074493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:38:34.758139Z","time spent":"316.349305ms","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-23T16:38:35.115343Z","caller":"traceutil/trace.go:171","msg":"trace[1193214053] transaction","detail":"{read_only:false; response_revision:4243; number_of_response:1; }","duration":"118.560878ms","start":"2026-04-23T16:38:34.996768Z","end":"2026-04-23T16:38:35.115329Z","steps":["trace[1193214053] 'process raft request' (duration: 118.331771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:38:35.1155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.413854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T16:38:35.115542Z","caller":"traceutil/trace.go:171","msg":"trace[711803215] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:0; response_revision:4243; }","duration":"111.502077ms","start":"2026-04-23T16:38:35.004029Z","end":"2026-04-23T16:38:35.115532Z","steps":["trace[711803215] 'agreement among raft nodes before linearized reading' (duration: 111.417654ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:38:35.115287Z","caller":"traceutil/trace.go:171","msg":"trace[971126110] linearizableReadLoop","detail":"{readStateIndex:4403; appliedIndex:4402; }","duration":"111.183507ms","start":"2026-04-23T16:38:35.004075Z","end":"2026-04-23T16:38:35.115259Z","steps":["trace[971126110] 'read index received' (duration: 110.972311ms)","trace[971126110] 'applied index is now lower than readState.Index' (duration: 210.126µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:38:35.371738Z","caller":"traceutil/trace.go:171","msg":"trace[1022784579] transaction","detail":"{read_only:false; response_revision:4244; number_of_response:1; }","duration":"349.824689ms","start":"2026-04-23T16:38:35.021875Z","end":"2026-04-23T16:38:35.3717Z","steps":["trace[1022784579] 'process raft request' (duration: 320.82938ms)","trace[1022784579] 'compare' (duration: 28.38366ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T16:38:35.371985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.982741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-031fe10b-2a0a-49e1-a576-ca74782ef74b\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-23T16:38:35.372063Z","caller":"traceutil/trace.go:171","msg":"trace[1420364346] range","detail":"{range_begin:/registry/persistentvolumes/pvc-031fe10b-2a0a-49e1-a576-ca74782ef74b; range_end:; response_count:1; response_revision:4246; }","duration":"295.116875ms","start":"2026-04-23T16:38:35.07693Z","end":"2026-04-23T16:38:35.372047Z","steps":["trace[1420364346] 'agreement among raft nodes before linearized reading' (duration: 294.884888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:38:35.371935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:38:35.021846Z","time spent":"350.001905ms","remote":"127.0.0.1:32942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T16:38:35.371764Z","caller":"traceutil/trace.go:171","msg":"trace[2006532557] linearizableReadLoop","detail":"{readStateIndex:4406; appliedIndex:4403; }","duration":"256.114331ms","start":"2026-04-23T16:38:35.115621Z","end":"2026-04-23T16:38:35.371735Z","steps":["trace[2006532557] 'read index received' (duration: 227.098741ms)","trace[2006532557] 'applied index is now lower than readState.Index' (duration: 29.01418ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:38:35.371766Z","caller":"traceutil/trace.go:171","msg":"trace[348547889] transaction","detail":"{read_only:false; response_revision:4245; number_of_response:1; }","duration":"344.896085ms","start":"2026-04-23T16:38:35.02685Z","end":"2026-04-23T16:38:35.371746Z","steps":["trace[348547889] 'process raft request' (duration: 344.74049ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:38:35.372288Z","caller":"traceutil/trace.go:171","msg":"trace[1093755694] transaction","detail":"{read_only:false; response_revision:4246; number_of_response:1; }","duration":"334.533171ms","start":"2026-04-23T16:38:35.037741Z","end":"2026-04-23T16:38:35.372274Z","steps":["trace[1093755694] 'process raft request' (duration: 333.935022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:38:35.372607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:38:35.026824Z","time spent":"345.712532ms","remote":"127.0.0.1:32942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T16:38:35.372679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T16:38:35.037713Z","time spent":"334.903043ms","remote":"127.0.0.1:32942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T16:38:35.389812Z","caller":"traceutil/trace.go:171","msg":"trace[1664666330] transaction","detail":"{read_only:false; response_revision:4247; number_of_response:1; }","duration":"268.638774ms","start":"2026-04-23T16:38:35.121147Z","end":"2026-04-23T16:38:35.389786Z","steps":["trace[1664666330] 'process raft request' (duration: 268.394247ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:38:35.542339Z","caller":"traceutil/trace.go:171","msg":"trace[540188477] transaction","detail":"{read_only:false; response_revision:4250; number_of_response:1; }","duration":"105.801737ms","start":"2026-04-23T16:38:35.436505Z","end":"2026-04-23T16:38:35.542307Z","steps":["trace[540188477] 'process raft request' (duration: 53.873749ms)","trace[540188477] 'compare' (duration: 51.711191ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:38:35.762854Z","caller":"traceutil/trace.go:171","msg":"trace[1387165011] transaction","detail":"{read_only:false; response_revision:4253; number_of_response:1; }","duration":"125.722383ms","start":"2026-04-23T16:38:35.637101Z","end":"2026-04-23T16:38:35.762823Z","steps":["trace[1387165011] 'process raft request' (duration: 37.319181ms)","trace[1387165011] 'compare' (duration: 88.142114ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:39:09.829759Z","caller":"traceutil/trace.go:171","msg":"trace[99777290] linearizableReadLoop","detail":"{readStateIndex:4723; appliedIndex:4722; }","duration":"243.47202ms","start":"2026-04-23T16:39:09.586261Z","end":"2026-04-23T16:39:09.829733Z","steps":["trace[99777290] 'read index received' (duration: 235.906464ms)","trace[99777290] 'applied index is now lower than readState.Index' (duration: 7.563906ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:39:09.829796Z","caller":"traceutil/trace.go:171","msg":"trace[316037828] transaction","detail":"{read_only:false; response_revision:4555; number_of_response:1; }","duration":"260.752821ms","start":"2026-04-23T16:39:09.569017Z","end":"2026-04-23T16:39:09.82977Z","steps":["trace[316037828] 'process raft request' (duration: 253.267818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:39:09.830021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.733868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-23T16:39:09.830093Z","caller":"traceutil/trace.go:171","msg":"trace[559006835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4555; }","duration":"243.856801ms","start":"2026-04-23T16:39:09.586219Z","end":"2026-04-23T16:39:09.830076Z","steps":["trace[559006835] 'agreement among raft nodes before linearized reading' (duration: 243.621205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:39:09.830236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.803389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T16:39:09.830274Z","caller":"traceutil/trace.go:171","msg":"trace[327158818] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4555; }","duration":"180.877472ms","start":"2026-04-23T16:39:09.649386Z","end":"2026-04-23T16:39:09.830264Z","steps":["trace[327158818] 'agreement among raft nodes before linearized reading' (duration: 180.81332ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:39:09.953986Z","caller":"traceutil/trace.go:171","msg":"trace[2129146434] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"119.371752ms","start":"2026-04-23T16:39:09.834582Z","end":"2026-04-23T16:39:09.953953Z","steps":["trace[2129146434] 'process raft request' (duration: 108.494143ms)","trace[2129146434] 'compare' (duration: 10.650272ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:39:09.954213Z","caller":"traceutil/trace.go:171","msg":"trace[372966066] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"119.607358ms","start":"2026-04-23T16:39:09.834582Z","end":"2026-04-23T16:39:09.954189Z","steps":["trace[372966066] 'process raft request' (duration: 119.31206ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:39:50.486938Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2810} {"level":"info","ts":"2026-04-23T16:39:50.552898Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2810,"took":"64.877433ms","hash":3129357554,"current-db-size-bytes":44359680,"current-db-size":"44 MB","current-db-size-in-use-bytes":20140032,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-23T16:39:50.552951Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3129357554,"revision":2810,"compact-revision":-1} {"level":"info","ts":"2026-04-23T16:40:18.889918Z","caller":"traceutil/trace.go:171","msg":"trace[1635867433] linearizableReadLoop","detail":"{readStateIndex:5756; appliedIndex:5755; }","duration":"118.990094ms","start":"2026-04-23T16:40:18.770895Z","end":"2026-04-23T16:40:18.889885Z","steps":["trace[1635867433] 'read index received' (duration: 118.636606ms)","trace[1635867433] 'applied index is now lower than readState.Index' (duration: 351.888µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:40:18.89036Z","caller":"traceutil/trace.go:171","msg":"trace[1707224186] transaction","detail":"{read_only:false; response_revision:5554; number_of_response:1; }","duration":"121.125946ms","start":"2026-04-23T16:40:18.769219Z","end":"2026-04-23T16:40:18.890345Z","steps":["trace[1707224186] 'process raft request' (duration: 120.46137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:40:18.891005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.064511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:46779"} {"level":"info","ts":"2026-04-23T16:40:18.891149Z","caller":"traceutil/trace.go:171","msg":"trace[1151008058] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5554; }","duration":"120.282745ms","start":"2026-04-23T16:40:18.770848Z","end":"2026-04-23T16:40:18.891131Z","steps":["trace[1151008058] 'agreement among raft nodes before linearized reading' (duration: 119.844505ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:40:23.270439Z","caller":"traceutil/trace.go:171","msg":"trace[1528859532] transaction","detail":"{read_only:false; response_revision:5678; number_of_response:1; }","duration":"105.617725ms","start":"2026-04-23T16:40:23.164781Z","end":"2026-04-23T16:40:23.270399Z","steps":["trace[1528859532] 'process raft request' (duration: 47.709844ms)","trace[1528859532] 'compare' (duration: 57.570603ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:40:24.221074Z","caller":"traceutil/trace.go:171","msg":"trace[1432701452] transaction","detail":"{read_only:false; response_revision:5697; number_of_response:1; }","duration":"152.117223ms","start":"2026-04-23T16:40:24.068931Z","end":"2026-04-23T16:40:24.221049Z","steps":["trace[1432701452] 'process raft request' (duration: 136.497925ms)","trace[1432701452] 'compare' (duration: 15.481645ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:40:24.225095Z","caller":"traceutil/trace.go:171","msg":"trace[1080084677] transaction","detail":"{read_only:false; response_revision:5698; number_of_response:1; }","duration":"115.751025ms","start":"2026-04-23T16:40:24.109315Z","end":"2026-04-23T16:40:24.225066Z","steps":["trace[1080084677] 'process raft request' (duration: 115.601121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:40:28.665387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.923544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T16:40:28.665525Z","caller":"traceutil/trace.go:171","msg":"trace[412512391] transaction","detail":"{read_only:false; response_revision:5745; number_of_response:1; }","duration":"187.573819ms","start":"2026-04-23T16:40:28.477927Z","end":"2026-04-23T16:40:28.665501Z","steps":["trace[412512391] 'process raft request' (duration: 17.456949ms)","trace[412512391] 'compare' (duration: 169.776831ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:40:28.673791Z","caller":"traceutil/trace.go:171","msg":"trace[769888402] transaction","detail":"{read_only:false; response_revision:5746; number_of_response:1; }","duration":"181.226785ms","start":"2026-04-23T16:40:28.492539Z","end":"2026-04-23T16:40:28.673765Z","steps":["trace[769888402] 'process raft request' (duration: 181.073132ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:40:28.674188Z","caller":"traceutil/trace.go:171","msg":"trace[923610258] linearizableReadLoop","detail":"{readStateIndex:5956; appliedIndex:5952; }","duration":"172.912057ms","start":"2026-04-23T16:40:28.501247Z","end":"2026-04-23T16:40:28.674159Z","steps":["trace[923610258] 'read index received' (duration: 172.324143ms)","trace[923610258] 'applied index is now lower than readState.Index' (duration: 586.604µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T16:40:28.674266Z","caller":"traceutil/trace.go:171","msg":"trace[430617206] transaction","detail":"{read_only:false; response_revision:5749; number_of_response:1; }","duration":"180.880938ms","start":"2026-04-23T16:40:28.493379Z","end":"2026-04-23T16:40:28.67426Z","steps":["trace[430617206] 'process raft request' (duration: 180.711034ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:40:28.674224Z","caller":"traceutil/trace.go:171","msg":"trace[1569061159] transaction","detail":"{read_only:false; response_revision:5748; number_of_response:1; }","duration":"181.089523ms","start":"2026-04-23T16:40:28.493068Z","end":"2026-04-23T16:40:28.674157Z","steps":["trace[1569061159] 'process raft request' (duration: 180.910749ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:40:28.674188Z","caller":"traceutil/trace.go:171","msg":"trace[388338050] transaction","detail":"{read_only:false; response_revision:5747; number_of_response:1; }","duration":"181.442132ms","start":"2026-04-23T16:40:28.492687Z","end":"2026-04-23T16:40:28.674129Z","steps":["trace[388338050] 'process raft request' (duration: 181.028721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:40:28.674432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.546915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-23T16:40:28.674473Z","caller":"traceutil/trace.go:171","msg":"trace[302261676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5749; }","duration":"121.625128ms","start":"2026-04-23T16:40:28.552836Z","end":"2026-04-23T16:40:28.674461Z","steps":["trace[302261676] 'agreement among raft nodes before linearized reading' (duration: 121.483834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T16:40:28.674605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.854638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-23T16:40:28.674597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.258575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-23T16:40:28.67463Z","caller":"traceutil/trace.go:171","msg":"trace[650302204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5749; }","duration":"120.93304ms","start":"2026-04-23T16:40:28.553691Z","end":"2026-04-23T16:40:28.674624Z","steps":["trace[650302204] 'agreement among raft nodes before linearized reading' (duration: 120.787897ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T16:40:28.674698Z","caller":"traceutil/trace.go:171","msg":"trace[78766448] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5749; }","duration":"173.403069ms","start":"2026-04-23T16:40:28.501236Z","end":"2026-04-23T16:40:28.674639Z","steps":["trace[78766448] 'agreement among raft nodes before linearized reading' (duration: 173.02497ms)"],"step_count":1}