{"level":"warn","ts":"2026-04-15T12:07:41.201924Z","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-15T12:07:41.202009Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.137:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.137:2380","--initial-cluster=instance=https://199.19.213.137:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.137:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.137: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-15T12:07:41.202079Z","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-15T12:07:41.202091Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-04-15T12:07:41.20211Z","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-15T12:07:41.20607Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"]} {"level":"info","ts":"2026-04-15T12:07:41.206169Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.137: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-15T12:07:41.234079Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"26.56264ms"} {"level":"info","ts":"2026-04-15T12:07:41.254468Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2ba8e3c2b0588654","cluster-id":"97694c3f9947e4ca"} {"level":"info","ts":"2026-04-15T12:07:41.254588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T12:07:41.254616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 0"} {"level":"info","ts":"2026-04-15T12:07:41.254627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2ba8e3c2b0588654 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T12:07:41.254664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 1"} {"level":"info","ts":"2026-04-15T12:07:41.254705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"warn","ts":"2026-04-15T12:07:41.264865Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T12:07:41.267463Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T12:07:41.270712Z","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-15T12:07:41.273193Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2ba8e3c2b0588654","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T12:07:41.27335Z","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-15T12:07:41.273385Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2ba8e3c2b0588654","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T12:07:41.273448Z","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-15T12:07:41.273478Z","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-15T12:07:41.275465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"info","ts":"2026-04-15T12:07:41.275761Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","added-peer-id":"2ba8e3c2b0588654","added-peer-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-04-15T12:07:41.278246Z","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-15T12:07:41.278292Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-04-15T12:07:41.278354Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-04-15T12:07:41.278644Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2ba8e3c2b0588654","initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T12:07:41.278726Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T12:07:42.055194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T12:07:42.05527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T12:07:42.055334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgPreVoteResp from 2ba8e3c2b0588654 at term 1"} {"level":"info","ts":"2026-04-15T12:07:42.055362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became candidate at term 2"} {"level":"info","ts":"2026-04-15T12:07:42.055383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgVoteResp from 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-04-15T12:07:42.055402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became leader at term 2"} {"level":"info","ts":"2026-04-15T12:07:42.055422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2ba8e3c2b0588654 elected leader 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-04-15T12:07:42.056518Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:07:42.057757Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T12:07:42.05776Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2ba8e3c2b0588654","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.137:2379]}","request-path":"/0/members/2ba8e3c2b0588654/attributes","cluster-id":"97694c3f9947e4ca","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T12:07:42.057801Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T12:07:42.058273Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T12:07:42.05831Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T12:07:42.05962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.137:2379"} {"level":"info","ts":"2026-04-15T12:07:42.060861Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T12:07:42.061554Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:07:42.062302Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:07:42.062365Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-15T12:07:43.834803Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679534745393809017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:07:44.335218Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679534745393809017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:07:44.451396Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.126410013s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T12:07:44.452028Z","caller":"traceutil/trace.go:171","msg":"trace[212246549] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"1.127135822s","start":"2026-04-15T12:07:43.324863Z","end":"2026-04-15T12:07:44.451999Z","steps":["trace[212246549] 'process raft request' (duration: 1.126856105s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:44.452763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.324851Z","time spent":"1.127254635s","remote":"127.0.0.1:49854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:07:45.199901Z","caller":"traceutil/trace.go:171","msg":"trace[1056043679] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.814076171s","start":"2026-04-15T12:07:43.385776Z","end":"2026-04-15T12:07:45.199852Z","steps":["trace[1056043679] 'process raft request' (duration: 1.813952957s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.199955Z","caller":"traceutil/trace.go:171","msg":"trace[1059123895] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.812708335s","start":"2026-04-15T12:07:43.387209Z","end":"2026-04-15T12:07:45.199918Z","steps":["trace[1059123895] 'process raft request' (duration: 1.81257156s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.200111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.387196Z","time spent":"1.812839417s","remote":"127.0.0.1:50240","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-15T12:07:45.200167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.385759Z","time spent":"1.814258185s","remote":"127.0.0.1:50056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:07:45.20012Z","caller":"traceutil/trace.go:171","msg":"trace[487720385] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"1.866355098s","start":"2026-04-15T12:07:43.333724Z","end":"2026-04-15T12:07:45.200079Z","steps":["trace[487720385] 'read index received' (duration: 1.117969644s)","trace[487720385] 'applied index is now lower than readState.Index' (duration: 748.383964ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:45.20028Z","caller":"traceutil/trace.go:171","msg":"trace[902451439] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.873706409s","start":"2026-04-15T12:07:43.326567Z","end":"2026-04-15T12:07:45.200273Z","steps":["trace[902451439] 'process raft request' (duration: 1.872938359s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.200273Z","caller":"traceutil/trace.go:171","msg":"trace[1273423316] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.79598667s","start":"2026-04-15T12:07:43.404225Z","end":"2026-04-15T12:07:45.200212Z","steps":["trace[1273423316] 'process raft request' (duration: 1.795709243s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.200337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.32655Z","time spent":"1.873752251s","remote":"127.0.0.1:49838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:07:45.200408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.404216Z","time spent":"1.796133454s","remote":"127.0.0.1:50328","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-15T12:07:45.200456Z","caller":"traceutil/trace.go:171","msg":"trace[179231657] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.796120404s","start":"2026-04-15T12:07:43.404278Z","end":"2026-04-15T12:07:45.200398Z","steps":["trace[179231657] 'process raft request' (duration: 1.795685603s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.200556Z","caller":"traceutil/trace.go:171","msg":"trace[1149729173] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.792490609s","start":"2026-04-15T12:07:43.408058Z","end":"2026-04-15T12:07:45.200549Z","steps":["trace[1149729173] 'process raft request' (duration: 1.791976106s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.408052Z","time spent":"1.793948758s","remote":"127.0.0.1:49978","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-15T12:07:45.200577Z","caller":"traceutil/trace.go:171","msg":"trace[539024320] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.796136624s","start":"2026-04-15T12:07:43.404436Z","end":"2026-04-15T12:07:45.200573Z","steps":["trace[539024320] 'process raft request' (duration: 1.7955655s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.200695Z","caller":"traceutil/trace.go:171","msg":"trace[419269903] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.796949505s","start":"2026-04-15T12:07:43.403738Z","end":"2026-04-15T12:07:45.200687Z","steps":["trace[419269903] 'process raft request' (duration: 1.796085552s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.200717Z","caller":"traceutil/trace.go:171","msg":"trace[956300773] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.796687589s","start":"2026-04-15T12:07:43.404025Z","end":"2026-04-15T12:07:45.200713Z","steps":["trace[956300773] 'process raft request' (duration: 1.795842097s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.200748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.866997875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.811229666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7670812s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.868149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.440839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.749769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.827034446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.73626815s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.817641783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.137\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.733353214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T12:07:45.200921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.819724337s","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-15T12:07:45.202225Z","caller":"traceutil/trace.go:171","msg":"trace[774079975] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.821028881s","start":"2026-04-15T12:07:43.381176Z","end":"2026-04-15T12:07:45.202205Z","steps":["trace[774079975] 'agreement among raft nodes before linearized reading' (duration: 1.819726777s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.381169Z","time spent":"1.821092282s","remote":"127.0.0.1:49902","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-15T12:07:45.202394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.404427Z","time spent":"1.797942211s","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:07:45.202387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.404272Z","time spent":"1.797226843s","remote":"127.0.0.1:50328","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-15T12:07:45.202453Z","caller":"traceutil/trace.go:171","msg":"trace[1948096210] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"913.499432ms","start":"2026-04-15T12:07:44.288943Z","end":"2026-04-15T12:07:45.202442Z","steps":["trace[1948096210] 'agreement among raft nodes before linearized reading' (duration: 911.89323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.404016Z","time spent":"1.798464255s","remote":"127.0.0.1:50328","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-15T12:07:45.202521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:44.288915Z","time spent":"913.592345ms","remote":"127.0.0.1:50166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-04-15T12:07:45.20258Z","caller":"traceutil/trace.go:171","msg":"trace[1669347302] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"1.868892174s","start":"2026-04-15T12:07:43.333682Z","end":"2026-04-15T12:07:45.202574Z","steps":["trace[1669347302] 'agreement among raft nodes before linearized reading' (duration: 1.866978755s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.333667Z","time spent":"1.868934965s","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-15T12:07:45.202643Z","caller":"traceutil/trace.go:171","msg":"trace[186518123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"506.285678ms","start":"2026-04-15T12:07:44.696347Z","end":"2026-04-15T12:07:45.202633Z","steps":["trace[186518123] 'agreement among raft nodes before linearized reading' (duration: 504.507982ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.202675Z","caller":"traceutil/trace.go:171","msg":"trace[952709311] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"1.813108365s","start":"2026-04-15T12:07:43.38956Z","end":"2026-04-15T12:07:45.202669Z","steps":["trace[952709311] 'agreement among raft nodes before linearized reading' (duration: 1.811228407s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:44.696309Z","time spent":"506.36308ms","remote":"127.0.0.1:49790","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-15T12:07:45.202692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.389555Z","time spent":"1.813132546s","remote":"127.0.0.1:49880","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":"info","ts":"2026-04-15T12:07:45.20281Z","caller":"traceutil/trace.go:171","msg":"trace[88432697] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"920.751042ms","start":"2026-04-15T12:07:44.28205Z","end":"2026-04-15T12:07:45.202801Z","steps":["trace[88432697] 'agreement among raft nodes before linearized reading' (duration: 918.826831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:44.282019Z","time spent":"920.860763ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-04-15T12:07:45.202927Z","caller":"traceutil/trace.go:171","msg":"trace[1874047366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.82912481s","start":"2026-04-15T12:07:43.373789Z","end":"2026-04-15T12:07:45.202914Z","steps":["trace[1874047366] 'agreement among raft nodes before linearized reading' (duration: 1.826885962s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.202988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.373783Z","time spent":"1.829194572s","remote":"127.0.0.1:49902","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-15T12:07:45.202465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.403726Z","time spent":"1.798729191s","remote":"127.0.0.1:50328","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-15T12:07:45.203151Z","caller":"traceutil/trace.go:171","msg":"trace[943809637] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.73859063s","start":"2026-04-15T12:07:43.464551Z","end":"2026-04-15T12:07:45.203141Z","steps":["trace[943809637] 'agreement among raft nodes before linearized reading' (duration: 1.736199078s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.203186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.464545Z","time spent":"1.738632691s","remote":"127.0.0.1:49902","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-15T12:07:45.202272Z","caller":"traceutil/trace.go:171","msg":"trace[870259559] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.768526048s","start":"2026-04-15T12:07:43.433725Z","end":"2026-04-15T12:07:45.202251Z","steps":["trace[870259559] 'agreement among raft nodes before linearized reading' (duration: 1.767087281s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:45.203292Z","caller":"traceutil/trace.go:171","msg":"trace[479820127] range","detail":"{range_begin:/registry/masterleases/199.19.213.137; range_end:; response_count:0; response_revision:11; }","duration":"1.820039455s","start":"2026-04-15T12:07:43.383244Z","end":"2026-04-15T12:07:45.203283Z","steps":["trace[479820127] 'agreement among raft nodes before linearized reading' (duration: 1.817658253s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.203324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.383227Z","time spent":"1.820089837s","remote":"127.0.0.1:49814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.137\" "} {"level":"warn","ts":"2026-04-15T12:07:45.203287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.43372Z","time spent":"1.769553505s","remote":"127.0.0.1:49902","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-15T12:07:45.203472Z","caller":"traceutil/trace.go:171","msg":"trace[442409224] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.73590915s","start":"2026-04-15T12:07:43.467551Z","end":"2026-04-15T12:07:45.203461Z","steps":["trace[442409224] 'agreement among raft nodes before linearized reading' (duration: 1.733328633s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:45.204124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:43.467538Z","time spent":"1.736571238s","remote":"127.0.0.1:49902","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-15T12:07:45.707053Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679534745393809032,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-15T12:07:46.076597Z","caller":"traceutil/trace.go:171","msg":"trace[852604662] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"870.826272ms","start":"2026-04-15T12:07:45.205732Z","end":"2026-04-15T12:07:46.076558Z","steps":["trace[852604662] 'process raft request' (duration: 870.612287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.076841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.205718Z","time spent":"870.974577ms","remote":"127.0.0.1:50240","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-15T12:07:46.079409Z","caller":"traceutil/trace.go:171","msg":"trace[516623352] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"870.33871ms","start":"2026-04-15T12:07:45.209058Z","end":"2026-04-15T12:07:46.079397Z","steps":["trace[516623352] 'process raft request' (duration: 870.051843ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:46.079382Z","caller":"traceutil/trace.go:171","msg":"trace[553670596] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"873.529713ms","start":"2026-04-15T12:07:45.20582Z","end":"2026-04-15T12:07:46.07935Z","steps":["trace[553670596] 'process raft request' (duration: 873.139493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.079467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209047Z","time spent":"870.394871ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:07:46.079533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.205797Z","time spent":"873.671727ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:07:46.079763Z","caller":"traceutil/trace.go:171","msg":"trace[332970423] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"869.589221ms","start":"2026-04-15T12:07:45.21016Z","end":"2026-04-15T12:07:46.079749Z","steps":["trace[332970423] 'process raft request' (duration: 869.214711ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:46.079856Z","caller":"traceutil/trace.go:171","msg":"trace[292583140] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"870.503205ms","start":"2026-04-15T12:07:45.209344Z","end":"2026-04-15T12:07:46.079847Z","steps":["trace[292583140] 'process raft request' (duration: 869.847348ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:46.079867Z","caller":"traceutil/trace.go:171","msg":"trace[1231859629] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"870.463524ms","start":"2026-04-15T12:07:45.209393Z","end":"2026-04-15T12:07:46.079857Z","steps":["trace[1231859629] 'process raft request' (duration: 869.837878ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:46.079894Z","caller":"traceutil/trace.go:171","msg":"trace[2939059] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"870.169716ms","start":"2026-04-15T12:07:45.209707Z","end":"2026-04-15T12:07:46.079876Z","steps":["trace[2939059] 'process raft request' (duration: 869.630413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.079923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209388Z","time spent":"870.512505ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:07:46.079976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209335Z","time spent":"870.568196ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:07:46.079815Z","caller":"traceutil/trace.go:171","msg":"trace[302389748] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"870.471994ms","start":"2026-04-15T12:07:45.209329Z","end":"2026-04-15T12:07:46.079801Z","steps":["trace[302389748] 'process raft request' (duration: 869.820288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.080064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209323Z","time spent":"870.710241ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:07:46.08009Z","caller":"traceutil/trace.go:171","msg":"trace[1805716396] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"870.68026ms","start":"2026-04-15T12:07:45.209395Z","end":"2026-04-15T12:07:46.080075Z","steps":["trace[1805716396] 'process raft request' (duration: 869.878909ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:46.079747Z","caller":"traceutil/trace.go:171","msg":"trace[586684241] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"870.256219ms","start":"2026-04-15T12:07:45.209434Z","end":"2026-04-15T12:07:46.07969Z","steps":["trace[586684241] 'process raft request' (duration: 869.870889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.080185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209389Z","time spent":"870.746771ms","remote":"127.0.0.1:50328","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-15T12:07:46.080199Z","caller":"traceutil/trace.go:171","msg":"trace[1763828712] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"868.489913ms","start":"2026-04-15T12:07:45.211538Z","end":"2026-04-15T12:07:46.080028Z","steps":["trace[1763828712] 'process raft request' (duration: 867.868086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.080294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209424Z","time spent":"870.766272ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:07:46.080009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.210151Z","time spent":"869.709944ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:07:46.080521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.53908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T12:07:46.080577Z","caller":"traceutil/trace.go:171","msg":"trace[800024864] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21; }","duration":"874.599351ms","start":"2026-04-15T12:07:45.205958Z","end":"2026-04-15T12:07:46.080558Z","steps":["trace[800024864] 'agreement among raft nodes before linearized reading' (duration: 874.499159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.079985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.209696Z","time spent":"870.240109ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:07:46.080585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.21153Z","time spent":"868.805621ms","remote":"127.0.0.1:49978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:07:46.080615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.205931Z","time spent":"874.671703ms","remote":"127.0.0.1:50170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-04-15T12:07:46.079668Z","caller":"traceutil/trace.go:171","msg":"trace[1794187797] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:14; }","duration":"873.645807ms","start":"2026-04-15T12:07:45.205966Z","end":"2026-04-15T12:07:46.079612Z","steps":["trace[1794187797] 'read index received' (duration: 870.453894ms)","trace[1794187797] 'applied index is now lower than readState.Index' (duration: 3.191133ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:07:46.080772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.721244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T12:07:46.080857Z","caller":"traceutil/trace.go:171","msg":"trace[1575207237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"874.821058ms","start":"2026-04-15T12:07:45.20601Z","end":"2026-04-15T12:07:46.080832Z","steps":["trace[1575207237] 'agreement among raft nodes before linearized reading' (duration: 874.719844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.080899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.285741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-15T12:07:46.080931Z","caller":"traceutil/trace.go:171","msg":"trace[977512689] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"815.314662ms","start":"2026-04-15T12:07:45.265609Z","end":"2026-04-15T12:07:46.080923Z","steps":["trace[977512689] 'agreement among raft nodes before linearized reading' (duration: 815.261071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.080951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.265599Z","time spent":"815.347362ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-15T12:07:46.080812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.617774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T12:07:46.081017Z","caller":"traceutil/trace.go:171","msg":"trace[2049545525] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"670.839961ms","start":"2026-04-15T12:07:45.410155Z","end":"2026-04-15T12:07:46.080995Z","steps":["trace[2049545525] 'agreement among raft nodes before linearized reading' (duration: 670.634306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:46.08107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.410143Z","time spent":"670.912882ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-04-15T12:07:46.081033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:45.205998Z","time spent":"875.014042ms","remote":"127.0.0.1:49792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T12:07:48.534883Z","caller":"traceutil/trace.go:171","msg":"trace[93368107] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"141.757292ms","start":"2026-04-15T12:07:48.393097Z","end":"2026-04-15T12:07:48.534855Z","steps":["trace[93368107] 'process raft request' (duration: 87.571445ms)","trace[93368107] 'compare' (duration: 54.051123ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:48.534955Z","caller":"traceutil/trace.go:171","msg":"trace[799508050] linearizableReadLoop","detail":"{readStateIndex:235; appliedIndex:234; }","duration":"141.322879ms","start":"2026-04-15T12:07:48.393582Z","end":"2026-04-15T12:07:48.534905Z","steps":["trace[799508050] 'read index received' (duration: 87.102471ms)","trace[799508050] 'applied index is now lower than readState.Index' (duration: 54.217368ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:48.534911Z","caller":"traceutil/trace.go:171","msg":"trace[1677358312] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"138.474676ms","start":"2026-04-15T12:07:48.396418Z","end":"2026-04-15T12:07:48.534893Z","steps":["trace[1677358312] 'process raft request' (duration: 138.427295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:48.535171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.564935ms","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-15T12:07:48.535281Z","caller":"traceutil/trace.go:171","msg":"trace[219617681] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:230; }","duration":"141.70115ms","start":"2026-04-15T12:07:48.393562Z","end":"2026-04-15T12:07:48.535263Z","steps":["trace[219617681] 'agreement among raft nodes before linearized reading' (duration: 141.480214ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:48.652667Z","caller":"traceutil/trace.go:171","msg":"trace[1302442151] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"112.130191ms","start":"2026-04-15T12:07:48.540493Z","end":"2026-04-15T12:07:48.652623Z","steps":["trace[1302442151] 'process raft request' (duration: 111.385512ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:48.652772Z","caller":"traceutil/trace.go:171","msg":"trace[1073397646] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"112.000108ms","start":"2026-04-15T12:07:48.54071Z","end":"2026-04-15T12:07:48.65271Z","steps":["trace[1073397646] 'process raft request' (duration: 111.874224ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:48.833641Z","caller":"traceutil/trace.go:171","msg":"trace[1987573695] linearizableReadLoop","detail":"{readStateIndex:243; appliedIndex:242; }","duration":"126.512755ms","start":"2026-04-15T12:07:48.707096Z","end":"2026-04-15T12:07:48.833609Z","steps":["trace[1987573695] 'read index received' (duration: 74.696499ms)","trace[1987573695] 'applied index is now lower than readState.Index' (duration: 51.815086ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:48.833654Z","caller":"traceutil/trace.go:171","msg":"trace[202645196] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"126.890695ms","start":"2026-04-15T12:07:48.706744Z","end":"2026-04-15T12:07:48.833635Z","steps":["trace[202645196] 'process raft request' (duration: 75.148652ms)","trace[202645196] 'compare' (duration: 51.572409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:07:48.833799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.670698ms","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-15T12:07:48.833842Z","caller":"traceutil/trace.go:171","msg":"trace[1931448545] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:237; }","duration":"126.758401ms","start":"2026-04-15T12:07:48.707072Z","end":"2026-04-15T12:07:48.833831Z","steps":["trace[1931448545] 'agreement among raft nodes before linearized reading' (duration: 126.631818ms)"],"step_count":1} 2026/04/15 12:07:48 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-04-15T12:07:49.021362Z","caller":"traceutil/trace.go:171","msg":"trace[1332464655] linearizableReadLoop","detail":"{readStateIndex:246; appliedIndex:244; }","duration":"140.019236ms","start":"2026-04-15T12:07:48.881316Z","end":"2026-04-15T12:07:49.021336Z","steps":["trace[1332464655] 'read index received' (duration: 92.469221ms)","trace[1332464655] 'applied index is now lower than readState.Index' (duration: 47.548715ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:49.021389Z","caller":"traceutil/trace.go:171","msg":"trace[1643654189] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"183.902415ms","start":"2026-04-15T12:07:48.837443Z","end":"2026-04-15T12:07:49.021346Z","steps":["trace[1643654189] 'process raft request' (duration: 136.303269ms)","trace[1643654189] 'compare' (duration: 47.37836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:07:49.021521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.172659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:07:49.021562Z","caller":"traceutil/trace.go:171","msg":"trace[1814735273] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:0; response_revision:240; }","duration":"140.259711ms","start":"2026-04-15T12:07:48.881289Z","end":"2026-04-15T12:07:49.021549Z","steps":["trace[1814735273] 'agreement among raft nodes before linearized reading' (duration: 140.151168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:49.364612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.112979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T12:07:49.364791Z","caller":"traceutil/trace.go:171","msg":"trace[19608876] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:248; }","duration":"251.723885ms","start":"2026-04-15T12:07:49.113055Z","end":"2026-04-15T12:07:49.364779Z","steps":["trace[19608876] 'read index received' (duration: 74.363879ms)","trace[19608876] 'applied index is now lower than readState.Index' (duration: 177.359386ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:49.3649Z","caller":"traceutil/trace.go:171","msg":"trace[1771309739] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"249.660722ms","start":"2026-04-15T12:07:49.115223Z","end":"2026-04-15T12:07:49.364884Z","steps":["trace[1771309739] 'process raft request' (duration: 249.525618ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.364911Z","caller":"traceutil/trace.go:171","msg":"trace[1863170105] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"253.586234ms","start":"2026-04-15T12:07:49.111291Z","end":"2026-04-15T12:07:49.364878Z","steps":["trace[1863170105] 'process raft request' (duration: 253.41879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:49.365142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.084126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:07:49.365091Z","caller":"traceutil/trace.go:171","msg":"trace[598801332] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"254.713004ms","start":"2026-04-15T12:07:49.110314Z","end":"2026-04-15T12:07:49.365027Z","steps":["trace[598801332] 'process raft request' (duration: 77.02825ms)","trace[598801332] 'compare' (duration: 176.996176ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:49.365161Z","caller":"traceutil/trace.go:171","msg":"trace[1457786755] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:245; }","duration":"252.125887ms","start":"2026-04-15T12:07:49.113028Z","end":"2026-04-15T12:07:49.365154Z","steps":["trace[1457786755] 'agreement among raft nodes before linearized reading' (duration: 251.945143ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.419379Z","caller":"traceutil/trace.go:171","msg":"trace[1808388470] transaction","detail":"{read_only:false; number_of_response:0; response_revision:245; }","duration":"212.118508ms","start":"2026-04-15T12:07:49.207245Z","end":"2026-04-15T12:07:49.419363Z","steps":["trace[1808388470] 'process raft request' (duration: 212.037316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:49.419599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.04596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-15T12:07:49.41971Z","caller":"traceutil/trace.go:171","msg":"trace[1992290643] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:245; }","duration":"305.191473ms","start":"2026-04-15T12:07:49.1145Z","end":"2026-04-15T12:07:49.419692Z","steps":["trace[1992290643] 'agreement among raft nodes before linearized reading' (duration: 304.937117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:49.419761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:07:49.114477Z","time spent":"305.274777ms","remote":"127.0.0.1:50196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-15T12:07:49.525531Z","caller":"traceutil/trace.go:171","msg":"trace[1871833585] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:252; }","duration":"106.168705ms","start":"2026-04-15T12:07:49.419333Z","end":"2026-04-15T12:07:49.525502Z","steps":["trace[1871833585] 'read index received' (duration: 85.89648ms)","trace[1871833585] 'applied index is now lower than readState.Index' (duration: 20.270865ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:49.525706Z","caller":"traceutil/trace.go:171","msg":"trace[1809513391] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"156.855263ms","start":"2026-04-15T12:07:49.368826Z","end":"2026-04-15T12:07:49.525681Z","steps":["trace[1809513391] 'process raft request' (duration: 136.471093ms)","trace[1809513391] 'compare' (duration: 19.962849ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:07:49.525585Z","caller":"traceutil/trace.go:171","msg":"trace[569348490] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"155.643031ms","start":"2026-04-15T12:07:49.36991Z","end":"2026-04-15T12:07:49.525553Z","steps":["trace[569348490] 'process raft request' (duration: 155.533898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:49.525805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.377525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"warn","ts":"2026-04-15T12:07:49.525833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.220252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:07:49.526027Z","caller":"traceutil/trace.go:171","msg":"trace[909477995] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:247; }","duration":"157.724574ms","start":"2026-04-15T12:07:49.36828Z","end":"2026-04-15T12:07:49.526005Z","steps":["trace[909477995] 'agreement among raft nodes before linearized reading' (duration: 157.361456ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.526097Z","caller":"traceutil/trace.go:171","msg":"trace[745042857] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:247; }","duration":"157.562621ms","start":"2026-04-15T12:07:49.368513Z","end":"2026-04-15T12:07:49.526076Z","steps":["trace[745042857] 'agreement among raft nodes before linearized reading' (duration: 157.12225ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.610762Z","caller":"traceutil/trace.go:171","msg":"trace[1383590022] transaction","detail":"{read_only:false; number_of_response:0; response_revision:247; }","duration":"180.785624ms","start":"2026-04-15T12:07:49.429957Z","end":"2026-04-15T12:07:49.610743Z","steps":["trace[1383590022] 'process raft request' (duration: 180.560278ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.610947Z","caller":"traceutil/trace.go:171","msg":"trace[1606613058] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"174.513421ms","start":"2026-04-15T12:07:49.436423Z","end":"2026-04-15T12:07:49.610936Z","steps":["trace[1606613058] 'process raft request' (duration: 174.370558ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.611276Z","caller":"traceutil/trace.go:171","msg":"trace[1194450550] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"175.091646ms","start":"2026-04-15T12:07:49.43616Z","end":"2026-04-15T12:07:49.611252Z","steps":["trace[1194450550] 'process raft request' (duration: 174.49715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:07:49.611323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.919037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"warn","ts":"2026-04-15T12:07:49.611449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.885244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-15T12:07:49.611513Z","caller":"traceutil/trace.go:171","msg":"trace[1180690815] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:251; }","duration":"191.138462ms","start":"2026-04-15T12:07:49.420357Z","end":"2026-04-15T12:07:49.611495Z","steps":["trace[1180690815] 'agreement among raft nodes before linearized reading' (duration: 190.752002ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.611326Z","caller":"traceutil/trace.go:171","msg":"trace[987940296] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"174.730687ms","start":"2026-04-15T12:07:49.436574Z","end":"2026-04-15T12:07:49.611305Z","steps":["trace[987940296] 'process raft request' (duration: 174.245074ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.611326Z","caller":"traceutil/trace.go:171","msg":"trace[1828456403] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"174.940652ms","start":"2026-04-15T12:07:49.436344Z","end":"2026-04-15T12:07:49.611284Z","steps":["trace[1828456403] 'process raft request' (duration: 174.400978ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:07:49.611644Z","caller":"traceutil/trace.go:171","msg":"trace[1631263628] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:251; }","duration":"189.042438ms","start":"2026-04-15T12:07:49.422463Z","end":"2026-04-15T12:07:49.611505Z","steps":["trace[1631263628] 'agreement among raft nodes before linearized reading' (duration: 188.852063ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:06.298611Z","caller":"traceutil/trace.go:171","msg":"trace[1865416188] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"111.891124ms","start":"2026-04-15T12:08:06.186691Z","end":"2026-04-15T12:08:06.298582Z","steps":["trace[1865416188] 'process raft request' (duration: 109.468001ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.704043Z","caller":"traceutil/trace.go:171","msg":"trace[65864512] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"642.550133ms","start":"2026-04-15T12:08:10.061423Z","end":"2026-04-15T12:08:10.703973Z","steps":["trace[65864512] 'process raft request' (duration: 642.329727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.70429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.061395Z","time spent":"642.782059ms","remote":"127.0.0.1:49832","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-15T12:08:10.712832Z","caller":"traceutil/trace.go:171","msg":"trace[259581736] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"645.016257ms","start":"2026-04-15T12:08:10.06779Z","end":"2026-04-15T12:08:10.712806Z","steps":["trace[259581736] 'process raft request' (duration: 644.872863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.71294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.067766Z","time spent":"645.128549ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:08:10.7129Z","caller":"traceutil/trace.go:171","msg":"trace[326986883] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"634.206136ms","start":"2026-04-15T12:08:10.078681Z","end":"2026-04-15T12:08:10.712887Z","steps":["trace[326986883] 'process raft request' (duration: 634.120384ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.71309Z","caller":"traceutil/trace.go:171","msg":"trace[319137899] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"629.73403ms","start":"2026-04-15T12:08:10.08334Z","end":"2026-04-15T12:08:10.713074Z","steps":["trace[319137899] 'process raft request' (duration: 629.542845ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.712897Z","caller":"traceutil/trace.go:171","msg":"trace[1247100721] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"634.670018ms","start":"2026-04-15T12:08:10.078185Z","end":"2026-04-15T12:08:10.712855Z","steps":["trace[1247100721] 'process raft request' (duration: 634.524395ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.713161Z","caller":"traceutil/trace.go:171","msg":"trace[426269573] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"622.716388ms","start":"2026-04-15T12:08:10.090432Z","end":"2026-04-15T12:08:10.713149Z","steps":["trace[426269573] 'process raft request' (duration: 622.508542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.713171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.078658Z","time spent":"634.375591ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:08:10.713232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.090421Z","time spent":"622.772979ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:08:10.713159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.078164Z","time spent":"634.968136ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:08:10.713225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.083333Z","time spent":"629.800393ms","remote":"127.0.0.1:49832","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-15T12:08:10.713261Z","caller":"traceutil/trace.go:171","msg":"trace[145639044] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"620.727466ms","start":"2026-04-15T12:08:10.092524Z","end":"2026-04-15T12:08:10.713252Z","steps":["trace[145639044] 'process raft request' (duration: 620.557102ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.712807Z","caller":"traceutil/trace.go:171","msg":"trace[530973034] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"647.725166ms","start":"2026-04-15T12:08:10.06505Z","end":"2026-04-15T12:08:10.712775Z","steps":["trace[530973034] 'process raft request' (duration: 647.48659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.713342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.092506Z","time spent":"620.785207ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:08:10.713367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.065037Z","time spent":"648.302711ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:08:10.712956Z","caller":"traceutil/trace.go:171","msg":"trace[1586049901] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"631.63601ms","start":"2026-04-15T12:08:10.081286Z","end":"2026-04-15T12:08:10.712922Z","steps":["trace[1586049901] 'process raft request' (duration: 631.555108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.713464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.081239Z","time spent":"632.209465ms","remote":"127.0.0.1:49832","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-15T12:08:10.712897Z","caller":"traceutil/trace.go:171","msg":"trace[27007566] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"634.605486ms","start":"2026-04-15T12:08:10.078256Z","end":"2026-04-15T12:08:10.712862Z","steps":["trace[27007566] 'process raft request' (duration: 634.503754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.713547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.078248Z","time spent":"635.276104ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:08:10.713956Z","caller":"traceutil/trace.go:171","msg":"trace[1405071239] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"609.168407ms","start":"2026-04-15T12:08:10.104779Z","end":"2026-04-15T12:08:10.713948Z","steps":["trace[1405071239] 'process raft request' (duration: 608.565741ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.713976Z","caller":"traceutil/trace.go:171","msg":"trace[749612256] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:486; }","duration":"435.776478ms","start":"2026-04-15T12:08:10.278184Z","end":"2026-04-15T12:08:10.71396Z","steps":["trace[749612256] 'read index received' (duration: 425.594604ms)","trace[749612256] 'applied index is now lower than readState.Index' (duration: 10.180984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:08:10.714001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.104765Z","time spent":"609.216088ms","remote":"127.0.0.1:49832","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-15T12:08:10.714106Z","caller":"traceutil/trace.go:171","msg":"trace[38121759] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"374.202889ms","start":"2026-04-15T12:08:10.339886Z","end":"2026-04-15T12:08:10.714089Z","steps":["trace[38121759] 'process raft request' (duration: 374.013685ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:10.714188Z","caller":"traceutil/trace.go:171","msg":"trace[746819264] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"434.954655ms","start":"2026-04-15T12:08:10.279226Z","end":"2026-04-15T12:08:10.71418Z","steps":["trace[746819264] 'process raft request' (duration: 434.531464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.714212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.339847Z","time spent":"374.284931ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:08:10.714224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.279188Z","time spent":"435.021027ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:08:10.71421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.020903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:08:10.714324Z","caller":"traceutil/trace.go:171","msg":"trace[690224101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"436.173397ms","start":"2026-04-15T12:08:10.278137Z","end":"2026-04-15T12:08:10.714311Z","steps":["trace[690224101] 'agreement among raft nodes before linearized reading' (duration: 435.952092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.714445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.278121Z","time spent":"436.311161ms","remote":"127.0.0.1:49790","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-15T12:08:10.723747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.156036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-15T12:08:10.723817Z","caller":"traceutil/trace.go:171","msg":"trace[1796084673] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:485; }","duration":"367.257029ms","start":"2026-04-15T12:08:10.356547Z","end":"2026-04-15T12:08:10.723804Z","steps":["trace[1796084673] 'agreement among raft nodes before linearized reading' (duration: 367.144706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:10.723845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:10.356533Z","time spent":"367.3064ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T12:08:10.723975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.819047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T12:08:10.724043Z","caller":"traceutil/trace.go:171","msg":"trace[123165114] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:485; }","duration":"297.91303ms","start":"2026-04-15T12:08:10.42609Z","end":"2026-04-15T12:08:10.724003Z","steps":["trace[123165114] 'agreement among raft nodes before linearized reading' (duration: 297.840017ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:11.224761Z","caller":"traceutil/trace.go:171","msg":"trace[455366008] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"136.931513ms","start":"2026-04-15T12:08:11.087765Z","end":"2026-04-15T12:08:11.224696Z","steps":["trace[455366008] 'process raft request' (duration: 107.790757ms)","trace[455366008] 'compare' (duration: 28.728325ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:08:11.225472Z","caller":"traceutil/trace.go:171","msg":"trace[86554587] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"119.704936ms","start":"2026-04-15T12:08:11.105725Z","end":"2026-04-15T12:08:11.22543Z","steps":["trace[86554587] 'process raft request' (duration: 119.501891ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:11.831083Z","caller":"traceutil/trace.go:171","msg":"trace[1611806688] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"454.606126ms","start":"2026-04-15T12:08:11.376398Z","end":"2026-04-15T12:08:11.831004Z","steps":["trace[1611806688] 'process raft request' (duration: 454.39655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:11.831298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:11.37637Z","time spent":"454.81516ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:08:11.853663Z","caller":"traceutil/trace.go:171","msg":"trace[1732366331] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"466.025732ms","start":"2026-04-15T12:08:11.387597Z","end":"2026-04-15T12:08:11.853623Z","steps":["trace[1732366331] 'process raft request' (duration: 463.64063ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:11.853728Z","caller":"traceutil/trace.go:171","msg":"trace[659736210] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"274.428361ms","start":"2026-04-15T12:08:11.579263Z","end":"2026-04-15T12:08:11.853691Z","steps":["trace[659736210] 'process raft request' (duration: 272.662935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:11.853887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:11.387562Z","time spent":"466.214486ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:08:11.882084Z","caller":"traceutil/trace.go:171","msg":"trace[1307188238] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:556; }","duration":"119.06397ms","start":"2026-04-15T12:08:11.762973Z","end":"2026-04-15T12:08:11.882037Z","steps":["trace[1307188238] 'read index received' (duration: 69.647457ms)","trace[1307188238] 'applied index is now lower than readState.Index' (duration: 49.414943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:08:11.882407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.389007ms","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-15T12:08:11.882435Z","caller":"traceutil/trace.go:171","msg":"trace[614836075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"119.46231ms","start":"2026-04-15T12:08:11.762965Z","end":"2026-04-15T12:08:11.882427Z","steps":["trace[614836075] 'agreement among raft nodes before linearized reading' (duration: 119.211853ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:14.247839Z","caller":"traceutil/trace.go:171","msg":"trace[667592567] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"155.896525ms","start":"2026-04-15T12:08:14.091908Z","end":"2026-04-15T12:08:14.247804Z","steps":["trace[667592567] 'process raft request' (duration: 155.782192ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:16.804919Z","caller":"traceutil/trace.go:171","msg":"trace[840252696] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"166.086009ms","start":"2026-04-15T12:08:16.638807Z","end":"2026-04-15T12:08:16.804893Z","steps":["trace[840252696] 'process raft request' (duration: 164.345544ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:18.351375Z","caller":"traceutil/trace.go:171","msg":"trace[2021602359] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"379.175337ms","start":"2026-04-15T12:08:17.972166Z","end":"2026-04-15T12:08:18.351342Z","steps":["trace[2021602359] 'read index received' (duration: 378.246763ms)","trace[2021602359] 'applied index is now lower than readState.Index' (duration: 927.754µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:08:18.351461Z","caller":"traceutil/trace.go:171","msg":"trace[1876483335] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"583.629991ms","start":"2026-04-15T12:08:17.767804Z","end":"2026-04-15T12:08:18.351434Z","steps":["trace[1876483335] 'process raft request' (duration: 582.926682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:18.351679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:17.767765Z","time spent":"583.753414ms","remote":"127.0.0.1:49888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:08:18.351688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.692945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pz4n6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-15T12:08:18.351855Z","caller":"traceutil/trace.go:171","msg":"trace[1957754373] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pz4n6; range_end:; response_count:1; response_revision:581; }","duration":"124.86601ms","start":"2026-04-15T12:08:18.22694Z","end":"2026-04-15T12:08:18.351806Z","steps":["trace[1957754373] 'agreement among raft nodes before linearized reading' (duration: 124.590902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:18.351834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.622848ms","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-15T12:08:18.351972Z","caller":"traceutil/trace.go:171","msg":"trace[527952375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"379.839684ms","start":"2026-04-15T12:08:17.972102Z","end":"2026-04-15T12:08:18.351941Z","steps":["trace[527952375] 'agreement among raft nodes before linearized reading' (duration: 379.393632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:18.35207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:17.972069Z","time spent":"379.983328ms","remote":"127.0.0.1:50064","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-15T12:08:19.32335Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679534745393810125,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:08:19.766072Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.333699249s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-15T12:08:20.539809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.107474002s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T12:08:20.539973Z","caller":"traceutil/trace.go:171","msg":"trace[938398995] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"1.717483354s","start":"2026-04-15T12:08:18.822478Z","end":"2026-04-15T12:08:20.539961Z","steps":["trace[938398995] 'read index received' (duration: 943.746222ms)","trace[938398995] 'applied index is now lower than readState.Index' (duration: 773.736422ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:08:20.540029Z","caller":"traceutil/trace.go:171","msg":"trace[442841174] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"2.173311559s","start":"2026-04-15T12:08:18.366707Z","end":"2026-04-15T12:08:20.540018Z","steps":["trace[442841174] 'process raft request' (duration: 65.489499ms)","trace[442841174] 'compare' (duration: 2.10704887s)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:08:20.540063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:18.366685Z","time spent":"2.173359491s","remote":"127.0.0.1:49994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:08:20.540116Z","caller":"traceutil/trace.go:171","msg":"trace[910356098] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"2.116568987s","start":"2026-04-15T12:08:18.423507Z","end":"2026-04-15T12:08:20.540076Z","steps":["trace[910356098] 'process raft request' (duration: 2.116390452s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:20.540291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.717825574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-15T12:08:20.540286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:18.423486Z","time spent":"2.116715711s","remote":"127.0.0.1:50318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:08:20.540313Z","caller":"traceutil/trace.go:171","msg":"trace[316450439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"1.717895615s","start":"2026-04-15T12:08:18.822409Z","end":"2026-04-15T12:08:20.540305Z","steps":["trace[316450439] 'agreement among raft nodes before linearized reading' (duration: 1.717769831s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:20.540451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:18.822381Z","time spent":"1.718054248s","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T12:08:20.541047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710345048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-15T12:08:20.541181Z","caller":"traceutil/trace.go:171","msg":"trace[1538083602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"1.710498032s","start":"2026-04-15T12:08:18.830661Z","end":"2026-04-15T12:08:20.541159Z","steps":["trace[1538083602] 'agreement among raft nodes before linearized reading' (duration: 1.710219345s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:20.541265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:18.830578Z","time spent":"1.710674617s","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T12:08:20.541438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.924406ms","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-15T12:08:20.541516Z","caller":"traceutil/trace.go:171","msg":"trace[421405952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"158.0376ms","start":"2026-04-15T12:08:20.383464Z","end":"2026-04-15T12:08:20.541501Z","steps":["trace[421405952] 'agreement among raft nodes before linearized reading' (duration: 157.826074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:20.541552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261650899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T12:08:20.541574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270823767s","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-15T12:08:20.541596Z","caller":"traceutil/trace.go:171","msg":"trace[975694691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"1.261755072s","start":"2026-04-15T12:08:19.279829Z","end":"2026-04-15T12:08:20.541584Z","steps":["trace[975694691] 'agreement among raft nodes before linearized reading' (duration: 1.261687381s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:20.541618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:19.279805Z","time spent":"1.261808563s","remote":"127.0.0.1:49790","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-15T12:08:20.541606Z","caller":"traceutil/trace.go:171","msg":"trace[1071729072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"1.270906649s","start":"2026-04-15T12:08:19.27069Z","end":"2026-04-15T12:08:20.541596Z","steps":["trace[1071729072] 'agreement among raft nodes before linearized reading' (duration: 1.270800637s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:20.541672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:19.27066Z","time spent":"1.271005782s","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T12:08:20.541622Z","caller":"traceutil/trace.go:171","msg":"trace[870593892] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"112.711014ms","start":"2026-04-15T12:08:20.428899Z","end":"2026-04-15T12:08:20.54161Z","steps":["trace[870593892] 'process raft request' (duration: 111.853312ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:22.638278Z","caller":"traceutil/trace.go:171","msg":"trace[1483296583] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"186.546239ms","start":"2026-04-15T12:08:22.451706Z","end":"2026-04-15T12:08:22.638253Z","steps":["trace[1483296583] 'process raft request' (duration: 186.404586ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:34.314549Z","caller":"traceutil/trace.go:171","msg":"trace[416876547] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"196.64323ms","start":"2026-04-15T12:08:34.117883Z","end":"2026-04-15T12:08:34.314526Z","steps":["trace[416876547] 'process raft request' (duration: 196.461955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.222399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679534745393810512,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-15T12:08:37.646607Z","caller":"traceutil/trace.go:171","msg":"trace[388593078] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"924.764932ms","start":"2026-04-15T12:08:36.721812Z","end":"2026-04-15T12:08:37.646577Z","steps":["trace[388593078] 'process raft request' (duration: 924.593908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.646783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:36.721798Z","time spent":"924.896136ms","remote":"127.0.0.1:50064","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-15T12:08:37.844604Z","caller":"traceutil/trace.go:171","msg":"trace[1112025830] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:772; }","duration":"1.122795557s","start":"2026-04-15T12:08:36.721726Z","end":"2026-04-15T12:08:37.844522Z","steps":["trace[1112025830] 'read index received' (duration: 924.66618ms)","trace[1112025830] 'applied index is now lower than readState.Index' (duration: 198.128207ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:08:37.844704Z","caller":"traceutil/trace.go:171","msg":"trace[1489107314] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"930.212173ms","start":"2026-04-15T12:08:36.914456Z","end":"2026-04-15T12:08:37.844668Z","steps":["trace[1489107314] 'process raft request' (duration: 929.827593ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:37.844735Z","caller":"traceutil/trace.go:171","msg":"trace[243573116] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"499.642167ms","start":"2026-04-15T12:08:37.345041Z","end":"2026-04-15T12:08:37.844683Z","steps":["trace[243573116] 'process raft request' (duration: 499.420651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.844832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:36.914431Z","time spent":"930.320566ms","remote":"127.0.0.1:50064","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-15T12:08:37.84488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123159686s","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-15T12:08:37.844933Z","caller":"traceutil/trace.go:171","msg":"trace[1137977654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:746; }","duration":"1.123240158s","start":"2026-04-15T12:08:36.721678Z","end":"2026-04-15T12:08:37.844918Z","steps":["trace[1137977654] 'agreement among raft nodes before linearized reading' (duration: 1.123083964s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.844967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:36.721666Z","time spent":"1.123292519s","remote":"127.0.0.1:50064","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-15T12:08:37.845185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118761472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T12:08:37.845216Z","caller":"traceutil/trace.go:171","msg":"trace[1457624965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:746; }","duration":"1.118807764s","start":"2026-04-15T12:08:36.726397Z","end":"2026-04-15T12:08:37.845205Z","steps":["trace[1457624965] 'agreement among raft nodes before linearized reading' (duration: 1.118712992s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.845242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:36.726387Z","time spent":"1.118849545s","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T12:08:37.845294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.388508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:08:37.845349Z","caller":"traceutil/trace.go:171","msg":"trace[582342339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"566.46948ms","start":"2026-04-15T12:08:37.278862Z","end":"2026-04-15T12:08:37.845332Z","steps":["trace[582342339] 'agreement among raft nodes before linearized reading' (duration: 566.372447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.845417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:37.278849Z","time spent":"566.559072ms","remote":"127.0.0.1:49790","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-15T12:08:37.845505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05542717s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.137\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-15T12:08:37.845504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118486625s","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-15T12:08:37.845548Z","caller":"traceutil/trace.go:171","msg":"trace[415501088] range","detail":"{range_begin:/registry/masterleases/199.19.213.137; range_end:; response_count:1; response_revision:746; }","duration":"1.055494703s","start":"2026-04-15T12:08:36.79004Z","end":"2026-04-15T12:08:37.845535Z","steps":["trace[415501088] 'agreement among raft nodes before linearized reading' (duration: 1.055377899s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:37.845551Z","caller":"traceutil/trace.go:171","msg":"trace[1165078282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:746; }","duration":"1.118552328s","start":"2026-04-15T12:08:36.726987Z","end":"2026-04-15T12:08:37.845539Z","steps":["trace[1165078282] 'agreement among raft nodes before linearized reading' (duration: 1.118434054s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:37.845579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:36.790026Z","time spent":"1.055546503s","remote":"127.0.0.1:49814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.137\" "} {"level":"warn","ts":"2026-04-15T12:08:37.845582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:36.726977Z","time spent":"1.118598859s","remote":"127.0.0.1:50064","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-15T12:08:37.844982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:37.344942Z","time spent":"499.898093ms","remote":"127.0.0.1:50040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:08:42.055839Z","caller":"traceutil/trace.go:171","msg":"trace[1136377507] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"224.182293ms","start":"2026-04-15T12:08:41.831628Z","end":"2026-04-15T12:08:42.05581Z","steps":["trace[1136377507] 'process raft request' (duration: 223.631029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:42.390158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.030322ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-15T12:08:42.390276Z","caller":"traceutil/trace.go:171","msg":"trace[1953954098] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:826; }","duration":"522.724785ms","start":"2026-04-15T12:08:41.867532Z","end":"2026-04-15T12:08:42.390257Z","steps":["trace[1953954098] 'read index received' (duration: 187.370578ms)","trace[1953954098] 'applied index is now lower than readState.Index' (duration: 335.343206ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:08:42.390471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.94231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-15T12:08:42.390509Z","caller":"traceutil/trace.go:171","msg":"trace[258161188] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"523.027322ms","start":"2026-04-15T12:08:41.86747Z","end":"2026-04-15T12:08:42.390498Z","steps":["trace[258161188] 'agreement among raft nodes before linearized reading' (duration: 522.867329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:42.390547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:41.867448Z","time spent":"523.091053ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T12:08:42.414144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.537027ms","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-15T12:08:42.414217Z","caller":"traceutil/trace.go:171","msg":"trace[818980342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"545.65743ms","start":"2026-04-15T12:08:41.868542Z","end":"2026-04-15T12:08:42.4142Z","steps":["trace[818980342] 'agreement among raft nodes before linearized reading' (duration: 545.456154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:42.414255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:41.868522Z","time spent":"545.724481ms","remote":"127.0.0.1:50064","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-15T12:08:42.414512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.098717ms","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-15T12:08:42.414545Z","caller":"traceutil/trace.go:171","msg":"trace[540929417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"542.19099ms","start":"2026-04-15T12:08:41.872346Z","end":"2026-04-15T12:08:42.414537Z","steps":["trace[540929417] 'agreement among raft nodes before linearized reading' (duration: 542.118367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:42.414564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:41.872312Z","time spent":"542.247612ms","remote":"127.0.0.1:50064","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-15T12:08:42.415332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.939831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-04-15T12:08:42.415379Z","caller":"traceutil/trace.go:171","msg":"trace[1035754025] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:798; }","duration":"240.020604ms","start":"2026-04-15T12:08:42.175346Z","end":"2026-04-15T12:08:42.415366Z","steps":["trace[1035754025] 'agreement among raft nodes before linearized reading' (duration: 239.078319ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:42.851803Z","caller":"traceutil/trace.go:171","msg":"trace[603213179] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"433.249034ms","start":"2026-04-15T12:08:42.418529Z","end":"2026-04-15T12:08:42.851778Z","steps":["trace[603213179] 'process raft request' (duration: 372.080018ms)","trace[603213179] 'compare' (duration: 60.685074ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:08:42.851966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:42.418496Z","time spent":"433.400438ms","remote":"127.0.0.1:50064","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-15T12:08:42.852325Z","caller":"traceutil/trace.go:171","msg":"trace[581063711] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"433.534791ms","start":"2026-04-15T12:08:42.418768Z","end":"2026-04-15T12:08:42.852303Z","steps":["trace[581063711] 'process raft request' (duration: 432.947376ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:42.852516Z","caller":"traceutil/trace.go:171","msg":"trace[1708638404] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"430.624736ms","start":"2026-04-15T12:08:42.421875Z","end":"2026-04-15T12:08:42.8525Z","steps":["trace[1708638404] 'process raft request' (duration: 430.517864ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:08:42.852534Z","caller":"traceutil/trace.go:171","msg":"trace[1784517680] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:830; }","duration":"295.828861ms","start":"2026-04-15T12:08:42.556671Z","end":"2026-04-15T12:08:42.852499Z","steps":["trace[1784517680] 'read index received' (duration: 233.863485ms)","trace[1784517680] 'applied index is now lower than readState.Index' (duration: 61.963866ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:08:42.852591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:42.421867Z","time spent":"430.691568ms","remote":"127.0.0.1:58104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2784,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:08:42.852632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:42.41876Z","time spent":"433.632684ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:08:42.852666Z","caller":"traceutil/trace.go:171","msg":"trace[921305829] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"433.151262ms","start":"2026-04-15T12:08:42.419501Z","end":"2026-04-15T12:08:42.852653Z","steps":["trace[921305829] 'process raft request' (duration: 432.727731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:42.852725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:08:42.419472Z","time spent":"433.220954ms","remote":"127.0.0.1:50064","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-15T12:08:42.855727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.014673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:08:42.856177Z","caller":"traceutil/trace.go:171","msg":"trace[41687084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"299.453584ms","start":"2026-04-15T12:08:42.556656Z","end":"2026-04-15T12:08:42.856109Z","steps":["trace[41687084] 'agreement among raft nodes before linearized reading' (duration: 295.978824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:42.856663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.468673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-04-15T12:08:42.857019Z","caller":"traceutil/trace.go:171","msg":"trace[1167737746] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:803; }","duration":"250.750682ms","start":"2026-04-15T12:08:42.606085Z","end":"2026-04-15T12:08:42.856836Z","steps":["trace[1167737746] 'agreement among raft nodes before linearized reading' (duration: 246.621464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:08:53.5163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.802263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-mdt2h\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-04-15T12:08:53.516376Z","caller":"traceutil/trace.go:171","msg":"trace[1962779575] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-mdt2h; range_end:; response_count:1; response_revision:927; }","duration":"100.895555ms","start":"2026-04-15T12:08:53.415462Z","end":"2026-04-15T12:08:53.516358Z","steps":["trace[1962779575] 'range keys from in-memory index tree' (duration: 100.624969ms)"],"step_count":1}