{"level":"warn","ts":"2026-07-10T21:20:32.414787Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-10T21:20:32.414872Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.250: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.250:2380","--initial-cluster=instance=https://199.19.213.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.250: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-07-10T21:20:32.414941Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-10T21:20:32.414955Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.250:2380"]} {"level":"info","ts":"2026-07-10T21:20:32.414973Z","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-07-10T21:20:32.415589Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"]} {"level":"info","ts":"2026-07-10T21:20:32.41567Z","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.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.250: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-07-10T21:20:32.813305Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"397.416596ms"} {"level":"warn","ts":"2026-07-10T21:20:33.89611Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.080993455s","expected-duration":"1s"} {"level":"info","ts":"2026-07-10T21:20:34.163247Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1918dd9317ae83a2","cluster-id":"1b9b645507bfe47a"} {"level":"info","ts":"2026-07-10T21:20:34.163413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=()"} {"level":"info","ts":"2026-07-10T21:20:34.163452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 0"} {"level":"info","ts":"2026-07-10T21:20:34.163472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1918dd9317ae83a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-10T21:20:34.163565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 1"} {"level":"info","ts":"2026-07-10T21:20:34.163639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"} {"level":"warn","ts":"2026-07-10T21:20:34.415777Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-10T21:20:34.418688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-10T21:20:34.420492Z","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-07-10T21:20:34.424115Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1918dd9317ae83a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-10T21:20:34.424313Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1918dd9317ae83a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-10T21:20:34.4245Z","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-07-10T21:20:34.424568Z","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-07-10T21:20:34.42458Z","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-07-10T21:20:34.426457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"} {"level":"info","ts":"2026-07-10T21:20:34.426564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","added-peer-id":"1918dd9317ae83a2","added-peer-peer-urls":["https://199.19.213.250:2380"]} {"level":"info","ts":"2026-07-10T21:20:34.431446Z","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-07-10T21:20:34.431539Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.250:2380"} {"level":"info","ts":"2026-07-10T21:20:34.431587Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.250:2380"} {"level":"info","ts":"2026-07-10T21:20:34.432735Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-10T21:20:34.432668Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1918dd9317ae83a2","initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-10T21:20:34.906539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 is starting a new election at term 1"} {"level":"info","ts":"2026-07-10T21:20:34.906601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-10T21:20:34.906624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgPreVoteResp from 1918dd9317ae83a2 at term 1"} {"level":"info","ts":"2026-07-10T21:20:34.906643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became candidate at term 2"} {"level":"info","ts":"2026-07-10T21:20:34.906654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgVoteResp from 1918dd9317ae83a2 at term 2"} {"level":"info","ts":"2026-07-10T21:20:34.906669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became leader at term 2"} {"level":"info","ts":"2026-07-10T21:20:34.906687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1918dd9317ae83a2 elected leader 1918dd9317ae83a2 at term 2"} {"level":"info","ts":"2026-07-10T21:20:34.908053Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T21:20:34.909108Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1918dd9317ae83a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.250:2379]}","request-path":"/0/members/1918dd9317ae83a2/attributes","cluster-id":"1b9b645507bfe47a","publish-timeout":"7s"} {"level":"info","ts":"2026-07-10T21:20:34.909117Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-10T21:20:34.909159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-10T21:20:34.909367Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-10T21:20:34.90943Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-10T21:20:34.909818Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T21:20:34.909918Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T21:20:34.909948Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T21:20:34.912435Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.250:2379"} {"level":"info","ts":"2026-07-10T21:20:34.913033Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-10T21:20:36.632122Z","caller":"traceutil/trace.go:171","msg":"trace[1862856535] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"421.508363ms","start":"2026-07-10T21:20:36.210585Z","end":"2026-07-10T21:20:36.632093Z","steps":["trace[1862856535] 'process raft request' (duration: 421.248528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.632803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.210537Z","time spent":"421.703076ms","remote":"127.0.0.1:50256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:20:36.658615Z","caller":"traceutil/trace.go:171","msg":"trace[2046091439] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"375.319153ms","start":"2026-07-10T21:20:36.283245Z","end":"2026-07-10T21:20:36.658564Z","steps":["trace[2046091439] 'process raft request' (duration: 375.212521ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.658652Z","caller":"traceutil/trace.go:171","msg":"trace[1361769809] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"447.992426ms","start":"2026-07-10T21:20:36.210619Z","end":"2026-07-10T21:20:36.658612Z","steps":["trace[1361769809] 'process raft request' (duration: 447.70089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.658781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.28322Z","time spent":"375.482916ms","remote":"127.0.0.1:50700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T21:20:36.658724Z","caller":"traceutil/trace.go:171","msg":"trace[2012132255] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"446.933587ms","start":"2026-07-10T21:20:36.211762Z","end":"2026-07-10T21:20:36.658696Z","steps":["trace[2012132255] 'read index received' (duration: 420.065038ms)","trace[2012132255] 'applied index is now lower than readState.Index' (duration: 26.867559ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:20:36.659033Z","caller":"traceutil/trace.go:171","msg":"trace[848578615] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"374.766024ms","start":"2026-07-10T21:20:36.284147Z","end":"2026-07-10T21:20:36.658913Z","steps":["trace[848578615] 'process raft request' (duration: 374.369107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.658949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.210605Z","time spent":"448.121027ms","remote":"127.0.0.1:50254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:20:36.659159Z","caller":"traceutil/trace.go:171","msg":"trace[1076640615] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"361.436011ms","start":"2026-07-10T21:20:36.297707Z","end":"2026-07-10T21:20:36.659143Z","steps":["trace[1076640615] 'process raft request' (duration: 360.924522ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.659185Z","caller":"traceutil/trace.go:171","msg":"trace[368201772] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"356.240055ms","start":"2026-07-10T21:20:36.30293Z","end":"2026-07-10T21:20:36.65917Z","steps":["trace[368201772] 'process raft request' (duration: 355.732436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.659246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.297688Z","time spent":"361.522072ms","remote":"127.0.0.1:50428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T21:20:36.659186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.284122Z","time spent":"374.992407ms","remote":"127.0.0.1:50700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T21:20:36.659324Z","caller":"traceutil/trace.go:171","msg":"trace[1975987465] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"374.864476ms","start":"2026-07-10T21:20:36.284446Z","end":"2026-07-10T21:20:36.65931Z","steps":["trace[1975987465] 'process raft request' (duration: 374.136153ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.659129Z","caller":"traceutil/trace.go:171","msg":"trace[2007244088] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"374.370356ms","start":"2026-07-10T21:20:36.284351Z","end":"2026-07-10T21:20:36.658722Z","steps":["trace[2007244088] 'process raft request' (duration: 374.190343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.659398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.302916Z","time spent":"356.356097ms","remote":"127.0.0.1:50348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T21:20:36.659472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.284438Z","time spent":"374.959447ms","remote":"127.0.0.1:50700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T21:20:36.659548Z","caller":"traceutil/trace.go:171","msg":"trace[1592138174] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"375.005927ms","start":"2026-07-10T21:20:36.284531Z","end":"2026-07-10T21:20:36.659537Z","steps":["trace[1592138174] 'process raft request' (duration: 374.071533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.660372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.28452Z","time spent":"375.810611ms","remote":"127.0.0.1:50700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T21:20:36.659641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.133558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-10T21:20:36.660463Z","caller":"traceutil/trace.go:171","msg":"trace[1475205775] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"401.065522ms","start":"2026-07-10T21:20:36.259385Z","end":"2026-07-10T21:20:36.660451Z","steps":["trace[1475205775] 'agreement among raft nodes before linearized reading' (duration: 400.143006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.660498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.259364Z","time spent":"401.125603ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-10T21:20:36.65963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.793812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-07-10T21:20:36.660754Z","caller":"traceutil/trace.go:171","msg":"trace[484356262] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"448.979201ms","start":"2026-07-10T21:20:36.211748Z","end":"2026-07-10T21:20:36.660727Z","steps":["trace[484356262] 'agreement among raft nodes before linearized reading' (duration: 447.709351ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.660806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.21174Z","time spent":"449.055054ms","remote":"127.0.0.1:50348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-10T21:20:36.658932Z","caller":"traceutil/trace.go:171","msg":"trace[948544388] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"375.427695ms","start":"2026-07-10T21:20:36.283457Z","end":"2026-07-10T21:20:36.658885Z","steps":["trace[948544388] 'process raft request' (duration: 375.033289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.659718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.02875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-10T21:20:36.661371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.284338Z","time spent":"375.575887ms","remote":"127.0.0.1:50700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T21:20:36.661478Z","caller":"traceutil/trace.go:171","msg":"trace[483701232] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"318.862401ms","start":"2026-07-10T21:20:36.342596Z","end":"2026-07-10T21:20:36.661458Z","steps":["trace[483701232] 'agreement among raft nodes before linearized reading' (duration: 317.02978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.661592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.342573Z","time spent":"319.004243ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-10T21:20:36.659747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.300649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.250\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-10T21:20:36.659786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.9046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-10T21:20:36.659796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.562617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-10T21:20:36.659787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.85985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-10T21:20:36.659814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.578744ms","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-07-10T21:20:36.661393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.283442Z","time spent":"377.899136ms","remote":"127.0.0.1:50630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T21:20:36.661898Z","caller":"traceutil/trace.go:171","msg":"trace[1921724329] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"371.659072ms","start":"2026-07-10T21:20:36.290224Z","end":"2026-07-10T21:20:36.661883Z","steps":["trace[1921724329] 'agreement among raft nodes before linearized reading' (duration: 369.512146ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.661904Z","caller":"traceutil/trace.go:171","msg":"trace[1933082975] range","detail":"{range_begin:/registry/masterleases/199.19.213.250; range_end:; response_count:0; response_revision:11; }","duration":"381.479236ms","start":"2026-07-10T21:20:36.280407Z","end":"2026-07-10T21:20:36.661886Z","steps":["trace[1933082975] 'agreement among raft nodes before linearized reading' (duration: 379.31599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.661956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.29021Z","time spent":"371.733243ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-10T21:20:36.661952Z","caller":"traceutil/trace.go:171","msg":"trace[1098980427] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"309.114908ms","start":"2026-07-10T21:20:36.35282Z","end":"2026-07-10T21:20:36.661935Z","steps":["trace[1098980427] 'agreement among raft nodes before linearized reading' (duration: 306.909891ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.661929Z","caller":"traceutil/trace.go:171","msg":"trace[1902297196] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"309.036556ms","start":"2026-07-10T21:20:36.352878Z","end":"2026-07-10T21:20:36.661915Z","steps":["trace[1902297196] 'agreement among raft nodes before linearized reading' (duration: 306.759718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.662042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.352804Z","time spent":"309.190329ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-10T21:20:36.661965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.280372Z","time spent":"381.578577ms","remote":"127.0.0.1:50228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.19.213.250\" "} {"level":"warn","ts":"2026-07-10T21:20:36.662116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.352831Z","time spent":"309.23475ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-10T21:20:36.662311Z","caller":"traceutil/trace.go:171","msg":"trace[1823090326] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"379.093706ms","start":"2026-07-10T21:20:36.283199Z","end":"2026-07-10T21:20:36.662293Z","steps":["trace[1823090326] 'agreement among raft nodes before linearized reading' (duration: 376.468582ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.663467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:20:36.283189Z","time spent":"380.261065ms","remote":"127.0.0.1:50274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-07-10T21:20:36.907274Z","caller":"traceutil/trace.go:171","msg":"trace[614245652] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:24; }","duration":"177.899519ms","start":"2026-07-10T21:20:36.729329Z","end":"2026-07-10T21:20:36.907229Z","steps":["trace[614245652] 'read index received' (duration: 96.641673ms)","trace[614245652] 'applied index is now lower than readState.Index' (duration: 81.256546ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:20:36.907354Z","caller":"traceutil/trace.go:171","msg":"trace[1953730928] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"230.867413ms","start":"2026-07-10T21:20:36.676444Z","end":"2026-07-10T21:20:36.907311Z","steps":["trace[1953730928] 'process raft request' (duration: 149.360733ms)","trace[1953730928] 'compare' (duration: 81.291077ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:20:36.907621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.701913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-6qk8w\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-07-10T21:20:36.907702Z","caller":"traceutil/trace.go:171","msg":"trace[935343973] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-6qk8w; range_end:; response_count:1; response_revision:21; }","duration":"238.851446ms","start":"2026-07-10T21:20:36.668834Z","end":"2026-07-10T21:20:36.907685Z","steps":["trace[935343973] 'agreement among raft nodes before linearized reading' (duration: 238.570101ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.90772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.698296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-10T21:20:36.907866Z","caller":"traceutil/trace.go:171","msg":"trace[1112371883] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"183.892529ms","start":"2026-07-10T21:20:36.723951Z","end":"2026-07-10T21:20:36.907844Z","steps":["trace[1112371883] 'agreement among raft nodes before linearized reading' (duration: 183.39302ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.914739Z","caller":"traceutil/trace.go:171","msg":"trace[1969365762] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"180.243128ms","start":"2026-07-10T21:20:36.734477Z","end":"2026-07-10T21:20:36.91472Z","steps":["trace[1969365762] 'process raft request' (duration: 179.998964ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.91482Z","caller":"traceutil/trace.go:171","msg":"trace[689935241] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"178.495068ms","start":"2026-07-10T21:20:36.736273Z","end":"2026-07-10T21:20:36.914768Z","steps":["trace[689935241] 'process raft request' (duration: 178.413418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.914833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.613224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-10T21:20:36.91485Z","caller":"traceutil/trace.go:171","msg":"trace[491368765] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"179.926983ms","start":"2026-07-10T21:20:36.734889Z","end":"2026-07-10T21:20:36.914816Z","steps":["trace[491368765] 'process raft request' (duration: 179.727129ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.914906Z","caller":"traceutil/trace.go:171","msg":"trace[393498698] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"184.02694ms","start":"2026-07-10T21:20:36.730861Z","end":"2026-07-10T21:20:36.914888Z","steps":["trace[393498698] 'agreement among raft nodes before linearized reading' (duration: 183.864938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.91492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.204158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-10T21:20:36.914995Z","caller":"traceutil/trace.go:171","msg":"trace[731219932] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:26; }","duration":"180.293699ms","start":"2026-07-10T21:20:36.734671Z","end":"2026-07-10T21:20:36.914964Z","steps":["trace[731219932] 'agreement among raft nodes before linearized reading' (duration: 180.193317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:20:36.914847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.521678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-10T21:20:36.915043Z","caller":"traceutil/trace.go:171","msg":"trace[357350184] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"179.929272ms","start":"2026-07-10T21:20:36.735102Z","end":"2026-07-10T21:20:36.915031Z","steps":["trace[357350184] 'process raft request' (duration: 179.543985ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.915092Z","caller":"traceutil/trace.go:171","msg":"trace[1805697278] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:26; }","duration":"109.802122ms","start":"2026-07-10T21:20:36.80527Z","end":"2026-07-10T21:20:36.915072Z","steps":["trace[1805697278] 'agreement among raft nodes before linearized reading' (duration: 109.528927ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:36.915769Z","caller":"traceutil/trace.go:171","msg":"trace[849825050] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"180.95789ms","start":"2026-07-10T21:20:36.734523Z","end":"2026-07-10T21:20:36.915481Z","steps":["trace[849825050] 'process raft request' (duration: 180.057485ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.091734Z","caller":"traceutil/trace.go:171","msg":"trace[1649904335] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"130.887815ms","start":"2026-07-10T21:20:36.960821Z","end":"2026-07-10T21:20:37.091709Z","steps":["trace[1649904335] 'process raft request' (duration: 130.859935ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.091788Z","caller":"traceutil/trace.go:171","msg":"trace[1159305867] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"172.266167ms","start":"2026-07-10T21:20:36.919477Z","end":"2026-07-10T21:20:37.091743Z","steps":["trace[1159305867] 'process raft request' (duration: 172.054823ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092101Z","caller":"traceutil/trace.go:171","msg":"trace[1475715922] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"172.327087ms","start":"2026-07-10T21:20:36.919751Z","end":"2026-07-10T21:20:37.092078Z","steps":["trace[1475715922] 'process raft request' (duration: 171.841738ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092143Z","caller":"traceutil/trace.go:171","msg":"trace[86275017] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"172.320436ms","start":"2026-07-10T21:20:36.919811Z","end":"2026-07-10T21:20:37.092132Z","steps":["trace[86275017] 'process raft request' (duration: 171.816449ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092266Z","caller":"traceutil/trace.go:171","msg":"trace[784688043] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"172.729794ms","start":"2026-07-10T21:20:36.919521Z","end":"2026-07-10T21:20:37.092251Z","steps":["trace[784688043] 'process raft request' (duration: 172.045243ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092377Z","caller":"traceutil/trace.go:171","msg":"trace[2147222191] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"172.54858ms","start":"2026-07-10T21:20:36.919815Z","end":"2026-07-10T21:20:37.092364Z","steps":["trace[2147222191] 'process raft request' (duration: 171.837989ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092509Z","caller":"traceutil/trace.go:171","msg":"trace[1638367360] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"173.973175ms","start":"2026-07-10T21:20:36.918527Z","end":"2026-07-10T21:20:37.0925Z","steps":["trace[1638367360] 'process raft request' (duration: 172.829466ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092553Z","caller":"traceutil/trace.go:171","msg":"trace[1992930106] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"173.73092ms","start":"2026-07-10T21:20:36.918812Z","end":"2026-07-10T21:20:37.092543Z","steps":["trace[1992930106] 'process raft request' (duration: 172.640212ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:20:37.092257Z","caller":"traceutil/trace.go:171","msg":"trace[1342214625] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"175.147864ms","start":"2026-07-10T21:20:36.917075Z","end":"2026-07-10T21:20:37.092223Z","steps":["trace[1342214625] 'process raft request' (duration: 104.276308ms)","trace[1342214625] 'compare' (duration: 69.85862ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:20:37.092745Z","caller":"traceutil/trace.go:171","msg":"trace[338904610] linearizableReadLoop","detail":"{readStateIndex:35; appliedIndex:30; }","duration":"173.747782ms","start":"2026-07-10T21:20:36.91898Z","end":"2026-07-10T21:20:37.092728Z","steps":["trace[338904610] 'read index received' (duration: 37.784661ms)","trace[338904610] 'applied index is now lower than readState.Index' (duration: 135.961241ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:20:37.092888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.881474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-10T21:20:37.092943Z","caller":"traceutil/trace.go:171","msg":"trace[1381570087] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:37; }","duration":"173.974745ms","start":"2026-07-10T21:20:36.918951Z","end":"2026-07-10T21:20:37.092926Z","steps":["trace[1381570087] 'agreement among raft nodes before linearized reading' (duration: 173.842062ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:05.368372Z","caller":"traceutil/trace.go:171","msg":"trace[44569133] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:452; }","duration":"104.767888ms","start":"2026-07-10T21:21:05.263569Z","end":"2026-07-10T21:21:05.368336Z","steps":["trace[44569133] 'read index received' (duration: 104.657316ms)","trace[44569133] 'applied index is now lower than readState.Index' (duration: 109.242µs)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:05.368537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.94448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:05.368577Z","caller":"traceutil/trace.go:171","msg":"trace[25130876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:435; }","duration":"105.062101ms","start":"2026-07-10T21:21:05.263504Z","end":"2026-07-10T21:21:05.368566Z","steps":["trace[25130876] 'agreement among raft nodes before linearized reading' (duration: 104.96339ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:05.368522Z","caller":"traceutil/trace.go:171","msg":"trace[2013920942] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"203.389744ms","start":"2026-07-10T21:21:05.165066Z","end":"2026-07-10T21:21:05.368456Z","steps":["trace[2013920942] 'process raft request' (duration: 203.092299ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:07.735676Z","caller":"traceutil/trace.go:171","msg":"trace[657978886] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:456; }","duration":"362.224366ms","start":"2026-07-10T21:21:07.37343Z","end":"2026-07-10T21:21:07.735655Z","steps":["trace[657978886] 'read index received' (duration: 362.082314ms)","trace[657978886] 'applied index is now lower than readState.Index' (duration: 139.552µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:07.73575Z","caller":"traceutil/trace.go:171","msg":"trace[1264135806] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"392.611647ms","start":"2026-07-10T21:21:07.343094Z","end":"2026-07-10T21:21:07.735706Z","steps":["trace[1264135806] 'process raft request' (duration: 392.433885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:07.735936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:07.343067Z","time spent":"392.77953ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T21:21:07.735793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.356787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-10T21:21:07.73608Z","caller":"traceutil/trace.go:171","msg":"trace[1173568137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:439; }","duration":"362.695342ms","start":"2026-07-10T21:21:07.373355Z","end":"2026-07-10T21:21:07.736051Z","steps":["trace[1173568137] 'agreement among raft nodes before linearized reading' (duration: 362.388637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:07.73619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:07.373326Z","time spent":"362.829564ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-10T21:21:08.371426Z","caller":"traceutil/trace.go:171","msg":"trace[1581648579] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"630.751491ms","start":"2026-07-10T21:21:07.740648Z","end":"2026-07-10T21:21:08.3714Z","steps":["trace[1581648579] 'process raft request' (duration: 585.021922ms)","trace[1581648579] 'compare' (duration: 45.313662ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:08.371614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:07.740614Z","time spent":"630.914092ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T21:21:08.371959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.138047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-10T21:21:08.372022Z","caller":"traceutil/trace.go:171","msg":"trace[887942959] linearizableReadLoop","detail":"{readStateIndex:458; appliedIndex:457; }","duration":"434.6423ms","start":"2026-07-10T21:21:07.936694Z","end":"2026-07-10T21:21:08.371337Z","steps":["trace[887942959] 'read index received' (duration: 388.956401ms)","trace[887942959] 'applied index is now lower than readState.Index' (duration: 45.684879ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:08.37208Z","caller":"traceutil/trace.go:171","msg":"trace[72062421] range","detail":"{range_begin:/registry/masterleases/199.19.213.250; range_end:; response_count:1; response_revision:440; }","duration":"435.415581ms","start":"2026-07-10T21:21:07.93664Z","end":"2026-07-10T21:21:08.372056Z","steps":["trace[72062421] 'agreement among raft nodes before linearized reading' (duration: 435.026796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:08.372121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:07.936621Z","time spent":"435.491683ms","remote":"127.0.0.1:50228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.250\" "} {"level":"warn","ts":"2026-07-10T21:21:08.372169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.882267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:08.372222Z","caller":"traceutil/trace.go:171","msg":"trace[1427582993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:440; }","duration":"110.970909ms","start":"2026-07-10T21:21:08.261231Z","end":"2026-07-10T21:21:08.372202Z","steps":["trace[1427582993] 'agreement among raft nodes before linearized reading' (duration: 110.888818ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:12.59073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.846309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-07-10T21:21:12.591112Z","caller":"traceutil/trace.go:171","msg":"trace[1146395802] transaction","detail":"{read_only:false; number_of_response:0; response_revision:507; }","duration":"245.591279ms","start":"2026-07-10T21:21:12.345442Z","end":"2026-07-10T21:21:12.591033Z","steps":["trace[1146395802] 'process raft request' (duration: 76.220533ms)","trace[1146395802] 'compare' (duration: 168.804418ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:12.591318Z","caller":"traceutil/trace.go:171","msg":"trace[426202020] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"237.716923ms","start":"2026-07-10T21:21:12.353552Z","end":"2026-07-10T21:21:12.591269Z","steps":["trace[426202020] 'process raft request' (duration: 237.294257ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:12.591623Z","caller":"traceutil/trace.go:171","msg":"trace[132251566] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"228.401195ms","start":"2026-07-10T21:21:12.363202Z","end":"2026-07-10T21:21:12.591603Z","steps":["trace[132251566] 'process raft request' (duration: 228.209073ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:12.591636Z","caller":"traceutil/trace.go:171","msg":"trace[1451232147] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"237.871865ms","start":"2026-07-10T21:21:12.353716Z","end":"2026-07-10T21:21:12.591588Z","steps":["trace[1451232147] 'process raft request' (duration: 237.49594ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:12.610413Z","caller":"traceutil/trace.go:171","msg":"trace[1127471381] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:527; }","duration":"206.491292ms","start":"2026-07-10T21:21:12.403908Z","end":"2026-07-10T21:21:12.610399Z","steps":["trace[1127471381] 'read index received' (duration: 17.816742ms)","trace[1127471381] 'applied index is now lower than readState.Index' (duration: 188.67399ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:12.610746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.833868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-10T21:21:12.610778Z","caller":"traceutil/trace.go:171","msg":"trace[1260570212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"206.909198ms","start":"2026-07-10T21:21:12.403861Z","end":"2026-07-10T21:21:12.61077Z","steps":["trace[1260570212] 'agreement among raft nodes before linearized reading' (duration: 206.819728ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:12.611179Z","caller":"traceutil/trace.go:171","msg":"trace[117422760] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"206.859099ms","start":"2026-07-10T21:21:12.403658Z","end":"2026-07-10T21:21:12.610518Z","steps":["trace[117422760] 'process raft request' (duration: 206.588555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.529627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.363947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:21:13.529746Z","caller":"traceutil/trace.go:171","msg":"trace[1314253312] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"280.306752ms","start":"2026-07-10T21:21:13.249419Z","end":"2026-07-10T21:21:13.529726Z","steps":["trace[1314253312] 'read index received' (duration: 79.646161ms)","trace[1314253312] 'applied index is now lower than readState.Index' (duration: 200.659301ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:13.529879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.453775ms","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-07-10T21:21:13.529822Z","caller":"traceutil/trace.go:171","msg":"trace[1584294165] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"300.51596ms","start":"2026-07-10T21:21:13.229224Z","end":"2026-07-10T21:21:13.52974Z","steps":["trace[1584294165] 'process raft request' (duration: 99.94499ms)","trace[1584294165] 'compare' (duration: 200.098602ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:13.53024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:13.229202Z","time spent":"300.765863ms","remote":"127.0.0.1:50250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:21:13.529915Z","caller":"traceutil/trace.go:171","msg":"trace[1445041656] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:548; }","duration":"280.489375ms","start":"2026-07-10T21:21:13.249413Z","end":"2026-07-10T21:21:13.529902Z","steps":["trace[1445041656] 'agreement among raft nodes before linearized reading' (duration: 280.427405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.532325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.82234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-10T21:21:13.532362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.371694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.532416Z","caller":"traceutil/trace.go:171","msg":"trace[510166040] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:549; }","duration":"282.934131ms","start":"2026-07-10T21:21:13.249462Z","end":"2026-07-10T21:21:13.532396Z","steps":["trace[510166040] 'agreement among raft nodes before linearized reading' (duration: 282.753739ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:13.532726Z","caller":"traceutil/trace.go:171","msg":"trace[579619519] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:549; }","duration":"208.805331ms","start":"2026-07-10T21:21:13.3239Z","end":"2026-07-10T21:21:13.532705Z","steps":["trace[579619519] 'agreement among raft nodes before linearized reading' (duration: 208.368765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.532815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.088327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.532867Z","caller":"traceutil/trace.go:171","msg":"trace[757320503] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:549; }","duration":"220.178929ms","start":"2026-07-10T21:21:13.312675Z","end":"2026-07-10T21:21:13.532854Z","steps":["trace[757320503] 'agreement among raft nodes before linearized reading' (duration: 220.096097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.533002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.32653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.533079Z","caller":"traceutil/trace.go:171","msg":"trace[1326296766] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:549; }","duration":"220.398791ms","start":"2026-07-10T21:21:13.312634Z","end":"2026-07-10T21:21:13.533033Z","steps":["trace[1326296766] 'agreement among raft nodes before linearized reading' (duration: 220.322009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.533198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.482667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.53324Z","caller":"traceutil/trace.go:171","msg":"trace[1632864876] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:549; }","duration":"244.580537ms","start":"2026-07-10T21:21:13.288647Z","end":"2026-07-10T21:21:13.533228Z","steps":["trace[1632864876] 'agreement among raft nodes before linearized reading' (duration: 244.521745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.533346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.92988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.533426Z","caller":"traceutil/trace.go:171","msg":"trace[1920294930] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:549; }","duration":"151.046502ms","start":"2026-07-10T21:21:13.382367Z","end":"2026-07-10T21:21:13.533414Z","steps":["trace[1920294930] 'agreement among raft nodes before linearized reading' (duration: 150.897709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.53347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.349238ms","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-07-10T21:21:13.533605Z","caller":"traceutil/trace.go:171","msg":"trace[1809337709] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:549; }","duration":"245.48073ms","start":"2026-07-10T21:21:13.288104Z","end":"2026-07-10T21:21:13.533585Z","steps":["trace[1809337709] 'agreement among raft nodes before linearized reading' (duration: 245.321908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.533272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.778308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.533844Z","caller":"traceutil/trace.go:171","msg":"trace[69797774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:549; }","duration":"151.448748ms","start":"2026-07-10T21:21:13.382382Z","end":"2026-07-10T21:21:13.533831Z","steps":["trace[69797774] 'agreement among raft nodes before linearized reading' (duration: 150.599145ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:13.533833Z","caller":"traceutil/trace.go:171","msg":"trace[1054849938] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"205.895147ms","start":"2026-07-10T21:21:13.327912Z","end":"2026-07-10T21:21:13.533807Z","steps":["trace[1054849938] 'process raft request' (duration: 203.606554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.533891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.814925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.533941Z","caller":"traceutil/trace.go:171","msg":"trace[695826160] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:549; }","duration":"245.898037ms","start":"2026-07-10T21:21:13.28803Z","end":"2026-07-10T21:21:13.533928Z","steps":["trace[695826160] 'agreement among raft nodes before linearized reading' (duration: 245.813316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.534152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.585515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.534186Z","caller":"traceutil/trace.go:171","msg":"trace[1812665425] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:549; }","duration":"131.665787ms","start":"2026-07-10T21:21:13.402511Z","end":"2026-07-10T21:21:13.534176Z","steps":["trace[1812665425] 'agreement among raft nodes before linearized reading' (duration: 131.607696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.534725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.299826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.5348Z","caller":"traceutil/trace.go:171","msg":"trace[2143311026] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:549; }","duration":"132.388777ms","start":"2026-07-10T21:21:13.402394Z","end":"2026-07-10T21:21:13.534783Z","steps":["trace[2143311026] 'agreement among raft nodes before linearized reading' (duration: 132.273216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.534826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.798311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.534883Z","caller":"traceutil/trace.go:171","msg":"trace[11494465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:549; }","duration":"210.879112ms","start":"2026-07-10T21:21:13.323991Z","end":"2026-07-10T21:21:13.53487Z","steps":["trace[11494465] 'agreement among raft nodes before linearized reading' (duration: 210.78477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.534751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.323001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-10T21:21:13.535042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.429658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.535146Z","caller":"traceutil/trace.go:171","msg":"trace[1146414044] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:549; }","duration":"132.766273ms","start":"2026-07-10T21:21:13.402364Z","end":"2026-07-10T21:21:13.535131Z","steps":["trace[1146414044] 'agreement among raft nodes before linearized reading' (duration: 132.408207ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:13.535228Z","caller":"traceutil/trace.go:171","msg":"trace[252195587] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:549; }","duration":"152.739056ms","start":"2026-07-10T21:21:13.38237Z","end":"2026-07-10T21:21:13.535109Z","steps":["trace[252195587] 'agreement among raft nodes before linearized reading' (duration: 152.219659ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:13.535056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.099275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:13.535528Z","caller":"traceutil/trace.go:171","msg":"trace[1097452141] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:549; }","duration":"211.594222ms","start":"2026-07-10T21:21:13.323913Z","end":"2026-07-10T21:21:13.535507Z","steps":["trace[1097452141] 'agreement among raft nodes before linearized reading' (duration: 211.116466ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:14.38509Z","caller":"traceutil/trace.go:171","msg":"trace[584339663] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"117.671498ms","start":"2026-07-10T21:21:14.267386Z","end":"2026-07-10T21:21:14.385057Z","steps":["trace[584339663] 'read index received' (duration: 117.265722ms)","trace[584339663] 'applied index is now lower than readState.Index' (duration: 404.556µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:14.385205Z","caller":"traceutil/trace.go:171","msg":"trace[1912746864] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"184.801163ms","start":"2026-07-10T21:21:14.200359Z","end":"2026-07-10T21:21:14.38516Z","steps":["trace[1912746864] 'process raft request' (duration: 184.316206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:14.385314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.894501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:14.385365Z","caller":"traceutil/trace.go:171","msg":"trace[1387304409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"118.015392ms","start":"2026-07-10T21:21:14.267336Z","end":"2026-07-10T21:21:14.385351Z","steps":["trace[1387304409] 'agreement among raft nodes before linearized reading' (duration: 117.89768ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:14.398532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.317905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-07-10T21:21:14.398549Z","caller":"traceutil/trace.go:171","msg":"trace[1406369695] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"103.703002ms","start":"2026-07-10T21:21:14.294821Z","end":"2026-07-10T21:21:14.398524Z","steps":["trace[1406369695] 'process raft request' (duration: 95.288289ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:14.398613Z","caller":"traceutil/trace.go:171","msg":"trace[771380405] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:571; }","duration":"109.487307ms","start":"2026-07-10T21:21:14.289106Z","end":"2026-07-10T21:21:14.398593Z","steps":["trace[771380405] 'agreement among raft nodes before linearized reading' (duration: 109.250443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:15.229415Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485318922138184418,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-10T21:21:15.322291Z","caller":"traceutil/trace.go:171","msg":"trace[1339871018] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"626.59668ms","start":"2026-07-10T21:21:14.695664Z","end":"2026-07-10T21:21:15.32226Z","steps":["trace[1339871018] 'process raft request' (duration: 626.428138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:15.322453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:14.695619Z","time spent":"626.750211ms","remote":"127.0.0.1:50250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T21:21:15.333725Z","caller":"traceutil/trace.go:171","msg":"trace[1883469869] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"637.147694ms","start":"2026-07-10T21:21:14.696545Z","end":"2026-07-10T21:21:15.333693Z","steps":["trace[1883469869] 'process raft request' (duration: 636.848461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:15.334044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:14.696533Z","time spent":"637.339127ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:21:15.334157Z","caller":"traceutil/trace.go:171","msg":"trace[1202899035] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"633.208257ms","start":"2026-07-10T21:21:14.700904Z","end":"2026-07-10T21:21:15.334112Z","steps":["trace[1202899035] 'process raft request' (duration: 632.675899ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:15.334258Z","caller":"traceutil/trace.go:171","msg":"trace[1837389489] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"439.079197ms","start":"2026-07-10T21:21:14.895157Z","end":"2026-07-10T21:21:15.334236Z","steps":["trace[1837389489] 'process raft request' (duration: 438.688162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:15.334359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:14.895141Z","time spent":"439.168569ms","remote":"127.0.0.1:50250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T21:21:15.334429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.094564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-10T21:21:15.334398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:14.700892Z","time spent":"633.388631ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4873,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:21:15.334456Z","caller":"traceutil/trace.go:171","msg":"trace[1035353060] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"605.152634ms","start":"2026-07-10T21:21:14.729296Z","end":"2026-07-10T21:21:15.334449Z","steps":["trace[1035353060] 'agreement among raft nodes before linearized reading' (duration: 605.006693ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:15.334263Z","caller":"traceutil/trace.go:171","msg":"trace[331961174] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:608; }","duration":"604.922991ms","start":"2026-07-10T21:21:14.729315Z","end":"2026-07-10T21:21:15.334238Z","steps":["trace[331961174] 'read index received' (duration: 593.054907ms)","trace[331961174] 'applied index is now lower than readState.Index' (duration: 11.867284ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:15.334479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:14.729286Z","time spent":"605.187976ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-10T21:21:15.334542Z","caller":"traceutil/trace.go:171","msg":"trace[926819282] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"239.171475ms","start":"2026-07-10T21:21:15.095354Z","end":"2026-07-10T21:21:15.334526Z","steps":["trace[926819282] 'process raft request' (duration: 238.79144ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:18.195063Z","caller":"traceutil/trace.go:171","msg":"trace[1436744749] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"102.307511ms","start":"2026-07-10T21:21:18.092722Z","end":"2026-07-10T21:21:18.195029Z","steps":["trace[1436744749] 'read index received' (duration: 30.675547ms)","trace[1436744749] 'applied index is now lower than readState.Index' (duration: 71.629794ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:18.19543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.682946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-07-10T21:21:18.19549Z","caller":"traceutil/trace.go:171","msg":"trace[1146521646] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:617; }","duration":"102.820139ms","start":"2026-07-10T21:21:18.092649Z","end":"2026-07-10T21:21:18.195469Z","steps":["trace[1146521646] 'agreement among raft nodes before linearized reading' (duration: 102.560244ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:22.026378Z","caller":"traceutil/trace.go:171","msg":"trace[1611682692] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"284.64894ms","start":"2026-07-10T21:21:21.741701Z","end":"2026-07-10T21:21:22.02635Z","steps":["trace[1611682692] 'process raft request' (duration: 284.467227ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:22.16028Z","caller":"traceutil/trace.go:171","msg":"trace[521705629] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"217.702274ms","start":"2026-07-10T21:21:21.942544Z","end":"2026-07-10T21:21:22.160246Z","steps":["trace[521705629] 'read index received' (duration: 84.301861ms)","trace[521705629] 'applied index is now lower than readState.Index' (duration: 133.398773ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:22.160443Z","caller":"traceutil/trace.go:171","msg":"trace[1192181056] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"388.005676ms","start":"2026-07-10T21:21:21.772386Z","end":"2026-07-10T21:21:22.160392Z","steps":["trace[1192181056] 'process raft request' (duration: 374.449469ms)","trace[1192181056] 'compare' (duration: 12.902277ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:22.160529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.957488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-10T21:21:22.160763Z","caller":"traceutil/trace.go:171","msg":"trace[1696536665] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:648; }","duration":"218.293274ms","start":"2026-07-10T21:21:21.942447Z","end":"2026-07-10T21:21:22.16074Z","steps":["trace[1696536665] 'agreement among raft nodes before linearized reading' (duration: 217.921868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:22.160917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:21.772343Z","time spent":"388.29002ms","remote":"127.0.0.1:50282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:21:22.510328Z","caller":"traceutil/trace.go:171","msg":"trace[901646327] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"246.41428ms","start":"2026-07-10T21:21:22.263883Z","end":"2026-07-10T21:21:22.510298Z","steps":["trace[901646327] 'read index received' (duration: 246.223607ms)","trace[901646327] 'applied index is now lower than readState.Index' (duration: 189.443µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:22.510441Z","caller":"traceutil/trace.go:171","msg":"trace[1811465321] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"292.430718ms","start":"2026-07-10T21:21:22.217968Z","end":"2026-07-10T21:21:22.510398Z","steps":["trace[1811465321] 'process raft request' (duration: 292.156993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:22.510514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.615973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:22.510552Z","caller":"traceutil/trace.go:171","msg":"trace[2083460720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"246.723914ms","start":"2026-07-10T21:21:22.263816Z","end":"2026-07-10T21:21:22.51054Z","steps":["trace[2083460720] 'agreement among raft nodes before linearized reading' (duration: 246.594243ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:23.445281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.409297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-10T21:21:23.445406Z","caller":"traceutil/trace.go:171","msg":"trace[1569481720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"746.5874ms","start":"2026-07-10T21:21:22.698789Z","end":"2026-07-10T21:21:23.445376Z","steps":["trace[1569481720] 'range keys from in-memory index tree' (duration: 746.160574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:23.445468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:22.698766Z","time spent":"746.687472ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-10T21:21:23.447309Z","caller":"traceutil/trace.go:171","msg":"trace[158705973] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"182.944679ms","start":"2026-07-10T21:21:23.264337Z","end":"2026-07-10T21:21:23.447281Z","steps":["trace[158705973] 'read index received' (duration: 181.488712ms)","trace[158705973] 'applied index is now lower than readState.Index' (duration: 1.454627ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:23.447618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.231574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:21:23.447761Z","caller":"traceutil/trace.go:171","msg":"trace[1593300448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"183.457727ms","start":"2026-07-10T21:21:23.264269Z","end":"2026-07-10T21:21:23.447727Z","steps":["trace[1593300448] 'agreement among raft nodes before linearized reading' (duration: 183.161831ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:23.448077Z","caller":"traceutil/trace.go:171","msg":"trace[1929316956] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"514.794624ms","start":"2026-07-10T21:21:22.933238Z","end":"2026-07-10T21:21:23.448033Z","steps":["trace[1929316956] 'process raft request' (duration: 513.194784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:23.448464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:22.933198Z","time spent":"514.980936ms","remote":"127.0.0.1:50282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:21:28.14203Z","caller":"traceutil/trace.go:171","msg":"trace[1725978428] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"186.818417ms","start":"2026-07-10T21:21:27.955181Z","end":"2026-07-10T21:21:28.141999Z","steps":["trace[1725978428] 'process raft request' (duration: 186.630027ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:36.513217Z","caller":"traceutil/trace.go:171","msg":"trace[1815820901] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"243.676429ms","start":"2026-07-10T21:21:36.269517Z","end":"2026-07-10T21:21:36.513194Z","steps":["trace[1815820901] 'process raft request' (duration: 243.47858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:39.128965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.483316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:21:39.129153Z","caller":"traceutil/trace.go:171","msg":"trace[2071186500] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"611.781784ms","start":"2026-07-10T21:21:38.517348Z","end":"2026-07-10T21:21:39.12913Z","steps":["trace[2071186500] 'read index received' (duration: 374.863949ms)","trace[2071186500] 'applied index is now lower than readState.Index' (duration: 236.916445ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:21:39.129262Z","caller":"traceutil/trace.go:171","msg":"trace[62901948] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"618.96272ms","start":"2026-07-10T21:21:38.510287Z","end":"2026-07-10T21:21:39.129249Z","steps":["trace[62901948] 'process raft request' (duration: 382.064786ms)","trace[62901948] 'compare' (duration: 236.315588ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:21:39.129326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:38.510251Z","time spent":"619.039683ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T21:21:39.129723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.199887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gppf8\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-10T21:21:39.1299Z","caller":"traceutil/trace.go:171","msg":"trace[1786395281] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gppf8; range_end:; response_count:1; response_revision:769; }","duration":"303.392026ms","start":"2026-07-10T21:21:38.826425Z","end":"2026-07-10T21:21:39.129817Z","steps":["trace[1786395281] 'agreement among raft nodes before linearized reading' (duration: 303.049921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:39.129973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:38.826398Z","time spent":"303.557784ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gppf8\" "} {"level":"warn","ts":"2026-07-10T21:21:39.129737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.373461ms","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-07-10T21:21:39.130122Z","caller":"traceutil/trace.go:171","msg":"trace[492051240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:769; }","duration":"612.772448ms","start":"2026-07-10T21:21:38.5173Z","end":"2026-07-10T21:21:39.130072Z","steps":["trace[492051240] 'agreement among raft nodes before linearized reading' (duration: 612.334849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:21:39.130193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:21:38.517281Z","time spent":"612.893074ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-10T21:21:39.248239Z","caller":"traceutil/trace.go:171","msg":"trace[836144122] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"112.784069ms","start":"2026-07-10T21:21:39.135416Z","end":"2026-07-10T21:21:39.2482Z","steps":["trace[836144122] 'process raft request' (duration: 112.612571ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:21:39.257639Z","caller":"traceutil/trace.go:171","msg":"trace[1537950195] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"119.592685ms","start":"2026-07-10T21:21:39.138004Z","end":"2026-07-10T21:21:39.257596Z","steps":["trace[1537950195] 'process raft request' (duration: 119.25827ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:22:31.270468Z","caller":"traceutil/trace.go:171","msg":"trace[1662087717] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"100.855812ms","start":"2026-07-10T21:22:31.169574Z","end":"2026-07-10T21:22:31.27043Z","steps":["trace[1662087717] 'process raft request' (duration: 90.715508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:22:31.56634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.610434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:22:31.566502Z","caller":"traceutil/trace.go:171","msg":"trace[2018985289] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1451; }","duration":"176.56722ms","start":"2026-07-10T21:22:31.389914Z","end":"2026-07-10T21:22:31.566481Z","steps":["trace[2018985289] 'read index received' (duration: 54.505424ms)","trace[2018985289] 'applied index is now lower than readState.Index' (duration: 122.060496ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:22:31.566573Z","caller":"traceutil/trace.go:171","msg":"trace[155239848] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"213.567229ms","start":"2026-07-10T21:22:31.35295Z","end":"2026-07-10T21:22:31.566517Z","steps":["trace[155239848] 'process raft request' (duration: 91.658256ms)","trace[155239848] 'compare' (duration: 120.813511ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:22:31.567395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.441066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-10T21:22:31.567522Z","caller":"traceutil/trace.go:171","msg":"trace[120417946] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1408; }","duration":"177.633313ms","start":"2026-07-10T21:22:31.389859Z","end":"2026-07-10T21:22:31.567492Z","steps":["trace[120417946] 'agreement among raft nodes before linearized reading' (duration: 176.691735ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:22:31.569246Z","caller":"traceutil/trace.go:171","msg":"trace[1605814395] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"117.232303ms","start":"2026-07-10T21:22:31.451988Z","end":"2026-07-10T21:22:31.56922Z","steps":["trace[1605814395] 'process raft request' (duration: 116.80604ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:00.261312Z","caller":"traceutil/trace.go:171","msg":"trace[20106928] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"373.230263ms","start":"2026-07-10T21:22:59.888045Z","end":"2026-07-10T21:23:00.261275Z","steps":["trace[20106928] 'process raft request' (duration: 372.951765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.261852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:22:59.888024Z","time spent":"373.477188ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:00.272371Z","caller":"traceutil/trace.go:171","msg":"trace[936207939] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1929; }","duration":"159.205057ms","start":"2026-07-10T21:23:00.113135Z","end":"2026-07-10T21:23:00.27234Z","steps":["trace[936207939] 'read index received' (duration: 147.98465ms)","trace[936207939] 'applied index is now lower than readState.Index' (duration: 11.219347ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:00.272474Z","caller":"traceutil/trace.go:171","msg":"trace[1837542164] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"295.262825ms","start":"2026-07-10T21:22:59.977203Z","end":"2026-07-10T21:23:00.272466Z","steps":["trace[1837542164] 'process raft request' (duration: 295.015028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.272675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.834494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-10T21:23:00.272919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.987014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-10T21:23:00.273005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.853964ms","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-07-10T21:23:00.273074Z","caller":"traceutil/trace.go:171","msg":"trace[1441482289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1858; }","duration":"147.130179ms","start":"2026-07-10T21:23:00.125863Z","end":"2026-07-10T21:23:00.272993Z","steps":["trace[1441482289] 'agreement among raft nodes before linearized reading' (duration: 146.809941ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:00.273103Z","caller":"traceutil/trace.go:171","msg":"trace[2046359503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1858; }","duration":"160.011438ms","start":"2026-07-10T21:23:00.113074Z","end":"2026-07-10T21:23:00.273085Z","steps":["trace[2046359503] 'agreement among raft nodes before linearized reading' (duration: 159.811833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.273225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.946858ms","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-07-10T21:23:00.273269Z","caller":"traceutil/trace.go:171","msg":"trace[1487271447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1858; }","duration":"148.036621ms","start":"2026-07-10T21:23:00.125223Z","end":"2026-07-10T21:23:00.27326Z","steps":["trace[1487271447] 'agreement among raft nodes before linearized reading' (duration: 147.901408ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:00.273738Z","caller":"traceutil/trace.go:171","msg":"trace[1930824984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1858; }","duration":"153.04008ms","start":"2026-07-10T21:23:00.119685Z","end":"2026-07-10T21:23:00.272725Z","steps":["trace[1930824984] 'agreement among raft nodes before linearized reading' (duration: 152.831704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.937451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.045464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:23:00.937928Z","caller":"traceutil/trace.go:171","msg":"trace[1718342118] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1931; }","duration":"657.663273ms","start":"2026-07-10T21:23:00.280236Z","end":"2026-07-10T21:23:00.937899Z","steps":["trace[1718342118] 'read index received' (duration: 9.411441ms)","trace[1718342118] 'applied index is now lower than readState.Index' (duration: 648.249791ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:00.938054Z","caller":"traceutil/trace.go:171","msg":"trace[1039511436] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"659.852918ms","start":"2026-07-10T21:23:00.278182Z","end":"2026-07-10T21:23:00.938035Z","steps":["trace[1039511436] 'process raft request' (duration: 154.087815ms)","trace[1039511436] 'compare' (duration: 504.641094ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:23:00.938148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.278153Z","time spent":"659.943921ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:00.938427Z","caller":"traceutil/trace.go:171","msg":"trace[1451655021] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"658.857063ms","start":"2026-07-10T21:23:00.279519Z","end":"2026-07-10T21:23:00.938376Z","steps":["trace[1451655021] 'process raft request' (duration: 658.179756ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:00.938475Z","caller":"traceutil/trace.go:171","msg":"trace[353325632] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"657.707264ms","start":"2026-07-10T21:23:00.280727Z","end":"2026-07-10T21:23:00.938434Z","steps":["trace[353325632] 'process raft request' (duration: 657.047057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.938618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.373121ms","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-07-10T21:23:00.938681Z","caller":"traceutil/trace.go:171","msg":"trace[1940250597] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"658.471694ms","start":"2026-07-10T21:23:00.280196Z","end":"2026-07-10T21:23:00.938668Z","steps":["trace[1940250597] 'agreement among raft nodes before linearized reading' (duration: 658.250308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.938675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.280717Z","time spent":"657.847958ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T21:23:00.938715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.280186Z","time spent":"658.520105ms","remote":"127.0.0.1:43574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-10T21:23:00.938898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.279502Z","time spent":"659.038878ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:00.938993Z","caller":"traceutil/trace.go:171","msg":"trace[1171224297] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"660.570077ms","start":"2026-07-10T21:23:00.278352Z","end":"2026-07-10T21:23:00.938922Z","steps":["trace[1171224297] 'process raft request' (duration: 659.230533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.939626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.278332Z","time spent":"661.207924ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:00.941178Z","caller":"traceutil/trace.go:171","msg":"trace[133398583] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"464.510835ms","start":"2026-07-10T21:23:00.476652Z","end":"2026-07-10T21:23:00.941163Z","steps":["trace[133398583] 'process raft request' (duration: 464.448383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.941369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.476623Z","time spent":"464.597648ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:00.943343Z","caller":"traceutil/trace.go:171","msg":"trace[2106012308] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"321.935915ms","start":"2026-07-10T21:23:00.621387Z","end":"2026-07-10T21:23:00.943323Z","steps":["trace[2106012308] 'process raft request' (duration: 321.75389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:00.943463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:00.621351Z","time spent":"322.054188ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:00.943812Z","caller":"traceutil/trace.go:171","msg":"trace[1101319960] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"230.523972ms","start":"2026-07-10T21:23:00.713273Z","end":"2026-07-10T21:23:00.943797Z","steps":["trace[1101319960] 'process raft request' (duration: 230.01154ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:13.054496Z","caller":"traceutil/trace.go:171","msg":"trace[1173463634] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"138.939943ms","start":"2026-07-10T21:23:12.915506Z","end":"2026-07-10T21:23:13.054446Z","steps":["trace[1173463634] 'process raft request' (duration: 138.726488ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:13.17461Z","caller":"traceutil/trace.go:171","msg":"trace[1249859282] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"175.725036ms","start":"2026-07-10T21:23:12.998854Z","end":"2026-07-10T21:23:13.174579Z","steps":["trace[1249859282] 'process raft request' (duration: 144.649684ms)","trace[1249859282] 'compare' (duration: 30.803426ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:13.175129Z","caller":"traceutil/trace.go:171","msg":"trace[207372599] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"176.158276ms","start":"2026-07-10T21:23:12.998949Z","end":"2026-07-10T21:23:13.175108Z","steps":["trace[207372599] 'process raft request' (duration: 175.576202ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:13.17539Z","caller":"traceutil/trace.go:171","msg":"trace[874149935] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"173.166154ms","start":"2026-07-10T21:23:13.002211Z","end":"2026-07-10T21:23:13.175377Z","steps":["trace[874149935] 'process raft request' (duration: 172.791974ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:13.175566Z","caller":"traceutil/trace.go:171","msg":"trace[221200598] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2037; }","duration":"167.604929ms","start":"2026-07-10T21:23:13.007948Z","end":"2026-07-10T21:23:13.175553Z","steps":["trace[221200598] 'read index received' (duration: 46.348753ms)","trace[221200598] 'applied index is now lower than readState.Index' (duration: 121.254125ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:23:13.296178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.815476ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-07-10T21:23:13.29623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.256382ms","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-07-10T21:23:13.296299Z","caller":"traceutil/trace.go:171","msg":"trace[919992095] linearizableReadLoop","detail":"{readStateIndex:2042; appliedIndex:2041; }","duration":"120.678592ms","start":"2026-07-10T21:23:13.175597Z","end":"2026-07-10T21:23:13.296275Z","steps":["trace[919992095] 'read index received' (duration: 158.273µs)","trace[919992095] 'applied index is now lower than readState.Index' (duration: 120.518799ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:13.296345Z","caller":"traceutil/trace.go:171","msg":"trace[340285808] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1966; }","duration":"288.404595ms","start":"2026-07-10T21:23:13.00791Z","end":"2026-07-10T21:23:13.296314Z","steps":["trace[340285808] 'agreement among raft nodes before linearized reading' (duration: 167.827254ms)","trace[340285808] 'range keys from in-memory index tree' (duration: 120.322145ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:23:13.296688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.233316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-10T21:23:13.296708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.529762ms","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-07-10T21:23:13.296812Z","caller":"traceutil/trace.go:171","msg":"trace[583005856] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1966; }","duration":"263.711487ms","start":"2026-07-10T21:23:13.033072Z","end":"2026-07-10T21:23:13.296783Z","steps":["trace[583005856] 'agreement among raft nodes before linearized reading' (duration: 263.218075ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:13.296749Z","caller":"traceutil/trace.go:171","msg":"trace[1383042028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1966; }","duration":"280.35091ms","start":"2026-07-10T21:23:13.016379Z","end":"2026-07-10T21:23:13.296729Z","steps":["trace[1383042028] 'agreement among raft nodes before linearized reading' (duration: 279.99353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:13.296863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.102568ms","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-07-10T21:23:13.296993Z","caller":"traceutil/trace.go:171","msg":"trace[29576092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1966; }","duration":"279.270873ms","start":"2026-07-10T21:23:13.017691Z","end":"2026-07-10T21:23:13.296961Z","steps":["trace[29576092] 'agreement among raft nodes before linearized reading' (duration: 278.630548ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:34.828648Z","caller":"traceutil/trace.go:171","msg":"trace[534448961] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"231.479827ms","start":"2026-07-10T21:23:34.597135Z","end":"2026-07-10T21:23:34.828615Z","steps":["trace[534448961] 'process raft request' (duration: 231.280422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:35.647262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.579612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:23:35.647391Z","caller":"traceutil/trace.go:171","msg":"trace[1988782653] linearizableReadLoop","detail":"{readStateIndex:2182; appliedIndex:2181; }","duration":"232.044333ms","start":"2026-07-10T21:23:35.415326Z","end":"2026-07-10T21:23:35.64737Z","steps":["trace[1988782653] 'read index received' (duration: 13.114824ms)","trace[1988782653] 'applied index is now lower than readState.Index' (duration: 218.928069ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:35.64744Z","caller":"traceutil/trace.go:171","msg":"trace[1108176185] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"237.324372ms","start":"2026-07-10T21:23:35.410076Z","end":"2026-07-10T21:23:35.6474Z","steps":["trace[1108176185] 'process raft request' (duration: 18.477025ms)","trace[1108176185] 'compare' (duration: 218.321105ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:23:35.647624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.301269ms","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-07-10T21:23:35.647665Z","caller":"traceutil/trace.go:171","msg":"trace[933963669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2102; }","duration":"232.38074ms","start":"2026-07-10T21:23:35.415273Z","end":"2026-07-10T21:23:35.647653Z","steps":["trace[933963669] 'agreement among raft nodes before linearized reading' (duration: 232.200366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:35.647948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.855988ms","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-07-10T21:23:35.647993Z","caller":"traceutil/trace.go:171","msg":"trace[512113603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2102; }","duration":"227.947892ms","start":"2026-07-10T21:23:35.420033Z","end":"2026-07-10T21:23:35.647981Z","steps":["trace[512113603] 'agreement among raft nodes before linearized reading' (duration: 227.756587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:35.648136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.646174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-10T21:23:35.648166Z","caller":"traceutil/trace.go:171","msg":"trace[1978453627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2102; }","duration":"227.687426ms","start":"2026-07-10T21:23:35.420471Z","end":"2026-07-10T21:23:35.648158Z","steps":["trace[1978453627] 'agreement among raft nodes before linearized reading' (duration: 227.605234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:35.648263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.125419ms","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-07-10T21:23:35.648391Z","caller":"traceutil/trace.go:171","msg":"trace[1889119524] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2102; }","duration":"197.280123ms","start":"2026-07-10T21:23:35.45107Z","end":"2026-07-10T21:23:35.64835Z","steps":["trace[1889119524] 'agreement among raft nodes before linearized reading' (duration: 196.977617ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:35.894091Z","caller":"traceutil/trace.go:171","msg":"trace[1904597903] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"240.758468ms","start":"2026-07-10T21:23:35.653304Z","end":"2026-07-10T21:23:35.894062Z","steps":["trace[1904597903] 'process raft request' (duration: 240.567384ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:35.926215Z","caller":"traceutil/trace.go:171","msg":"trace[1715933454] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"272.251254ms","start":"2026-07-10T21:23:35.65393Z","end":"2026-07-10T21:23:35.926181Z","steps":["trace[1715933454] 'process raft request' (duration: 272.197614ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:35.926491Z","caller":"traceutil/trace.go:171","msg":"trace[424734708] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"272.685284ms","start":"2026-07-10T21:23:35.653791Z","end":"2026-07-10T21:23:35.926476Z","steps":["trace[424734708] 'process raft request' (duration: 272.164082ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:36.839613Z","caller":"traceutil/trace.go:171","msg":"trace[635876351] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2185; }","duration":"207.192342ms","start":"2026-07-10T21:23:36.632384Z","end":"2026-07-10T21:23:36.839577Z","steps":["trace[635876351] 'read index received' (duration: 206.932635ms)","trace[635876351] 'applied index is now lower than readState.Index' (duration: 258.737µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:36.839768Z","caller":"traceutil/trace.go:171","msg":"trace[378753857] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"238.505571ms","start":"2026-07-10T21:23:36.60125Z","end":"2026-07-10T21:23:36.839756Z","steps":["trace[378753857] 'process raft request' (duration: 238.161314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:36.839919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.509038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:23:36.840024Z","caller":"traceutil/trace.go:171","msg":"trace[54236088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"207.650093ms","start":"2026-07-10T21:23:36.632344Z","end":"2026-07-10T21:23:36.839995Z","steps":["trace[54236088] 'agreement among raft nodes before linearized reading' (duration: 207.50991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:36.84037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.980515ms","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-07-10T21:23:36.840411Z","caller":"traceutil/trace.go:171","msg":"trace[51268003] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2106; }","duration":"185.038927ms","start":"2026-07-10T21:23:36.655361Z","end":"2026-07-10T21:23:36.8404Z","steps":["trace[51268003] 'agreement among raft nodes before linearized reading' (duration: 184.901164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:36.840399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.471803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:126701"} {"level":"info","ts":"2026-07-10T21:23:36.840492Z","caller":"traceutil/trace.go:171","msg":"trace[1396024530] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2106; }","duration":"179.643846ms","start":"2026-07-10T21:23:36.660826Z","end":"2026-07-10T21:23:36.84047Z","steps":["trace[1396024530] 'agreement among raft nodes before linearized reading' (duration: 179.281728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:36.840466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.78817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-07-10T21:23:36.840563Z","caller":"traceutil/trace.go:171","msg":"trace[426050767] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2106; }","duration":"205.932505ms","start":"2026-07-10T21:23:36.634607Z","end":"2026-07-10T21:23:36.84054Z","steps":["trace[426050767] 'agreement among raft nodes before linearized reading' (duration: 205.201458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:37.171669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.367764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:23:37.171799Z","caller":"traceutil/trace.go:171","msg":"trace[711833189] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2186; }","duration":"324.631295ms","start":"2026-07-10T21:23:36.847148Z","end":"2026-07-10T21:23:37.171779Z","steps":["trace[711833189] 'read index received' (duration: 168.031546ms)","trace[711833189] 'applied index is now lower than readState.Index' (duration: 156.598329ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:23:37.171925Z","caller":"traceutil/trace.go:171","msg":"trace[347714236] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"327.538381ms","start":"2026-07-10T21:23:36.844334Z","end":"2026-07-10T21:23:37.171872Z","steps":["trace[347714236] 'process raft request' (duration: 170.854469ms)","trace[347714236] 'compare' (duration: 156.206131ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:23:37.172093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.145105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-07-10T21:23:37.172109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.963082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:126701"} {"level":"info","ts":"2026-07-10T21:23:37.172141Z","caller":"traceutil/trace.go:171","msg":"trace[365418989] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2107; }","duration":"325.031515ms","start":"2026-07-10T21:23:36.847101Z","end":"2026-07-10T21:23:37.172133Z","steps":["trace[365418989] 'agreement among raft nodes before linearized reading' (duration: 324.82797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:37.172179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:36.847081Z","time spent":"325.091366ms","remote":"127.0.0.1:50254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":126723,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-07-10T21:23:37.172179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:36.844315Z","time spent":"327.712965ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T21:23:37.172141Z","caller":"traceutil/trace.go:171","msg":"trace[1522494932] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2107; }","duration":"324.206727ms","start":"2026-07-10T21:23:36.847921Z","end":"2026-07-10T21:23:37.172128Z","steps":["trace[1522494932] 'agreement among raft nodes before linearized reading' (duration: 324.104595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:23:37.172424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:23:36.84791Z","time spent":"324.502243ms","remote":"127.0.0.1:50256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-07-10T21:23:37.172434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.506257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-10T21:23:37.172511Z","caller":"traceutil/trace.go:171","msg":"trace[975742135] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2107; }","duration":"194.65025ms","start":"2026-07-10T21:23:36.977844Z","end":"2026-07-10T21:23:37.172494Z","steps":["trace[975742135] 'agreement among raft nodes before linearized reading' (duration: 194.499817ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:37.472239Z","caller":"traceutil/trace.go:171","msg":"trace[1205796796] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"177.137238ms","start":"2026-07-10T21:23:37.295067Z","end":"2026-07-10T21:23:37.472204Z","steps":["trace[1205796796] 'process raft request' (duration: 175.560172ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:23:37.474035Z","caller":"traceutil/trace.go:171","msg":"trace[1275568895] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"154.058464ms","start":"2026-07-10T21:23:37.319959Z","end":"2026-07-10T21:23:37.474018Z","steps":["trace[1275568895] 'process raft request' (duration: 153.86918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:25:03.598619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.745438ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-07-10T21:25:03.598979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.983772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T21:25:03.599116Z","caller":"traceutil/trace.go:171","msg":"trace[1479103337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2680; }","duration":"336.155376ms","start":"2026-07-10T21:25:03.262936Z","end":"2026-07-10T21:25:03.599092Z","steps":["trace[1479103337] 'agreement among raft nodes before linearized reading' (duration: 335.960912ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:25:03.599019Z","caller":"traceutil/trace.go:171","msg":"trace[1281794639] linearizableReadLoop","detail":"{readStateIndex:2781; appliedIndex:2780; }","duration":"335.740266ms","start":"2026-07-10T21:25:03.262982Z","end":"2026-07-10T21:25:03.598723Z","steps":["trace[1281794639] 'read index received' (duration: 133.820535ms)","trace[1281794639] 'applied index is now lower than readState.Index' (duration: 201.917801ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:25:03.599205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:25:03.262917Z","time spent":"336.275817ms","remote":"127.0.0.1:50200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-10T21:25:03.601453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.491589ms","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-07-10T21:25:03.601516Z","caller":"traceutil/trace.go:171","msg":"trace[1310445546] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2681; }","duration":"326.600992ms","start":"2026-07-10T21:25:03.274901Z","end":"2026-07-10T21:25:03.601502Z","steps":["trace[1310445546] 'agreement among raft nodes before linearized reading' (duration: 326.431178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:25:03.601555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:25:03.27488Z","time spent":"326.666463ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-10T21:28:41.463227Z","caller":"traceutil/trace.go:171","msg":"trace[215698553] transaction","detail":"{read_only:false; response_revision:4535; number_of_response:1; }","duration":"118.146908ms","start":"2026-07-10T21:28:41.345061Z","end":"2026-07-10T21:28:41.463208Z","steps":["trace[215698553] 'process raft request' (duration: 118.070687ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:46.713028Z","caller":"traceutil/trace.go:171","msg":"trace[617211773] linearizableReadLoop","detail":"{readStateIndex:4752; appliedIndex:4751; }","duration":"244.297354ms","start":"2026-07-10T21:28:46.468696Z","end":"2026-07-10T21:28:46.712993Z","steps":["trace[617211773] 'read index received' (duration: 176.686308ms)","trace[617211773] 'applied index is now lower than readState.Index' (duration: 67.610296ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:28:46.713403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.684934ms","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-07-10T21:28:46.713436Z","caller":"traceutil/trace.go:171","msg":"trace[193127640] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4579; }","duration":"244.762055ms","start":"2026-07-10T21:28:46.468666Z","end":"2026-07-10T21:28:46.713428Z","steps":["trace[193127640] 'agreement among raft nodes before linearized reading' (duration: 244.447807ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:46.713641Z","caller":"traceutil/trace.go:171","msg":"trace[639698321] transaction","detail":"{read_only:false; response_revision:4579; number_of_response:1; }","duration":"261.476492ms","start":"2026-07-10T21:28:46.45213Z","end":"2026-07-10T21:28:46.713606Z","steps":["trace[639698321] 'process raft request' (duration: 193.177189ms)","trace[639698321] 'compare' (duration: 67.594706ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:28:46.784659Z","caller":"traceutil/trace.go:171","msg":"trace[365725067] transaction","detail":"{read_only:false; response_revision:4580; number_of_response:1; }","duration":"215.747493ms","start":"2026-07-10T21:28:46.568886Z","end":"2026-07-10T21:28:46.784633Z","steps":["trace[365725067] 'process raft request' (duration: 215.464625ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:46.784664Z","caller":"traceutil/trace.go:171","msg":"trace[219983318] transaction","detail":"{read_only:false; response_revision:4581; number_of_response:1; }","duration":"213.65736ms","start":"2026-07-10T21:28:46.570981Z","end":"2026-07-10T21:28:46.784638Z","steps":["trace[219983318] 'process raft request' (duration: 213.532766ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:46.785067Z","caller":"traceutil/trace.go:171","msg":"trace[1219441011] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"211.169468ms","start":"2026-07-10T21:28:46.573738Z","end":"2026-07-10T21:28:46.784908Z","steps":["trace[1219441011] 'process raft request' (duration: 210.84506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:28:47.222562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.793693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T21:28:47.222842Z","caller":"traceutil/trace.go:171","msg":"trace[1467004117] transaction","detail":"{read_only:false; response_revision:4598; number_of_response:1; }","duration":"263.723741ms","start":"2026-07-10T21:28:46.959096Z","end":"2026-07-10T21:28:47.222819Z","steps":["trace[1467004117] 'process raft request' (duration: 263.592777ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:47.222893Z","caller":"traceutil/trace.go:171","msg":"trace[696143021] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"260.480401ms","start":"2026-07-10T21:28:46.962373Z","end":"2026-07-10T21:28:47.222854Z","steps":["trace[696143021] 'process raft request' (duration: 260.397729ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:47.222882Z","caller":"traceutil/trace.go:171","msg":"trace[376460314] transaction","detail":"{read_only:false; response_revision:4597; number_of_response:1; }","duration":"267.540557ms","start":"2026-07-10T21:28:46.955305Z","end":"2026-07-10T21:28:47.222846Z","steps":["trace[376460314] 'process raft request' (duration: 125.371485ms)","trace[376460314] 'compare' (duration: 141.6964ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T21:28:47.222903Z","caller":"traceutil/trace.go:171","msg":"trace[728334496] linearizableReadLoop","detail":"{readStateIndex:4770; appliedIndex:4769; }","duration":"266.07207ms","start":"2026-07-10T21:28:46.956805Z","end":"2026-07-10T21:28:47.222877Z","steps":["trace[728334496] 'read index received' (duration: 123.841557ms)","trace[728334496] 'applied index is now lower than readState.Index' (duration: 142.228613ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T21:28:47.223034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.213164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-10T21:28:47.222997Z","caller":"traceutil/trace.go:171","msg":"trace[2140279638] transaction","detail":"{read_only:false; response_revision:4599; number_of_response:1; }","duration":"263.807974ms","start":"2026-07-10T21:28:46.959165Z","end":"2026-07-10T21:28:47.222973Z","steps":["trace[2140279638] 'process raft request' (duration: 263.568218ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:47.223065Z","caller":"traceutil/trace.go:171","msg":"trace[1131494304] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:4600; }","duration":"266.46065ms","start":"2026-07-10T21:28:46.956596Z","end":"2026-07-10T21:28:47.223057Z","steps":["trace[1131494304] 'agreement among raft nodes before linearized reading' (duration: 266.349487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:28:47.223195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.192973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-10T21:28:47.223222Z","caller":"traceutil/trace.go:171","msg":"trace[870971426] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4600; }","duration":"266.276795ms","start":"2026-07-10T21:28:46.956938Z","end":"2026-07-10T21:28:47.223215Z","steps":["trace[870971426] 'agreement among raft nodes before linearized reading' (duration: 266.154492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:28:47.223248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.873706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-07-10T21:28:47.223311Z","caller":"traceutil/trace.go:171","msg":"trace[105995415] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4600; }","duration":"243.955609ms","start":"2026-07-10T21:28:46.979333Z","end":"2026-07-10T21:28:47.223288Z","steps":["trace[105995415] 'agreement among raft nodes before linearized reading' (duration: 243.796894ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:28:47.223345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.340767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-10T21:28:47.223379Z","caller":"traceutil/trace.go:171","msg":"trace[1589754085] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4600; }","duration":"264.377857ms","start":"2026-07-10T21:28:46.958985Z","end":"2026-07-10T21:28:47.223363Z","steps":["trace[1589754085] 'agreement among raft nodes before linearized reading' (duration: 264.267824ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:47.391482Z","caller":"traceutil/trace.go:171","msg":"trace[452418018] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"144.361726ms","start":"2026-07-10T21:28:47.247101Z","end":"2026-07-10T21:28:47.391463Z","steps":["trace[452418018] 'process raft request' (duration: 144.242113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:28:47.391816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.080192ms","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-07-10T21:28:47.39195Z","caller":"traceutil/trace.go:171","msg":"trace[1616188028] 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:4607; }","duration":"161.196334ms","start":"2026-07-10T21:28:47.230707Z","end":"2026-07-10T21:28:47.391903Z","steps":["trace[1616188028] 'agreement among raft nodes before linearized reading' (duration: 160.797755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T21:28:47.392763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.836707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-07-10T21:28:47.392907Z","caller":"traceutil/trace.go:171","msg":"trace[569285467] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4607; }","duration":"158.990051ms","start":"2026-07-10T21:28:47.233902Z","end":"2026-07-10T21:28:47.392892Z","steps":["trace[569285467] 'agreement among raft nodes before linearized reading' (duration: 157.562215ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:28:50.290753Z","caller":"traceutil/trace.go:171","msg":"trace[1589789905] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"227.510703ms","start":"2026-07-10T21:28:50.063217Z","end":"2026-07-10T21:28:50.290727Z","steps":["trace[1589789905] 'process raft request' (duration: 227.37137ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T21:30:34.934066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2852} {"level":"info","ts":"2026-07-10T21:30:35.014165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2852,"took":"78.482477ms","hash":308672584,"current-db-size-bytes":54231040,"current-db-size":"54 MB","current-db-size-in-use-bytes":29655040,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-10T21:30:35.014216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":308672584,"revision":2852,"compact-revision":-1} {"level":"info","ts":"2026-07-10T21:35:34.938872Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5574} {"level":"info","ts":"2026-07-10T21:35:35.033823Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5574,"took":"93.852797ms","hash":1837335954,"current-db-size-bytes":54231040,"current-db-size":"54 MB","current-db-size-in-use-bytes":18444288,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-10T21:35:35.033881Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1837335954,"revision":5574,"compact-revision":2852}