{"level":"warn","ts":"2026-04-27T15:59:09.424767Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T15:59:09.424854Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.204.45.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T15:59:09.424918Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T15:59:09.42493Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-27T15:59:09.424948Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T15:59:09.425573Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-27T15:59:09.425653Z","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.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T15:59:09.430615Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.756017ms"} {"level":"info","ts":"2026-04-27T15:59:09.443175Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-27T15:59:09.443256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T15:59:09.443353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-27T15:59:09.443368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T15:59:09.443387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-27T15:59:09.443424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-27T15:59:09.464198Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T15:59:09.469576Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T15:59:09.471569Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T15:59:09.473759Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T15:59:09.473943Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T15:59:09.473969Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T15:59:09.474121Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T15:59:09.47414Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T15:59:09.475355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-27T15:59:09.475583Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-27T15:59:09.477911Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T15:59:09.477996Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-27T15:59:09.478034Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-27T15:59:09.478146Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T15:59:09.478177Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T15:59:10.044543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T15:59:10.04462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T15:59:10.044654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-27T15:59:10.044674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-27T15:59:10.044686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-27T15:59:10.044707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-27T15:59:10.044791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-27T15:59:10.045678Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T15:59:10.046735Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T15:59:10.046781Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T15:59:10.046742Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T15:59:10.046902Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T15:59:10.047042Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T15:59:10.047077Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T15:59:10.047523Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T15:59:10.048354Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T15:59:10.049749Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T15:59:10.057601Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"warn","ts":"2026-04-27T15:59:11.93384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.848049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-27T15:59:11.934138Z","caller":"traceutil/trace.go:171","msg":"trace[2033575099] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"540.104872ms","start":"2026-04-27T15:59:11.394001Z","end":"2026-04-27T15:59:11.934106Z","steps":["trace[2033575099] 'read index received' (duration: 282.334127ms)","trace[2033575099] 'applied index is now lower than readState.Index' (duration: 257.769024ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T15:59:11.934186Z","caller":"traceutil/trace.go:171","msg":"trace[2107377474] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"542.119255ms","start":"2026-04-27T15:59:11.392024Z","end":"2026-04-27T15:59:11.934143Z","steps":["trace[2107377474] 'process raft request' (duration: 284.196031ms)","trace[2107377474] 'compare' (duration: 256.699781ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T15:59:11.934321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.392009Z","time spent":"542.253701ms","remote":"127.0.0.1:54820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:11.934437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.387335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:11.934619Z","caller":"traceutil/trace.go:171","msg":"trace[1386107408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4; }","duration":"540.633172ms","start":"2026-04-27T15:59:11.393958Z","end":"2026-04-27T15:59:11.934592Z","steps":["trace[1386107408] 'agreement among raft nodes before linearized reading' (duration: 540.309351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:11.934684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.393944Z","time spent":"540.721108ms","remote":"127.0.0.1:54398","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-04-27T15:59:12.390309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.13825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-27T15:59:12.390672Z","caller":"traceutil/trace.go:171","msg":"trace[1865255719] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"996.485135ms","start":"2026-04-27T15:59:11.394173Z","end":"2026-04-27T15:59:12.390658Z","steps":["trace[1865255719] 'process raft request' (duration: 687.920174ms)","trace[1865255719] 'compare' (duration: 307.991723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T15:59:12.390763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.579373ms","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":"info","ts":"2026-04-27T15:59:12.390806Z","caller":"traceutil/trace.go:171","msg":"trace[148302682] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"996.655507ms","start":"2026-04-27T15:59:11.394141Z","end":"2026-04-27T15:59:12.390796Z","steps":["trace[148302682] 'agreement among raft nodes before linearized reading' (duration: 996.567621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.390845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394127Z","time spent":"996.709888ms","remote":"127.0.0.1:54486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-27T15:59:12.391008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394155Z","time spent":"996.567ms","remote":"127.0.0.1:54918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:12.39068Z","caller":"traceutil/trace.go:171","msg":"trace[1724072577] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:7; }","duration":"456.435954ms","start":"2026-04-27T15:59:11.934228Z","end":"2026-04-27T15:59:12.390664Z","steps":["trace[1724072577] 'read index received' (duration: 147.875124ms)","trace[1724072577] 'applied index is now lower than readState.Index' (duration: 308.55998ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T15:59:12.391084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.309788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.391122Z","caller":"traceutil/trace.go:171","msg":"trace[338775007] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"923.37214ms","start":"2026-04-27T15:59:11.467741Z","end":"2026-04-27T15:59:12.391113Z","steps":["trace[338775007] 'agreement among raft nodes before linearized reading' (duration: 923.310599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.467731Z","time spent":"923.415768ms","remote":"127.0.0.1:54510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-27T15:59:12.391092Z","caller":"traceutil/trace.go:171","msg":"trace[491188404] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"982.842534ms","start":"2026-04-27T15:59:11.408181Z","end":"2026-04-27T15:59:12.391023Z","steps":["trace[491188404] 'process raft request' (duration: 982.45202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.484322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.391328Z","caller":"traceutil/trace.go:171","msg":"trace[49814131] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"924.541653ms","start":"2026-04-27T15:59:11.466778Z","end":"2026-04-27T15:59:12.391319Z","steps":["trace[49814131] 'agreement among raft nodes before linearized reading' (duration: 924.494654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.466762Z","time spent":"924.585872ms","remote":"127.0.0.1:54510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-27T15:59:12.391476Z","caller":"traceutil/trace.go:171","msg":"trace[75484772] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"997.19466ms","start":"2026-04-27T15:59:11.394269Z","end":"2026-04-27T15:59:12.391464Z","steps":["trace[75484772] 'process raft request' (duration: 996.235708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.497037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.391586Z","caller":"traceutil/trace.go:171","msg":"trace[824997314] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"963.575342ms","start":"2026-04-27T15:59:11.428002Z","end":"2026-04-27T15:59:12.391577Z","steps":["trace[824997314] 'agreement among raft nodes before linearized reading' (duration: 963.472923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.427971Z","time spent":"963.663259ms","remote":"127.0.0.1:54754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-27T15:59:12.391668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.442376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.391703Z","caller":"traceutil/trace.go:171","msg":"trace[933850478] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"997.535204ms","start":"2026-04-27T15:59:11.394159Z","end":"2026-04-27T15:59:12.391694Z","steps":["trace[933850478] 'agreement among raft nodes before linearized reading' (duration: 997.480504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394143Z","time spent":"997.589444ms","remote":"127.0.0.1:54510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-27T15:59:12.391723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394258Z","time spent":"997.307741ms","remote":"127.0.0.1:54918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:12.391901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.092307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.391924Z","caller":"traceutil/trace.go:171","msg":"trace[1826991876] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"925.139826ms","start":"2026-04-27T15:59:11.466777Z","end":"2026-04-27T15:59:12.391917Z","steps":["trace[1826991876] 'agreement among raft nodes before linearized reading' (duration: 925.097758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.39199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.466762Z","time spent":"925.177765ms","remote":"127.0.0.1:54510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-27T15:59:12.39199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.816299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.391996Z","caller":"traceutil/trace.go:171","msg":"trace[1599425863] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"986.778254ms","start":"2026-04-27T15:59:11.405206Z","end":"2026-04-27T15:59:12.391985Z","steps":["trace[1599425863] 'process raft request' (duration: 985.397652ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.392021Z","caller":"traceutil/trace.go:171","msg":"trace[1808135366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"948.889923ms","start":"2026-04-27T15:59:11.443122Z","end":"2026-04-27T15:59:12.392012Z","steps":["trace[1808135366] 'agreement among raft nodes before linearized reading' (duration: 948.845225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.392039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.44311Z","time spent":"948.92554ms","remote":"127.0.0.1:54510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-27T15:59:12.39205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.405196Z","time spent":"986.826373ms","remote":"127.0.0.1:54562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:12.392098Z","caller":"traceutil/trace.go:171","msg":"trace[1313801379] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"997.483363ms","start":"2026-04-27T15:59:11.394609Z","end":"2026-04-27T15:59:12.392092Z","steps":["trace[1313801379] 'process raft request' (duration: 995.967206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.391288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.408168Z","time spent":"983.070338ms","remote":"127.0.0.1:54634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:12.392132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394591Z","time spent":"997.523301ms","remote":"127.0.0.1:54918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:12.392198Z","caller":"traceutil/trace.go:171","msg":"trace[753320898] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"997.768458ms","start":"2026-04-27T15:59:11.394424Z","end":"2026-04-27T15:59:12.392193Z","steps":["trace[753320898] 'process raft request' (duration: 996.109624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.392225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394402Z","time spent":"997.810706ms","remote":"127.0.0.1:54918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:12.390646Z","caller":"traceutil/trace.go:171","msg":"trace[874857515] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"996.422363ms","start":"2026-04-27T15:59:11.394199Z","end":"2026-04-27T15:59:12.390621Z","steps":["trace[874857515] 'process raft request' (duration: 996.227536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.392607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.394181Z","time spent":"998.370442ms","remote":"127.0.0.1:54918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:12.485681Z","caller":"traceutil/trace.go:171","msg":"trace[674083884] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"547.668848ms","start":"2026-04-27T15:59:11.937976Z","end":"2026-04-27T15:59:12.485645Z","steps":["trace[674083884] 'process raft request' (duration: 547.535173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.485837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.223252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T15:59:12.485835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.202919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.485994Z","caller":"traceutil/trace.go:171","msg":"trace[775973842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"148.396114ms","start":"2026-04-27T15:59:12.337552Z","end":"2026-04-27T15:59:12.485948Z","steps":["trace[775973842] 'agreement among raft nodes before linearized reading' (duration: 148.217631ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.486046Z","caller":"traceutil/trace.go:171","msg":"trace[698170538] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:12; }","duration":"194.447495ms","start":"2026-04-27T15:59:12.291588Z","end":"2026-04-27T15:59:12.486036Z","steps":["trace[698170538] 'agreement among raft nodes before linearized reading' (duration: 194.125164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.485919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.690511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T15:59:12.486118Z","caller":"traceutil/trace.go:171","msg":"trace[1861349263] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:12; }","duration":"196.050129ms","start":"2026-04-27T15:59:12.29005Z","end":"2026-04-27T15:59:12.4861Z","steps":["trace[1861349263] 'agreement among raft nodes before linearized reading' (duration: 195.697362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.486628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:11.937956Z","time spent":"547.975206ms","remote":"127.0.0.1:54820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:12.498229Z","caller":"traceutil/trace.go:171","msg":"trace[995382589] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"101.652493ms","start":"2026-04-27T15:59:12.396547Z","end":"2026-04-27T15:59:12.498199Z","steps":["trace[995382589] 'process raft request' (duration: 101.519127ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.498313Z","caller":"traceutil/trace.go:171","msg":"trace[207028827] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"101.741479ms","start":"2026-04-27T15:59:12.396556Z","end":"2026-04-27T15:59:12.498298Z","steps":["trace[207028827] 'process raft request' (duration: 101.572667ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.498507Z","caller":"traceutil/trace.go:171","msg":"trace[291547961] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"101.957351ms","start":"2026-04-27T15:59:12.396541Z","end":"2026-04-27T15:59:12.498499Z","steps":["trace[291547961] 'process raft request' (duration: 101.555774ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.498472Z","caller":"traceutil/trace.go:171","msg":"trace[769846320] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"102.019363ms","start":"2026-04-27T15:59:12.396403Z","end":"2026-04-27T15:59:12.498423Z","steps":["trace[769846320] 'process raft request' (duration: 97.652795ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.498698Z","caller":"traceutil/trace.go:171","msg":"trace[268478614] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"100.904831ms","start":"2026-04-27T15:59:12.397786Z","end":"2026-04-27T15:59:12.49869Z","steps":["trace[268478614] 'process raft request' (duration: 100.412956ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.498814Z","caller":"traceutil/trace.go:171","msg":"trace[137429885] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"101.387484ms","start":"2026-04-27T15:59:12.397419Z","end":"2026-04-27T15:59:12.498806Z","steps":["trace[137429885] 'process raft request' (duration: 100.760974ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:12.49882Z","caller":"traceutil/trace.go:171","msg":"trace[1168874812] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"101.480231ms","start":"2026-04-27T15:59:12.397311Z","end":"2026-04-27T15:59:12.498792Z","steps":["trace[1168874812] 'process raft request' (duration: 100.84687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.499094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.58714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-b7dnj\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-27T15:59:12.499133Z","caller":"traceutil/trace.go:171","msg":"trace[1271021097] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-b7dnj; range_end:; response_count:1; response_revision:21; }","duration":"102.667816ms","start":"2026-04-27T15:59:12.396457Z","end":"2026-04-27T15:59:12.499125Z","steps":["trace[1271021097] 'agreement among raft nodes before linearized reading' (duration: 102.573458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:12.499094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.58719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-04-27T15:59:12.4992Z","caller":"traceutil/trace.go:171","msg":"trace[552387907] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21; }","duration":"102.712814ms","start":"2026-04-27T15:59:12.396469Z","end":"2026-04-27T15:59:12.499182Z","steps":["trace[552387907] 'agreement among raft nodes before linearized reading' (duration: 102.571197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:17.92782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.118789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-27T15:59:17.927914Z","caller":"traceutil/trace.go:171","msg":"trace[1613290474] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:290; }","duration":"156.271677ms","start":"2026-04-27T15:59:17.771622Z","end":"2026-04-27T15:59:17.927894Z","steps":["trace[1613290474] 'range keys from in-memory index tree' (duration: 155.984894ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:43.799334Z","caller":"traceutil/trace.go:171","msg":"trace[1806648714] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"443.800556ms","start":"2026-04-27T15:59:43.35549Z","end":"2026-04-27T15:59:43.79929Z","steps":["trace[1806648714] 'process raft request' (duration: 443.282428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.799567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.355467Z","time spent":"443.966834ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.79967Z","caller":"traceutil/trace.go:171","msg":"trace[469716232] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"440.858334ms","start":"2026-04-27T15:59:43.358784Z","end":"2026-04-27T15:59:43.799642Z","steps":["trace[469716232] 'process raft request' (duration: 440.389244ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:43.799806Z","caller":"traceutil/trace.go:171","msg":"trace[1892323135] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"430.053492ms","start":"2026-04-27T15:59:43.36972Z","end":"2026-04-27T15:59:43.799773Z","steps":["trace[1892323135] 'process raft request' (duration: 429.630441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.799838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.358775Z","time spent":"441.010841ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:43.799863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.369693Z","time spent":"430.143037ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.800036Z","caller":"traceutil/trace.go:171","msg":"trace[17900431] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"425.062511ms","start":"2026-04-27T15:59:43.374952Z","end":"2026-04-27T15:59:43.800015Z","steps":["trace[17900431] 'process raft request' (duration: 424.610704ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:43.800032Z","caller":"traceutil/trace.go:171","msg":"trace[311233238] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"441.381253ms","start":"2026-04-27T15:59:43.358579Z","end":"2026-04-27T15:59:43.79996Z","steps":["trace[311233238] 'process raft request' (duration: 440.490972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.800143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.374938Z","time spent":"425.147286ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.800132Z","caller":"traceutil/trace.go:171","msg":"trace[1910917140] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"424.769751ms","start":"2026-04-27T15:59:43.375334Z","end":"2026-04-27T15:59:43.800104Z","steps":["trace[1910917140] 'process raft request' (duration: 424.324745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.800219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.358569Z","time spent":"441.544981ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:43.800331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.375326Z","time spent":"424.911977ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.800601Z","caller":"traceutil/trace.go:171","msg":"trace[1689691104] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"412.989894ms","start":"2026-04-27T15:59:43.387588Z","end":"2026-04-27T15:59:43.800577Z","steps":["trace[1689691104] 'process raft request' (duration: 412.666589ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:43.800613Z","caller":"traceutil/trace.go:171","msg":"trace[1676461456] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"427.182012ms","start":"2026-04-27T15:59:43.372854Z","end":"2026-04-27T15:59:43.800036Z","steps":["trace[1676461456] 'process raft request' (duration: 426.557516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.800746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.387562Z","time spent":"413.13634ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.800773Z","caller":"traceutil/trace.go:171","msg":"trace[1136208917] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"411.253968ms","start":"2026-04-27T15:59:43.389501Z","end":"2026-04-27T15:59:43.800755Z","steps":["trace[1136208917] 'process raft request' (duration: 410.965449ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:43.800827Z","caller":"traceutil/trace.go:171","msg":"trace[149964483] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"425.05321ms","start":"2026-04-27T15:59:43.375723Z","end":"2026-04-27T15:59:43.800776Z","steps":["trace[149964483] 'process raft request' (duration: 424.348169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.800962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.389489Z","time spent":"411.368188ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.801007Z","caller":"traceutil/trace.go:171","msg":"trace[1108202543] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"392.589036ms","start":"2026-04-27T15:59:43.408398Z","end":"2026-04-27T15:59:43.800987Z","steps":["trace[1108202543] 'process raft request' (duration: 392.227114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.80103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.372831Z","time spent":"427.893884ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:43.801014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.375715Z","time spent":"425.174651ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.801219Z","caller":"traceutil/trace.go:171","msg":"trace[1507893418] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"325.181255ms","start":"2026-04-27T15:59:43.476017Z","end":"2026-04-27T15:59:43.801198Z","steps":["trace[1507893418] 'process raft request' (duration: 324.788718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.801176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.408367Z","time spent":"392.727229ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T15:59:43.801504Z","caller":"traceutil/trace.go:171","msg":"trace[1116270378] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"264.553759ms","start":"2026-04-27T15:59:43.5369Z","end":"2026-04-27T15:59:43.801453Z","steps":["trace[1116270378] 'process raft request' (duration: 264.412775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:43.801739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:43.475993Z","time spent":"325.280032ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T15:59:43.801778Z","caller":"traceutil/trace.go:171","msg":"trace[1912012159] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"171.16988ms","start":"2026-04-27T15:59:43.630597Z","end":"2026-04-27T15:59:43.801767Z","steps":["trace[1912012159] 'process raft request' (duration: 171.001811ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:44.182076Z","caller":"traceutil/trace.go:171","msg":"trace[231978831] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"191.927146ms","start":"2026-04-27T15:59:43.990117Z","end":"2026-04-27T15:59:44.182044Z","steps":["trace[231978831] 'process raft request' (duration: 184.355558ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:44.182772Z","caller":"traceutil/trace.go:171","msg":"trace[2144476452] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"146.274473ms","start":"2026-04-27T15:59:44.036484Z","end":"2026-04-27T15:59:44.182759Z","steps":["trace[2144476452] 'process raft request' (duration: 146.114676ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:44.419369Z","caller":"traceutil/trace.go:171","msg":"trace[1499262466] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"123.781707ms","start":"2026-04-27T15:59:44.295562Z","end":"2026-04-27T15:59:44.419344Z","steps":["trace[1499262466] 'process raft request' (duration: 123.584483ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:44.423971Z","caller":"traceutil/trace.go:171","msg":"trace[720513948] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"126.234474ms","start":"2026-04-27T15:59:44.297699Z","end":"2026-04-27T15:59:44.423933Z","steps":["trace[720513948] 'process raft request' (duration: 125.940054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.478764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528383218878437,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T15:59:49.488412Z","caller":"traceutil/trace.go:171","msg":"trace[984971950] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"510.073991ms","start":"2026-04-27T15:59:48.9783Z","end":"2026-04-27T15:59:49.488374Z","steps":["trace[984971950] 'read index received' (duration: 509.866016ms)","trace[984971950] 'applied index is now lower than readState.Index' (duration: 206.925µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T15:59:49.488734Z","caller":"traceutil/trace.go:171","msg":"trace[187327412] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"530.513592ms","start":"2026-04-27T15:59:48.958205Z","end":"2026-04-27T15:59:49.488718Z","steps":["trace[187327412] 'process raft request' (duration: 530.02359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.488845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:48.958178Z","time spent":"530.594956ms","remote":"127.0.0.1:54718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T15:59:49.489125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.811816ms","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-04-27T15:59:49.490166Z","caller":"traceutil/trace.go:171","msg":"trace[267833648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:575; }","duration":"511.883236ms","start":"2026-04-27T15:59:48.978268Z","end":"2026-04-27T15:59:49.490151Z","steps":["trace[267833648] 'agreement among raft nodes before linearized reading' (duration: 510.790102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.490271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:48.978238Z","time spent":"512.014508ms","remote":"127.0.0.1:36954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T15:59:49.489299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.937467ms","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-04-27T15:59:49.490856Z","caller":"traceutil/trace.go:171","msg":"trace[148058487] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:575; }","duration":"512.426308ms","start":"2026-04-27T15:59:48.978321Z","end":"2026-04-27T15:59:49.490747Z","steps":["trace[148058487] 'agreement among raft nodes before linearized reading' (duration: 510.947429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.49101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:48.978279Z","time spent":"512.622511ms","remote":"127.0.0.1:36954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.48934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.188935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.492425Z","caller":"traceutil/trace.go:171","msg":"trace[1345243036] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:575; }","duration":"405.23496ms","start":"2026-04-27T15:59:49.086126Z","end":"2026-04-27T15:59:49.491361Z","steps":["trace[1345243036] 'agreement among raft nodes before linearized reading' (duration: 403.194396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.492505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.086119Z","time spent":"406.369091ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-27T15:59:49.489402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.343731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.492665Z","caller":"traceutil/trace.go:171","msg":"trace[859931027] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:575; }","duration":"406.634855ms","start":"2026-04-27T15:59:49.086019Z","end":"2026-04-27T15:59:49.492654Z","steps":["trace[859931027] 'agreement among raft nodes before linearized reading' (duration: 403.3407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.492707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.086009Z","time spent":"406.684894ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.489454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.879774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.49285Z","caller":"traceutil/trace.go:171","msg":"trace[1761594279] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:575; }","duration":"359.418159ms","start":"2026-04-27T15:59:49.133422Z","end":"2026-04-27T15:59:49.49284Z","steps":["trace[1761594279] 'agreement among raft nodes before linearized reading' (duration: 355.886425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.492889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.133394Z","time spent":"359.483831ms","remote":"127.0.0.1:37022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T15:59:49.489475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.42902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.493069Z","caller":"traceutil/trace.go:171","msg":"trace[1305684286] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"430.044649ms","start":"2026-04-27T15:59:49.063014Z","end":"2026-04-27T15:59:49.493058Z","steps":["trace[1305684286] 'agreement among raft nodes before linearized reading' (duration: 426.421299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.49311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.063007Z","time spent":"430.090757ms","remote":"127.0.0.1:36980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T15:59:49.489516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.713588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.493326Z","caller":"traceutil/trace.go:171","msg":"trace[302388964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"430.521559ms","start":"2026-04-27T15:59:49.062795Z","end":"2026-04-27T15:59:49.493317Z","steps":["trace[302388964] 'agreement among raft nodes before linearized reading' (duration: 426.700606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.493369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.06277Z","time spent":"430.58732ms","remote":"127.0.0.1:36980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.48955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.833799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.493734Z","caller":"traceutil/trace.go:171","msg":"trace[758311819] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"431.040248ms","start":"2026-04-27T15:59:49.062685Z","end":"2026-04-27T15:59:49.493725Z","steps":["trace[758311819] 'agreement among raft nodes before linearized reading' (duration: 426.846661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.493776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.062674Z","time spent":"431.090647ms","remote":"127.0.0.1:36980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T15:59:49.489581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.864247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.493986Z","caller":"traceutil/trace.go:171","msg":"trace[1190829429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"462.319468ms","start":"2026-04-27T15:59:49.031654Z","end":"2026-04-27T15:59:49.493973Z","steps":["trace[1190829429] 'agreement among raft nodes before linearized reading' (duration: 457.910555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.494036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.031607Z","time spent":"462.412453ms","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.48961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.896132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.494259Z","caller":"traceutil/trace.go:171","msg":"trace[211825865] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"462.559068ms","start":"2026-04-27T15:59:49.031686Z","end":"2026-04-27T15:59:49.494245Z","steps":["trace[211825865] 'agreement among raft nodes before linearized reading' (duration: 457.908865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.494311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.031679Z","time spent":"462.618738ms","remote":"127.0.0.1:36966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T15:59:49.489627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.963748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.49453Z","caller":"traceutil/trace.go:171","msg":"trace[1234997187] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:575; }","duration":"260.885917ms","start":"2026-04-27T15:59:49.233633Z","end":"2026-04-27T15:59:49.494519Z","steps":["trace[1234997187] 'agreement among raft nodes before linearized reading' (duration: 255.957187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.489644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.956832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.494747Z","caller":"traceutil/trace.go:171","msg":"trace[869666963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"463.095958ms","start":"2026-04-27T15:59:49.031642Z","end":"2026-04-27T15:59:49.494738Z","steps":["trace[869666963] 'agreement among raft nodes before linearized reading' (duration: 457.982897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.494792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.031611Z","time spent":"463.16674ms","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T15:59:49.489675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.447442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.495031Z","caller":"traceutil/trace.go:171","msg":"trace[1028980826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"485.856683ms","start":"2026-04-27T15:59:49.009148Z","end":"2026-04-27T15:59:49.495005Z","steps":["trace[1028980826] 'agreement among raft nodes before linearized reading' (duration: 480.510732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.495076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.009127Z","time spent":"485.933376ms","remote":"127.0.0.1:36966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.489725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.573183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.49521Z","caller":"traceutil/trace.go:171","msg":"trace[366470571] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:575; }","duration":"486.103505ms","start":"2026-04-27T15:59:49.009098Z","end":"2026-04-27T15:59:49.495201Z","steps":["trace[366470571] 'agreement among raft nodes before linearized reading' (duration: 480.591927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.495245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.009083Z","time spent":"486.151393ms","remote":"127.0.0.1:36966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T15:59:49.489728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.089499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.495378Z","caller":"traceutil/trace.go:171","msg":"trace[1904002477] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:575; }","duration":"261.779528ms","start":"2026-04-27T15:59:49.233585Z","end":"2026-04-27T15:59:49.495365Z","steps":["trace[1904002477] 'agreement among raft nodes before linearized reading' (duration: 256.103702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.489756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.988576ms","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":"info","ts":"2026-04-27T15:59:49.495675Z","caller":"traceutil/trace.go:171","msg":"trace[954887548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:575; }","duration":"516.940708ms","start":"2026-04-27T15:59:48.978717Z","end":"2026-04-27T15:59:49.495658Z","steps":["trace[954887548] 'agreement among raft nodes before linearized reading' (duration: 511.023221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.496955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:48.978698Z","time spent":"518.243468ms","remote":"127.0.0.1:36954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T15:59:49.489789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.108701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.497133Z","caller":"traceutil/trace.go:171","msg":"trace[796159255] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:575; }","duration":"264.495507ms","start":"2026-04-27T15:59:49.232629Z","end":"2026-04-27T15:59:49.497125Z","steps":["trace[796159255] 'agreement among raft nodes before linearized reading' (duration: 257.130615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.489903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.655729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.49729Z","caller":"traceutil/trace.go:171","msg":"trace[1152165174] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:575; }","duration":"394.074769ms","start":"2026-04-27T15:59:49.103208Z","end":"2026-04-27T15:59:49.497283Z","steps":["trace[1152165174] 'agreement among raft nodes before linearized reading' (duration: 386.668321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.497321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.103194Z","time spent":"394.116966ms","remote":"127.0.0.1:37008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.489803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.483181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.497639Z","caller":"traceutil/trace.go:171","msg":"trace[304683585] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:575; }","duration":"393.335544ms","start":"2026-04-27T15:59:49.104296Z","end":"2026-04-27T15:59:49.497632Z","steps":["trace[304683585] 'agreement among raft nodes before linearized reading' (duration: 385.486061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.497668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.104288Z","time spent":"393.37139ms","remote":"127.0.0.1:37008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-27T15:59:49.489836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.248844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T15:59:49.489843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.231201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.497757Z","caller":"traceutil/trace.go:171","msg":"trace[1575055136] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:575; }","duration":"365.174519ms","start":"2026-04-27T15:59:49.132577Z","end":"2026-04-27T15:59:49.497752Z","steps":["trace[1575055136] 'agreement among raft nodes before linearized reading' (duration: 357.239692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.497783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.132561Z","time spent":"365.214786ms","remote":"127.0.0.1:37022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-27T15:59:49.497732Z","caller":"traceutil/trace.go:171","msg":"trace[24613121] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:575; }","duration":"365.169188ms","start":"2026-04-27T15:59:49.132554Z","end":"2026-04-27T15:59:49.497723Z","steps":["trace[24613121] 'agreement among raft nodes before linearized reading' (duration: 357.264506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.497869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.13253Z","time spent":"365.327205ms","remote":"127.0.0.1:37022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T15:59:49.489876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.6026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.497952Z","caller":"traceutil/trace.go:171","msg":"trace[1376167579] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:575; }","duration":"394.692863ms","start":"2026-04-27T15:59:49.103252Z","end":"2026-04-27T15:59:49.497945Z","steps":["trace[1376167579] 'agreement among raft nodes before linearized reading' (duration: 386.608431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.497974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.103248Z","time spent":"394.718517ms","remote":"127.0.0.1:37008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-27T15:59:49.498151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.913885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T15:59:49.498181Z","caller":"traceutil/trace.go:171","msg":"trace[1384013931] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:575; }","duration":"411.968284ms","start":"2026-04-27T15:59:49.086205Z","end":"2026-04-27T15:59:49.498174Z","steps":["trace[1384013931] 'agreement among raft nodes before linearized reading' (duration: 411.896812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:49.498237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:49.086167Z","time spent":"412.06297ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-27T15:59:50.590385Z","caller":"traceutil/trace.go:171","msg":"trace[2075159283] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"137.887473ms","start":"2026-04-27T15:59:50.452468Z","end":"2026-04-27T15:59:50.590355Z","steps":["trace[2075159283] 'read index received' (duration: 136.79798ms)","trace[2075159283] 'applied index is now lower than readState.Index' (duration: 1.088562ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T15:59:50.590615Z","caller":"traceutil/trace.go:171","msg":"trace[1321008780] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"151.202122ms","start":"2026-04-27T15:59:50.439262Z","end":"2026-04-27T15:59:50.590464Z","steps":["trace[1321008780] 'process raft request' (duration: 150.366011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:50.590669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.17211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T15:59:50.590886Z","caller":"traceutil/trace.go:171","msg":"trace[236609785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"138.453077ms","start":"2026-04-27T15:59:50.452413Z","end":"2026-04-27T15:59:50.590866Z","steps":["trace[236609785] 'agreement among raft nodes before linearized reading' (duration: 138.097038ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:50.792578Z","caller":"traceutil/trace.go:171","msg":"trace[1756297448] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"196.67399ms","start":"2026-04-27T15:59:50.595858Z","end":"2026-04-27T15:59:50.792532Z","steps":["trace[1756297448] 'process raft request' (duration: 127.738916ms)","trace[1756297448] 'compare' (duration: 68.767936ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T15:59:50.830018Z","caller":"traceutil/trace.go:171","msg":"trace[1850456125] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"181.829934ms","start":"2026-04-27T15:59:50.648149Z","end":"2026-04-27T15:59:50.829979Z","steps":["trace[1850456125] 'process raft request' (duration: 181.604355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:51.786882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.591169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pxnqf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-27T15:59:51.787035Z","caller":"traceutil/trace.go:171","msg":"trace[592096594] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pxnqf; range_end:; response_count:1; response_revision:586; }","duration":"864.802175ms","start":"2026-04-27T15:59:50.92219Z","end":"2026-04-27T15:59:51.786993Z","steps":["trace[592096594] 'range keys from in-memory index tree' (duration: 863.446678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:51.787127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:50.922167Z","time spent":"864.947399ms","remote":"127.0.0.1:54570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-pxnqf\" "} {"level":"info","ts":"2026-04-27T15:59:51.789673Z","caller":"traceutil/trace.go:171","msg":"trace[190522022] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"544.935271ms","start":"2026-04-27T15:59:51.244685Z","end":"2026-04-27T15:59:51.789621Z","steps":["trace[190522022] 'process raft request' (duration: 536.654031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T15:59:51.789867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T15:59:51.244654Z","time spent":"545.119702ms","remote":"127.0.0.1:54494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T15:59:54.184963Z","caller":"traceutil/trace.go:171","msg":"trace[1187275325] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"104.118959ms","start":"2026-04-27T15:59:54.080818Z","end":"2026-04-27T15:59:54.184937Z","steps":["trace[1187275325] 'process raft request' (duration: 101.24844ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:54.187876Z","caller":"traceutil/trace.go:171","msg":"trace[637667142] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"105.374479ms","start":"2026-04-27T15:59:54.082478Z","end":"2026-04-27T15:59:54.187852Z","steps":["trace[637667142] 'process raft request' (duration: 105.144781ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:57.523647Z","caller":"traceutil/trace.go:171","msg":"trace[1297052803] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"103.993183ms","start":"2026-04-27T15:59:57.419623Z","end":"2026-04-27T15:59:57.523616Z","steps":["trace[1297052803] 'process raft request' (duration: 103.73327ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T15:59:57.62914Z","caller":"traceutil/trace.go:171","msg":"trace[33369831] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"124.590268ms","start":"2026-04-27T15:59:57.504509Z","end":"2026-04-27T15:59:57.629099Z","steps":["trace[33369831] 'process raft request' (duration: 95.585243ms)","trace[33369831] 'compare' (duration: 28.590437ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:00:15.927025Z","caller":"traceutil/trace.go:171","msg":"trace[1536441906] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"175.716986ms","start":"2026-04-27T16:00:15.751234Z","end":"2026-04-27T16:00:15.926951Z","steps":["trace[1536441906] 'read index received' (duration: 175.544738ms)","trace[1536441906] 'applied index is now lower than readState.Index' (duration: 170.348µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:00:15.927265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.024126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:00:15.92734Z","caller":"traceutil/trace.go:171","msg":"trace[1241081295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:778; }","duration":"176.145626ms","start":"2026-04-27T16:00:15.751182Z","end":"2026-04-27T16:00:15.927328Z","steps":["trace[1241081295] 'agreement among raft nodes before linearized reading' (duration: 176.035098ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:15.92725Z","caller":"traceutil/trace.go:171","msg":"trace[1074661233] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"253.893093ms","start":"2026-04-27T16:00:15.673337Z","end":"2026-04-27T16:00:15.92723Z","steps":["trace[1074661233] 'process raft request' (duration: 253.456431ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:15.935401Z","caller":"traceutil/trace.go:171","msg":"trace[2108578289] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"166.229447ms","start":"2026-04-27T16:00:15.769136Z","end":"2026-04-27T16:00:15.935365Z","steps":["trace[2108578289] 'process raft request' (duration: 166.032615ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:25.916444Z","caller":"traceutil/trace.go:171","msg":"trace[485964467] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"132.248663ms","start":"2026-04-27T16:00:25.784166Z","end":"2026-04-27T16:00:25.916415Z","steps":["trace[485964467] 'process raft request' (duration: 114.108803ms)","trace[485964467] 'compare' (duration: 18.025401ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:00:26.175468Z","caller":"traceutil/trace.go:171","msg":"trace[587074161] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"124.006165ms","start":"2026-04-27T16:00:26.051428Z","end":"2026-04-27T16:00:26.175434Z","steps":["trace[587074161] 'process raft request' (duration: 121.859888ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:26.327399Z","caller":"traceutil/trace.go:171","msg":"trace[541683503] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"145.870848ms","start":"2026-04-27T16:00:26.181504Z","end":"2026-04-27T16:00:26.327375Z","steps":["trace[541683503] 'process raft request' (duration: 143.892147ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:26.328759Z","caller":"traceutil/trace.go:171","msg":"trace[709324928] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"146.898745ms","start":"2026-04-27T16:00:26.181812Z","end":"2026-04-27T16:00:26.328711Z","steps":["trace[709324928] 'process raft request' (duration: 145.468053ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:26.328833Z","caller":"traceutil/trace.go:171","msg":"trace[457360476] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"145.7003ms","start":"2026-04-27T16:00:26.183077Z","end":"2026-04-27T16:00:26.328778Z","steps":["trace[457360476] 'process raft request' (duration: 145.497587ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:26.332611Z","caller":"traceutil/trace.go:171","msg":"trace[1208551912] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"102.754123ms","start":"2026-04-27T16:00:26.229839Z","end":"2026-04-27T16:00:26.332594Z","steps":["trace[1208551912] 'process raft request' (duration: 102.557712ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:45.289834Z","caller":"traceutil/trace.go:171","msg":"trace[22039000] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"116.863755ms","start":"2026-04-27T16:00:45.172939Z","end":"2026-04-27T16:00:45.289802Z","steps":["trace[22039000] 'process raft request' (duration: 116.731114ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:00:46.713978Z","caller":"traceutil/trace.go:171","msg":"trace[2010220162] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"136.504114ms","start":"2026-04-27T16:00:46.577445Z","end":"2026-04-27T16:00:46.713949Z","steps":["trace[2010220162] 'process raft request' (duration: 136.332205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:20.352343Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528383218879637,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:20.738738Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.212779035s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T16:01:20.739172Z","caller":"traceutil/trace.go:171","msg":"trace[1195310064] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"1.206494312s","start":"2026-04-27T16:01:19.532651Z","end":"2026-04-27T16:01:20.739146Z","steps":["trace[1195310064] 'read index received' (duration: 1.20623222s)","trace[1195310064] 'applied index is now lower than readState.Index' (duration: 261.062µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:20.739308Z","caller":"traceutil/trace.go:171","msg":"trace[980333482] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"1.213402205s","start":"2026-04-27T16:01:19.525862Z","end":"2026-04-27T16:01:20.739264Z","steps":["trace[980333482] 'process raft request' (duration: 1.213061091s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:20.739394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206733471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-27T16:01:20.739398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.868065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:20.739401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.439535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T16:01:20.739443Z","caller":"traceutil/trace.go:171","msg":"trace[1001786753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1121; }","duration":"1.206826185s","start":"2026-04-27T16:01:19.532602Z","end":"2026-04-27T16:01:20.739429Z","steps":["trace[1001786753] 'agreement among raft nodes before linearized reading' (duration: 1.206643766s)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:20.739453Z","caller":"traceutil/trace.go:171","msg":"trace[1975018171] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1121; }","duration":"110.944287ms","start":"2026-04-27T16:01:20.628494Z","end":"2026-04-27T16:01:20.739438Z","steps":["trace[1975018171] 'agreement among raft nodes before linearized reading' (duration: 110.830278ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:20.739462Z","caller":"traceutil/trace.go:171","msg":"trace[817478567] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1121; }","duration":"385.532409ms","start":"2026-04-27T16:01:20.353915Z","end":"2026-04-27T16:01:20.739447Z","steps":["trace[817478567] 'agreement among raft nodes before linearized reading' (duration: 385.377524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:20.739466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:19.525838Z","time spent":"1.213541556s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:01:20.739462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.388126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:20.739485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:19.532585Z","time spent":"1.206888825s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T16:01:20.739504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:20.353875Z","time spent":"385.617723ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-27T16:01:20.739533Z","caller":"traceutil/trace.go:171","msg":"trace[1291479533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1121; }","duration":"384.508495ms","start":"2026-04-27T16:01:20.355009Z","end":"2026-04-27T16:01:20.739518Z","steps":["trace[1291479533] 'agreement among raft nodes before linearized reading' (duration: 384.3477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:20.739565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:20.354999Z","time spent":"384.559664ms","remote":"127.0.0.1:54414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T16:01:24.982218Z","caller":"traceutil/trace.go:171","msg":"trace[1726750434] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"217.133948ms","start":"2026-04-27T16:01:24.765061Z","end":"2026-04-27T16:01:24.982195Z","steps":["trace[1726750434] 'read index received' (duration: 216.990925ms)","trace[1726750434] 'applied index is now lower than readState.Index' (duration: 142.162µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:24.982293Z","caller":"traceutil/trace.go:171","msg":"trace[734367095] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"226.16675ms","start":"2026-04-27T16:01:24.756105Z","end":"2026-04-27T16:01:24.982272Z","steps":["trace[734367095] 'process raft request' (duration: 225.944594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:24.982461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.668864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T16:01:24.982496Z","caller":"traceutil/trace.go:171","msg":"trace[1622640632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1134; }","duration":"216.774811ms","start":"2026-04-27T16:01:24.765712Z","end":"2026-04-27T16:01:24.982486Z","steps":["trace[1622640632] 'agreement among raft nodes before linearized reading' (duration: 216.631428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:24.98251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.425414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T16:01:24.982588Z","caller":"traceutil/trace.go:171","msg":"trace[197985295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1134; }","duration":"217.561356ms","start":"2026-04-27T16:01:24.765006Z","end":"2026-04-27T16:01:24.982568Z","steps":["trace[197985295] 'agreement among raft nodes before linearized reading' (duration: 217.306725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:24.982542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.357072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T16:01:24.982664Z","caller":"traceutil/trace.go:171","msg":"trace[1291336414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1134; }","duration":"179.52948ms","start":"2026-04-27T16:01:24.803112Z","end":"2026-04-27T16:01:24.982641Z","steps":["trace[1291336414] 'agreement among raft nodes before linearized reading' (duration: 179.261237ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.198792Z","caller":"traceutil/trace.go:171","msg":"trace[1786728187] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1217; }","duration":"149.206072ms","start":"2026-04-27T16:01:35.049567Z","end":"2026-04-27T16:01:35.198773Z","steps":["trace[1786728187] 'read index received' (duration: 149.043886ms)","trace[1786728187] 'applied index is now lower than readState.Index' (duration: 161.536µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:35.199637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.599326ms","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-04-27T16:01:35.199844Z","caller":"traceutil/trace.go:171","msg":"trace[706992834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1167; }","duration":"147.049088ms","start":"2026-04-27T16:01:35.052783Z","end":"2026-04-27T16:01:35.199832Z","steps":["trace[706992834] 'agreement among raft nodes before linearized reading' (duration: 146.552589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:35.199437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.847505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-27T16:01:35.199997Z","caller":"traceutil/trace.go:171","msg":"trace[717654532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1167; }","duration":"150.475574ms","start":"2026-04-27T16:01:35.049514Z","end":"2026-04-27T16:01:35.199989Z","steps":["trace[717654532] 'agreement among raft nodes before linearized reading' (duration: 149.732036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:35.199744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.325023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-27T16:01:35.199778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.876042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-27T16:01:35.200263Z","caller":"traceutil/trace.go:171","msg":"trace[1696758454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1167; }","duration":"145.794638ms","start":"2026-04-27T16:01:35.054397Z","end":"2026-04-27T16:01:35.200192Z","steps":["trace[1696758454] 'agreement among raft nodes before linearized reading' (duration: 145.275725ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.200341Z","caller":"traceutil/trace.go:171","msg":"trace[215317718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1167; }","duration":"146.473536ms","start":"2026-04-27T16:01:35.053857Z","end":"2026-04-27T16:01:35.20033Z","steps":["trace[215317718] 'agreement among raft nodes before linearized reading' (duration: 145.852087ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.200305Z","caller":"traceutil/trace.go:171","msg":"trace[329146084] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"181.939539ms","start":"2026-04-27T16:01:35.017319Z","end":"2026-04-27T16:01:35.199259Z","steps":["trace[329146084] 'process raft request' (duration: 181.344865ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.349414Z","caller":"traceutil/trace.go:171","msg":"trace[1646027166] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"140.555943ms","start":"2026-04-27T16:01:35.208843Z","end":"2026-04-27T16:01:35.349399Z","steps":["trace[1646027166] 'process raft request' (duration: 140.525178ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.349459Z","caller":"traceutil/trace.go:171","msg":"trace[665620559] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"141.640796ms","start":"2026-04-27T16:01:35.207803Z","end":"2026-04-27T16:01:35.349444Z","steps":["trace[665620559] 'process raft request' (duration: 141.515296ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.349489Z","caller":"traceutil/trace.go:171","msg":"trace[1249612222] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"141.635534ms","start":"2026-04-27T16:01:35.207844Z","end":"2026-04-27T16:01:35.34948Z","steps":["trace[1249612222] 'process raft request' (duration: 141.501453ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:35.349422Z","caller":"traceutil/trace.go:171","msg":"trace[1714530617] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"141.648296ms","start":"2026-04-27T16:01:35.207744Z","end":"2026-04-27T16:01:35.349392Z","steps":["trace[1714530617] 'process raft request' (duration: 110.443003ms)","trace[1714530617] 'compare' (duration: 31.037497ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:53.419076Z","caller":"traceutil/trace.go:171","msg":"trace[1426112719] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"101.350119ms","start":"2026-04-27T16:01:53.31769Z","end":"2026-04-27T16:01:53.41904Z","steps":["trace[1426112719] 'process raft request' (duration: 100.948285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.042271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528383218880088,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T16:02:06.345203Z","caller":"traceutil/trace.go:171","msg":"trace[1982508412] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1355; }","duration":"802.95925ms","start":"2026-04-27T16:02:05.542226Z","end":"2026-04-27T16:02:06.345185Z","steps":["trace[1982508412] 'read index received' (duration: 802.768309ms)","trace[1982508412] 'applied index is now lower than readState.Index' (duration: 190.341µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:06.345357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.130957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T16:02:06.345382Z","caller":"traceutil/trace.go:171","msg":"trace[255018977] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1297; }","duration":"803.202849ms","start":"2026-04-27T16:02:05.54217Z","end":"2026-04-27T16:02:06.345373Z","steps":["trace[255018977] 'agreement among raft nodes before linearized reading' (duration: 803.105833ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:06.345332Z","caller":"traceutil/trace.go:171","msg":"trace[1746519627] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"825.463672ms","start":"2026-04-27T16:02:05.519827Z","end":"2026-04-27T16:02:06.34529Z","steps":["trace[1746519627] 'process raft request' (duration: 825.236146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.345453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.327175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T16:02:06.34547Z","caller":"traceutil/trace.go:171","msg":"trace[1200086252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1297; }","duration":"698.365281ms","start":"2026-04-27T16:02:05.647101Z","end":"2026-04-27T16:02:06.345466Z","steps":["trace[1200086252] 'agreement among raft nodes before linearized reading' (duration: 698.322314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.345482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.647089Z","time spent":"698.390865ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:06.345477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.602193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T16:02:06.345506Z","caller":"traceutil/trace.go:171","msg":"trace[1557543847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1297; }","duration":"680.672835ms","start":"2026-04-27T16:02:05.664826Z","end":"2026-04-27T16:02:06.345499Z","steps":["trace[1557543847] 'agreement among raft nodes before linearized reading' (duration: 680.596241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.345524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.664804Z","time spent":"680.714281ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:06.345578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.519803Z","time spent":"825.639851ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:02:06.345619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.301418ms","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-04-27T16:02:06.345403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.542152Z","time spent":"803.246576ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T16:02:06.345731Z","caller":"traceutil/trace.go:171","msg":"trace[94713364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1297; }","duration":"725.473816ms","start":"2026-04-27T16:02:05.620234Z","end":"2026-04-27T16:02:06.345708Z","steps":["trace[94713364] 'agreement among raft nodes before linearized reading' (duration: 725.19412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.345759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.549346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T16:02:06.34579Z","caller":"traceutil/trace.go:171","msg":"trace[1465408789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1297; }","duration":"704.608445ms","start":"2026-04-27T16:02:05.641174Z","end":"2026-04-27T16:02:06.345783Z","steps":["trace[1465408789] 'agreement among raft nodes before linearized reading' (duration: 704.51409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.345788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.620217Z","time spent":"725.555369ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:02:06.345806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.641161Z","time spent":"704.6412ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:06.345793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.448193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:06.345894Z","caller":"traceutil/trace.go:171","msg":"trace[618538787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1297; }","duration":"404.590426ms","start":"2026-04-27T16:02:05.94128Z","end":"2026-04-27T16:02:06.345871Z","steps":["trace[618538787] 'agreement among raft nodes before linearized reading' (duration: 404.408137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:06.346023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:05.94126Z","time spent":"404.707024ms","remote":"127.0.0.1:54414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T16:02:07.469389Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528383218880092,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:02:07.683271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.678601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:02:07.683499Z","caller":"traceutil/trace.go:171","msg":"trace[1347577223] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"1.332873612s","start":"2026-04-27T16:02:06.350611Z","end":"2026-04-27T16:02:07.683485Z","steps":["trace[1347577223] 'process raft request' (duration: 1.332841007s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:07.683554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:06.3506Z","time spent":"1.33292897s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:07.68356Z","caller":"traceutil/trace.go:171","msg":"trace[1105957450] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"1.333954473s","start":"2026-04-27T16:02:06.349557Z","end":"2026-04-27T16:02:07.683511Z","steps":["trace[1105957450] 'process raft request' (duration: 492.967483ms)","trace[1105957450] 'compare' (duration: 840.556772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:07.683656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:06.349538Z","time spent":"1.334087474s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:07.683709Z","caller":"traceutil/trace.go:171","msg":"trace[404579942] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"1.334083674s","start":"2026-04-27T16:02:06.349619Z","end":"2026-04-27T16:02:07.683702Z","steps":["trace[404579942] 'process raft request' (duration: 1.333776795s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:07.68375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:06.349593Z","time spent":"1.334136172s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:07.683686Z","caller":"traceutil/trace.go:171","msg":"trace[1856751477] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"1.334063581s","start":"2026-04-27T16:02:06.349614Z","end":"2026-04-27T16:02:07.683677Z","steps":["trace[1856751477] 'process raft request' (duration: 1.333736769s)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:07.683816Z","caller":"traceutil/trace.go:171","msg":"trace[630017734] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"1.333854467s","start":"2026-04-27T16:02:06.349954Z","end":"2026-04-27T16:02:07.683808Z","steps":["trace[630017734] 'process raft request' (duration: 1.333468966s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:07.683948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:06.349593Z","time spent":"1.334263342s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:02:07.684022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:06.349939Z","time spent":"1.334023064s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:07.913959Z","caller":"traceutil/trace.go:171","msg":"trace[265403321] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1356; }","duration":"944.737755ms","start":"2026-04-27T16:02:06.96919Z","end":"2026-04-27T16:02:07.913928Z","steps":["trace[265403321] 'read index received' (duration: 694.750862ms)","trace[265403321] 'applied index is now lower than readState.Index' (duration: 249.985492ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:07.914058Z","caller":"traceutil/trace.go:171","msg":"trace[1705462148] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"639.794663ms","start":"2026-04-27T16:02:07.274235Z","end":"2026-04-27T16:02:07.91403Z","steps":["trace[1705462148] 'process raft request' (duration: 570.793691ms)","trace[1705462148] 'compare' (duration: 68.777827ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:07.914298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.092061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-04-27T16:02:07.914365Z","caller":"traceutil/trace.go:171","msg":"trace[157382583] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1303; }","duration":"945.216301ms","start":"2026-04-27T16:02:06.969133Z","end":"2026-04-27T16:02:07.91435Z","steps":["trace[157382583] 'agreement among raft nodes before linearized reading' (duration: 944.984234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:07.914416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:06.969114Z","time spent":"945.287592ms","remote":"127.0.0.1:54570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2499,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-04-27T16:02:07.914356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:07.274206Z","time spent":"640.025579ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:02:07.914859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.306455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:07.915002Z","caller":"traceutil/trace.go:171","msg":"trace[1972725749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1303; }","duration":"164.506236ms","start":"2026-04-27T16:02:07.750477Z","end":"2026-04-27T16:02:07.914983Z","steps":["trace[1972725749] 'agreement among raft nodes before linearized reading' (duration: 164.2745ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:10.431103Z","caller":"traceutil/trace.go:171","msg":"trace[1369438438] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"122.38208ms","start":"2026-04-27T16:02:10.308691Z","end":"2026-04-27T16:02:10.431073Z","steps":["trace[1369438438] 'process raft request' (duration: 122.142242ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:10.645933Z","caller":"traceutil/trace.go:171","msg":"trace[74309215] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"144.725765ms","start":"2026-04-27T16:02:10.501184Z","end":"2026-04-27T16:02:10.64591Z","steps":["trace[74309215] 'process raft request' (duration: 144.598475ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:12.616787Z","caller":"traceutil/trace.go:171","msg":"trace[1784725282] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"170.31892ms","start":"2026-04-27T16:02:12.446437Z","end":"2026-04-27T16:02:12.616756Z","steps":["trace[1784725282] 'process raft request' (duration: 170.088313ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:14.079445Z","caller":"traceutil/trace.go:171","msg":"trace[1119087270] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"456.007628ms","start":"2026-04-27T16:02:13.623415Z","end":"2026-04-27T16:02:14.079422Z","steps":["trace[1119087270] 'read index received' (duration: 455.795604ms)","trace[1119087270] 'applied index is now lower than readState.Index' (duration: 211.044µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:14.079504Z","caller":"traceutil/trace.go:171","msg":"trace[67232069] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"638.316564ms","start":"2026-04-27T16:02:13.441128Z","end":"2026-04-27T16:02:14.079444Z","steps":["trace[67232069] 'process raft request' (duration: 638.128254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.079683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.258748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2566"} {"level":"warn","ts":"2026-04-27T16:02:14.079702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.441102Z","time spent":"638.523337ms","remote":"127.0.0.1:54436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:14.079738Z","caller":"traceutil/trace.go:171","msg":"trace[632992197] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1322; }","duration":"456.356843ms","start":"2026-04-27T16:02:13.62337Z","end":"2026-04-27T16:02:14.079727Z","steps":["trace[632992197] 'agreement among raft nodes before linearized reading' (duration: 456.172724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.079773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.623349Z","time spent":"456.418054ms","remote":"127.0.0.1:54570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2589,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-04-27T16:02:14.079786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.898771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:02:14.079904Z","caller":"traceutil/trace.go:171","msg":"trace[1273909036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1322; }","duration":"361.068628ms","start":"2026-04-27T16:02:13.718819Z","end":"2026-04-27T16:02:14.079887Z","steps":["trace[1273909036] 'agreement among raft nodes before linearized reading' (duration: 360.83079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.079998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.718791Z","time spent":"361.186186ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:02:14.080053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.728693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T16:02:14.080081Z","caller":"traceutil/trace.go:171","msg":"trace[1684990652] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1322; }","duration":"313.772229ms","start":"2026-04-27T16:02:13.766301Z","end":"2026-04-27T16:02:14.080073Z","steps":["trace[1684990652] 'agreement among raft nodes before linearized reading' (duration: 313.659641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.080112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.766292Z","time spent":"313.815067ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T16:02:14.080109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.975694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T16:02:14.080141Z","caller":"traceutil/trace.go:171","msg":"trace[1258413019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1322; }","duration":"312.037724ms","start":"2026-04-27T16:02:13.768094Z","end":"2026-04-27T16:02:14.080131Z","steps":["trace[1258413019] 'agreement among raft nodes before linearized reading' (duration: 311.949329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.080177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.768072Z","time spent":"312.097753ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:14.080215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.053483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T16:02:14.080342Z","caller":"traceutil/trace.go:171","msg":"trace[2003699993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1322; }","duration":"315.22164ms","start":"2026-04-27T16:02:13.765113Z","end":"2026-04-27T16:02:14.080335Z","steps":["trace[2003699993] 'agreement among raft nodes before linearized reading' (duration: 315.060504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.080366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.409751ms","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":"warn","ts":"2026-04-27T16:02:14.080373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.765089Z","time spent":"315.277149ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:14.080256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.132856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:14.080428Z","caller":"traceutil/trace.go:171","msg":"trace[874338445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1322; }","duration":"328.338178ms","start":"2026-04-27T16:02:13.752078Z","end":"2026-04-27T16:02:14.080416Z","steps":["trace[874338445] 'agreement among raft nodes before linearized reading' (duration: 328.156009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.080459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.752059Z","time spent":"328.394197ms","remote":"127.0.0.1:54414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T16:02:14.080767Z","caller":"traceutil/trace.go:171","msg":"trace[1344426265] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"314.836939ms","start":"2026-04-27T16:02:13.76592Z","end":"2026-04-27T16:02:14.080757Z","steps":["trace[1344426265] 'agreement among raft nodes before linearized reading' (duration: 314.366734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:14.080802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:13.765903Z","time spent":"314.890318ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-27T16:02:14.782268Z","caller":"traceutil/trace.go:171","msg":"trace[1605852244] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"160.104352ms","start":"2026-04-27T16:02:14.622137Z","end":"2026-04-27T16:02:14.782241Z","steps":["trace[1605852244] 'process raft request' (duration: 159.942966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:16.650791Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528383218880183,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T16:02:16.823358Z","caller":"traceutil/trace.go:171","msg":"trace[1326045630] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1391; }","duration":"672.608006ms","start":"2026-04-27T16:02:16.150724Z","end":"2026-04-27T16:02:16.823332Z","steps":["trace[1326045630] 'read index received' (duration: 672.525883ms)","trace[1326045630] 'applied index is now lower than readState.Index' (duration: 81.013µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:16.823507Z","caller":"traceutil/trace.go:171","msg":"trace[1021515344] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"685.88636ms","start":"2026-04-27T16:02:16.137571Z","end":"2026-04-27T16:02:16.823457Z","steps":["trace[1021515344] 'process raft request' (duration: 685.567819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:16.823626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.8865ms","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-04-27T16:02:16.823678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.137552Z","time spent":"686.044395ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:16.823695Z","caller":"traceutil/trace.go:171","msg":"trace[1274897296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1331; }","duration":"672.991937ms","start":"2026-04-27T16:02:16.150685Z","end":"2026-04-27T16:02:16.823676Z","steps":["trace[1274897296] 'agreement among raft nodes before linearized reading' (duration: 672.789495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:16.823754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.150666Z","time spent":"673.07338ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:02:17.256735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.303615ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:02:17.256897Z","caller":"traceutil/trace.go:171","msg":"trace[167054594] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"428.991363ms","start":"2026-04-27T16:02:16.827889Z","end":"2026-04-27T16:02:17.256881Z","steps":["trace[167054594] 'process raft request' (duration: 428.945986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:17.256945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.827867Z","time spent":"429.055104ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:17.257037Z","caller":"traceutil/trace.go:171","msg":"trace[1881069879] linearizableReadLoop","detail":"{readStateIndex:1393; appliedIndex:1392; }","duration":"433.593296ms","start":"2026-04-27T16:02:16.823437Z","end":"2026-04-27T16:02:17.25703Z","steps":["trace[1881069879] 'read index received' (duration: 264.917602ms)","trace[1881069879] 'applied index is now lower than readState.Index' (duration: 168.674934ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:17.257069Z","caller":"traceutil/trace.go:171","msg":"trace[2145346276] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"470.4988ms","start":"2026-04-27T16:02:16.786359Z","end":"2026-04-27T16:02:17.256857Z","steps":["trace[2145346276] 'process raft request' (duration: 301.984301ms)","trace[2145346276] 'compare' (duration: 168.217762ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:17.257164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105312561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T16:02:17.257186Z","caller":"traceutil/trace.go:171","msg":"trace[1083580269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1333; }","duration":"1.105344796s","start":"2026-04-27T16:02:16.151835Z","end":"2026-04-27T16:02:17.25718Z","steps":["trace[1083580269] 'agreement among raft nodes before linearized reading' (duration: 1.105294498s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:17.257204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.151827Z","time spent":"1.10537224s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:17.257256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.786341Z","time spent":"470.811609ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:02:17.257284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105440461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T16:02:17.257303Z","caller":"traceutil/trace.go:171","msg":"trace[704577810] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"1.105480228s","start":"2026-04-27T16:02:16.151817Z","end":"2026-04-27T16:02:17.257297Z","steps":["trace[704577810] 'agreement among raft nodes before linearized reading' (duration: 1.1054298s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:17.257321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.151807Z","time spent":"1.105509152s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T16:02:17.257116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105407866s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T16:02:17.257432Z","caller":"traceutil/trace.go:171","msg":"trace[393603436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1333; }","duration":"1.105946882s","start":"2026-04-27T16:02:16.151465Z","end":"2026-04-27T16:02:17.257412Z","steps":["trace[393603436] 'agreement among raft nodes before linearized reading' (duration: 1.105587445s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:17.257479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:16.151443Z","time spent":"1.106023694s","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T16:02:17.39446Z","caller":"traceutil/trace.go:171","msg":"trace[1102697902] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"133.030111ms","start":"2026-04-27T16:02:17.261407Z","end":"2026-04-27T16:02:17.394437Z","steps":["trace[1102697902] 'process raft request' (duration: 132.967831ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:17.394734Z","caller":"traceutil/trace.go:171","msg":"trace[1870063837] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"133.537581ms","start":"2026-04-27T16:02:17.261173Z","end":"2026-04-27T16:02:17.394711Z","steps":["trace[1870063837] 'process raft request' (duration: 132.085651ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.477746Z","caller":"traceutil/trace.go:171","msg":"trace[1907488203] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1421; }","duration":"103.111458ms","start":"2026-04-27T16:02:23.374617Z","end":"2026-04-27T16:02:23.477728Z","steps":["trace[1907488203] 'read index received' (duration: 57.43727ms)","trace[1907488203] 'applied index is now lower than readState.Index' (duration: 45.673298ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:23.477863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.229627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:auth-delegator\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-04-27T16:02:23.477842Z","caller":"traceutil/trace.go:171","msg":"trace[1864376307] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"103.602957ms","start":"2026-04-27T16:02:23.374191Z","end":"2026-04-27T16:02:23.477794Z","steps":["trace[1864376307] 'process raft request' (duration: 103.441041ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.4779Z","caller":"traceutil/trace.go:171","msg":"trace[1752504419] range","detail":"{range_begin:/registry/clusterroles/system:auth-delegator; range_end:; response_count:1; response_revision:1359; }","duration":"103.300068ms","start":"2026-04-27T16:02:23.374592Z","end":"2026-04-27T16:02:23.477892Z","steps":["trace[1752504419] 'agreement among raft nodes before linearized reading' (duration: 103.227407ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:39.136508Z","caller":"traceutil/trace.go:171","msg":"trace[249584392] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"194.513118ms","start":"2026-04-27T16:02:38.941969Z","end":"2026-04-27T16:02:39.136482Z","steps":["trace[249584392] 'process raft request' (duration: 194.358203ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:39.177551Z","caller":"traceutil/trace.go:171","msg":"trace[716111266] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"234.712125ms","start":"2026-04-27T16:02:38.942793Z","end":"2026-04-27T16:02:39.177505Z","steps":["trace[716111266] 'process raft request' (duration: 234.49347ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:39.177675Z","caller":"traceutil/trace.go:171","msg":"trace[1390593870] linearizableReadLoop","detail":"{readStateIndex:1477; appliedIndex:1476; }","duration":"204.070859ms","start":"2026-04-27T16:02:38.973354Z","end":"2026-04-27T16:02:39.177425Z","steps":["trace[1390593870] 'read index received' (duration: 163.526168ms)","trace[1390593870] 'applied index is now lower than readState.Index' (duration: 40.543701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:39.178001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.559707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8kn96\" ","response":"range_response_count:1 size:4694"} {"level":"info","ts":"2026-04-27T16:02:39.178104Z","caller":"traceutil/trace.go:171","msg":"trace[891477387] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-8kn96; range_end:; response_count:1; response_revision:1410; }","duration":"204.776232ms","start":"2026-04-27T16:02:38.973313Z","end":"2026-04-27T16:02:39.178089Z","steps":["trace[891477387] 'agreement among raft nodes before linearized reading' (duration: 204.404143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:39.178335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.153503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-04-27T16:02:39.178418Z","caller":"traceutil/trace.go:171","msg":"trace[694027289] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1410; }","duration":"203.252039ms","start":"2026-04-27T16:02:38.975141Z","end":"2026-04-27T16:02:39.178393Z","steps":["trace[694027289] 'agreement among raft nodes before linearized reading' (duration: 203.015481ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:45.813103Z","caller":"traceutil/trace.go:171","msg":"trace[1881835183] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1501; }","duration":"122.028784ms","start":"2026-04-27T16:02:45.691048Z","end":"2026-04-27T16:02:45.813077Z","steps":["trace[1881835183] 'read index received' (duration: 121.788226ms)","trace[1881835183] 'applied index is now lower than readState.Index' (duration: 239.118µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:45.813486Z","caller":"traceutil/trace.go:171","msg":"trace[1638365089] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"122.969154ms","start":"2026-04-27T16:02:45.690491Z","end":"2026-04-27T16:02:45.81346Z","steps":["trace[1638365089] 'process raft request' (duration: 122.420097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:45.814096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.031024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-27T16:02:45.814175Z","caller":"traceutil/trace.go:171","msg":"trace[286259637] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1434; }","duration":"123.149613ms","start":"2026-04-27T16:02:45.691004Z","end":"2026-04-27T16:02:45.814153Z","steps":["trace[286259637] 'agreement among raft nodes before linearized reading' (duration: 122.282955ms)"],"step_count":1}