{"level":"warn","ts":"2026-08-11T12:55:57.649575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T12:55:57.649666Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-08-11T12:55:57.649737Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T12:55:57.649748Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-08-11T12:55:57.649766Z","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-08-11T12:55:57.650468Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-08-11T12:55:57.650544Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-08-11T12:55:57.655478Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.724741ms"} {"level":"info","ts":"2026-08-11T12:55:57.67001Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-08-11T12:55:57.670164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T12:55:57.670208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-08-11T12:55:57.670232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T12:55:57.670257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-08-11T12:55:57.670379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-08-11T12:55:57.681611Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T12:55:57.68311Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T12:55:57.684212Z","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-08-11T12:55:57.686457Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T12:55:57.689166Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T12:55:57.689338Z","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-08-11T12:55:57.689379Z","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-08-11T12:55:57.689389Z","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-08-11T12:55:57.68979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-08-11T12:55:57.689916Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-08-11T12:55:57.691573Z","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-08-11T12:55:57.691877Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T12:55:57.691937Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T12:55:57.691842Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-08-11T12:55:57.692312Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-08-11T12:55:58.574452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T12:55:58.574525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T12:55:58.574567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-08-11T12:55:58.574589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-08-11T12:55:58.574601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-08-11T12:55:58.574623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-08-11T12:55:58.574653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-08-11T12:55:58.5758Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T12:55:58.577708Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T12:55:58.577693Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T12:55:58.577779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:55:58.577968Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T12:55:58.578013Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T12:55:58.57883Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:55:58.578916Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:55:58.578945Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T12:55:58.580572Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T12:55:58.580704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-08-11T12:56:35.715742Z","caller":"traceutil/trace.go:171","msg":"trace[1128391158] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"360.2446ms","start":"2026-08-11T12:56:35.355455Z","end":"2026-08-11T12:56:35.715699Z","steps":["trace[1128391158] 'process raft request' (duration: 359.9078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:35.717029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.355425Z","time spent":"360.450895ms","remote":"127.0.0.1:49708","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-08-11T12:56:36.42577Z","caller":"traceutil/trace.go:171","msg":"trace[167810372] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.062849654s","start":"2026-08-11T12:56:35.362844Z","end":"2026-08-11T12:56:36.425694Z","steps":["trace[167810372] 'process raft request' (duration: 1.062321191s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.426128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.362819Z","time spent":"1.063148572s","remote":"127.0.0.1:49708","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-08-11T12:56:36.426541Z","caller":"traceutil/trace.go:171","msg":"trace[900305083] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.06148289s","start":"2026-08-11T12:56:35.365016Z","end":"2026-08-11T12:56:36.426499Z","steps":["trace[900305083] 'process raft request' (duration: 1.060452374s)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:56:36.426756Z","caller":"traceutil/trace.go:171","msg":"trace[1041154371] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.052598008s","start":"2026-08-11T12:56:35.3741Z","end":"2026-08-11T12:56:36.426698Z","steps":["trace[1041154371] 'process raft request' (duration: 1.052306591s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.426985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.37408Z","time spent":"1.052770423s","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:56:36.427117Z","caller":"traceutil/trace.go:171","msg":"trace[1583790430] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.051860391s","start":"2026-08-11T12:56:35.375216Z","end":"2026-08-11T12:56:36.427076Z","steps":["trace[1583790430] 'process raft request' (duration: 1.051535521s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.427289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.375192Z","time spent":"1.052008904s","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:56:36.427568Z","caller":"traceutil/trace.go:171","msg":"trace[1210463866] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.052268651s","start":"2026-08-11T12:56:35.375286Z","end":"2026-08-11T12:56:36.427555Z","steps":["trace[1210463866] 'process raft request' (duration: 1.05185908s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.427636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.375283Z","time spent":"1.052319982s","remote":"127.0.0.1:49708","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-08-11T12:56:36.42858Z","caller":"traceutil/trace.go:171","msg":"trace[378322079] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.053047221s","start":"2026-08-11T12:56:35.375517Z","end":"2026-08-11T12:56:36.428564Z","steps":["trace[378322079] 'process raft request' (duration: 1.052127217s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.42871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.375511Z","time spent":"1.053115432s","remote":"127.0.0.1:49708","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-08-11T12:56:36.42919Z","caller":"traceutil/trace.go:171","msg":"trace[1357045200] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.048582444s","start":"2026-08-11T12:56:35.38059Z","end":"2026-08-11T12:56:36.429173Z","steps":["trace[1357045200] 'process raft request' (duration: 1.047832545s)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:56:36.429291Z","caller":"traceutil/trace.go:171","msg":"trace[363637990] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"915.192332ms","start":"2026-08-11T12:56:35.514081Z","end":"2026-08-11T12:56:36.429273Z","steps":["trace[363637990] 'process raft request' (duration: 915.059308ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.429321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.380556Z","time spent":"1.048689627s","remote":"127.0.0.1:49708","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-08-11T12:56:36.429397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.514051Z","time spent":"915.296495ms","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:56:36.429655Z","caller":"traceutil/trace.go:171","msg":"trace[1238825785] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.048514502s","start":"2026-08-11T12:56:35.381124Z","end":"2026-08-11T12:56:36.429638Z","steps":["trace[1238825785] 'process raft request' (duration: 1.047480256s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.429749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.381111Z","time spent":"1.048605784s","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T12:56:36.429718Z","caller":"traceutil/trace.go:171","msg":"trace[407602133] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.054150259s","start":"2026-08-11T12:56:35.375549Z","end":"2026-08-11T12:56:36.4297Z","steps":["trace[407602133] 'process raft request' (duration: 1.05261728s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.429875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.375546Z","time spent":"1.054257982s","remote":"127.0.0.1:49708","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-08-11T12:56:36.429957Z","caller":"traceutil/trace.go:171","msg":"trace[1990225028] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.028214467s","start":"2026-08-11T12:56:35.401707Z","end":"2026-08-11T12:56:36.429922Z","steps":["trace[1990225028] 'process raft request' (duration: 1.027087117s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.426783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.365008Z","time spent":"1.061687915s","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:56:36.43002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.40167Z","time spent":"1.028324919s","remote":"127.0.0.1:49708","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-08-11T12:56:36.444617Z","caller":"traceutil/trace.go:171","msg":"trace[1008867145] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"721.139297ms","start":"2026-08-11T12:56:35.723456Z","end":"2026-08-11T12:56:36.444595Z","steps":["trace[1008867145] 'process raft request' (duration: 716.034325ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:56:36.444975Z","caller":"traceutil/trace.go:171","msg":"trace[259265729] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"723.185329ms","start":"2026-08-11T12:56:35.721753Z","end":"2026-08-11T12:56:36.444939Z","steps":["trace[259265729] 'process raft request' (duration: 717.621445ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.445116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.721726Z","time spent":"723.327203ms","remote":"127.0.0.1:59548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:56:36.445185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.723442Z","time spent":"721.27376ms","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:56:36.445431Z","caller":"traceutil/trace.go:171","msg":"trace[925447010] transaction","detail":"{read_only:false; number_of_response:1; response_revision:544; }","duration":"721.30118ms","start":"2026-08-11T12:56:35.724117Z","end":"2026-08-11T12:56:36.445418Z","steps":["trace[925447010] 'process raft request' (duration: 715.470849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.445541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:35.724103Z","time spent":"721.406573ms","remote":"127.0.0.1:49708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:56:36.445711Z","caller":"traceutil/trace.go:171","msg":"trace[528723882] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:547; }","duration":"366.286577ms","start":"2026-08-11T12:56:36.079186Z","end":"2026-08-11T12:56:36.445472Z","steps":["trace[528723882] 'read index received' (duration: 346.120664ms)","trace[528723882] 'applied index is now lower than readState.Index' (duration: 20.159822ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:56:36.446014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.805571ms","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-08-11T12:56:36.446114Z","caller":"traceutil/trace.go:171","msg":"trace[949246402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:545; }","duration":"366.965255ms","start":"2026-08-11T12:56:36.07913Z","end":"2026-08-11T12:56:36.446095Z","steps":["trace[949246402] 'agreement among raft nodes before linearized reading' (duration: 366.686337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.446163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:36.079105Z","time spent":"367.049466ms","remote":"127.0.0.1:59284","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-08-11T12:56:36.452843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.591322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:56:36.452992Z","caller":"traceutil/trace.go:171","msg":"trace[327712141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"352.843008ms","start":"2026-08-11T12:56:36.100132Z","end":"2026-08-11T12:56:36.452975Z","steps":["trace[327712141] 'agreement among raft nodes before linearized reading' (duration: 352.569751ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.453087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:36.100115Z","time spent":"352.95619ms","remote":"127.0.0.1:49652","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-08-11T12:56:36.453674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.685935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-11T12:56:36.453763Z","caller":"traceutil/trace.go:171","msg":"trace[545826721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"297.799539ms","start":"2026-08-11T12:56:36.155948Z","end":"2026-08-11T12:56:36.453748Z","steps":["trace[545826721] 'agreement among raft nodes before linearized reading' (duration: 297.690346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.454015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.250083ms","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-08-11T12:56:36.454083Z","caller":"traceutil/trace.go:171","msg":"trace[224473376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"300.449608ms","start":"2026-08-11T12:56:36.153614Z","end":"2026-08-11T12:56:36.454064Z","steps":["trace[224473376] 'agreement among raft nodes before linearized reading' (duration: 300.274443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:36.454123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:36.153585Z","time spent":"300.5282ms","remote":"127.0.0.1:59284","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-08-11T12:56:41.981068Z","caller":"traceutil/trace.go:171","msg":"trace[1980727850] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"174.116903ms","start":"2026-08-11T12:56:41.806913Z","end":"2026-08-11T12:56:41.98103Z","steps":["trace[1980727850] 'process raft request' (duration: 172.552753ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:56:42.685712Z","caller":"traceutil/trace.go:171","msg":"trace[1754108958] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"194.480274ms","start":"2026-08-11T12:56:42.491201Z","end":"2026-08-11T12:56:42.685681Z","steps":["trace[1754108958] 'read index received' (duration: 191.935348ms)","trace[1754108958] 'applied index is now lower than readState.Index' (duration: 2.543716ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:56:42.68585Z","caller":"traceutil/trace.go:171","msg":"trace[208673569] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"199.00151ms","start":"2026-08-11T12:56:42.486765Z","end":"2026-08-11T12:56:42.685767Z","steps":["trace[208673569] 'process raft request' (duration: 196.932766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:42.685997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.771091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T12:56:42.686038Z","caller":"traceutil/trace.go:171","msg":"trace[212538703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"194.865284ms","start":"2026-08-11T12:56:42.49116Z","end":"2026-08-11T12:56:42.686025Z","steps":["trace[212538703] 'agreement among raft nodes before linearized reading' (duration: 194.759601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:42.686329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.587571ms","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-08-11T12:56:42.686359Z","caller":"traceutil/trace.go:171","msg":"trace[841800192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"190.662504ms","start":"2026-08-11T12:56:42.495687Z","end":"2026-08-11T12:56:42.68635Z","steps":["trace[841800192] 'agreement among raft nodes before linearized reading' (duration: 190.611683ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:42.686687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.960446ms","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-08-11T12:56:42.686773Z","caller":"traceutil/trace.go:171","msg":"trace[1212456245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"190.072458ms","start":"2026-08-11T12:56:42.49667Z","end":"2026-08-11T12:56:42.686743Z","steps":["trace[1212456245] 'agreement among raft nodes before linearized reading' (duration: 189.701299ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:56:43.204513Z","caller":"traceutil/trace.go:171","msg":"trace[516019984] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:648; }","duration":"307.481505ms","start":"2026-08-11T12:56:42.896997Z","end":"2026-08-11T12:56:43.204478Z","steps":["trace[516019984] 'read index received' (duration: 259.621749ms)","trace[516019984] 'applied index is now lower than readState.Index' (duration: 47.858276ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:56:43.204697Z","caller":"traceutil/trace.go:171","msg":"trace[996345448] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"513.769625ms","start":"2026-08-11T12:56:42.690892Z","end":"2026-08-11T12:56:43.204661Z","steps":["trace[996345448] 'process raft request' (duration: 465.675303ms)","trace[996345448] 'compare' (duration: 47.398824ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:56:43.205602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:42.69086Z","time spent":"514.632756ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:56:43.20477Z","caller":"traceutil/trace.go:171","msg":"trace[1992336019] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"513.778804ms","start":"2026-08-11T12:56:42.690983Z","end":"2026-08-11T12:56:43.204762Z","steps":["trace[1992336019] 'process raft request' (duration: 513.178059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:43.2058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:42.690957Z","time spent":"514.75996ms","remote":"127.0.0.1:59284","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-08-11T12:56:43.20472Z","caller":"traceutil/trace.go:171","msg":"trace[330290635] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"494.464022ms","start":"2026-08-11T12:56:42.710211Z","end":"2026-08-11T12:56:43.204675Z","steps":["trace[330290635] 'process raft request' (duration: 494.130964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:43.205936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:42.710185Z","time spent":"495.724405ms","remote":"127.0.0.1:49888","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-08-11T12:56:43.204801Z","caller":"traceutil/trace.go:171","msg":"trace[2051058344] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"513.735033ms","start":"2026-08-11T12:56:42.691058Z","end":"2026-08-11T12:56:43.204793Z","steps":["trace[2051058344] 'process raft request' (duration: 513.189479ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:56:43.20494Z","caller":"traceutil/trace.go:171","msg":"trace[1664007606] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"455.690063ms","start":"2026-08-11T12:56:42.749162Z","end":"2026-08-11T12:56:43.204852Z","steps":["trace[1664007606] 'process raft request' (duration: 455.257092ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:43.206224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:42.749131Z","time spent":"457.052088ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T12:56:43.206141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:42.691049Z","time spent":"514.979936ms","remote":"127.0.0.1:59284","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-08-11T12:56:43.204974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.963107ms","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-08-11T12:56:43.206379Z","caller":"traceutil/trace.go:171","msg":"trace[823317829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"309.414435ms","start":"2026-08-11T12:56:42.896945Z","end":"2026-08-11T12:56:43.20636Z","steps":["trace[823317829] 'agreement among raft nodes before linearized reading' (duration: 307.884955ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:43.20644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:42.89692Z","time spent":"309.502998ms","remote":"127.0.0.1:59284","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-08-11T12:56:44.599905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369638223572110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T12:56:45.100424Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369638223572110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T12:56:45.121577Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.484661569s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T12:56:45.122728Z","caller":"traceutil/trace.go:171","msg":"trace[2112943377] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.487367609s","start":"2026-08-11T12:56:43.635332Z","end":"2026-08-11T12:56:45.1227Z","steps":["trace[2112943377] 'process raft request' (duration: 1.486798114s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:45.122936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:43.635298Z","time spent":"1.487509323s","remote":"127.0.0.1:49768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:56:45.134767Z","caller":"traceutil/trace.go:171","msg":"trace[7006087] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"1.035390234s","start":"2026-08-11T12:56:44.099353Z","end":"2026-08-11T12:56:45.134743Z","steps":["trace[7006087] 'read index received' (duration: 1.022596701s)","trace[7006087] 'applied index is now lower than readState.Index' (duration: 12.792423ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:56:45.134899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035534177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:56:45.134938Z","caller":"traceutil/trace.go:171","msg":"trace[1281825042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"1.0356332s","start":"2026-08-11T12:56:44.099294Z","end":"2026-08-11T12:56:45.134928Z","steps":["trace[1281825042] 'agreement among raft nodes before linearized reading' (duration: 1.035536698s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:45.134974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:44.099266Z","time spent":"1.035699222s","remote":"127.0.0.1:49652","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-08-11T12:56:45.135153Z","caller":"traceutil/trace.go:171","msg":"trace[796747453] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"424.595474ms","start":"2026-08-11T12:56:44.710548Z","end":"2026-08-11T12:56:45.135144Z","steps":["trace[796747453] 'process raft request' (duration: 422.102189ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:56:45.135233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:56:44.710517Z","time spent":"424.663205ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:56:47.025226Z","caller":"traceutil/trace.go:171","msg":"trace[841296689] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"158.330882ms","start":"2026-08-11T12:56:46.866861Z","end":"2026-08-11T12:56:47.025192Z","steps":["trace[841296689] 'process raft request' (duration: 158.139798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:01.243507Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369638223572442,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T12:57:01.452393Z","caller":"traceutil/trace.go:171","msg":"trace[919683806] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"911.114279ms","start":"2026-08-11T12:57:00.541258Z","end":"2026-08-11T12:57:01.452372Z","steps":["trace[919683806] 'process raft request' (duration: 910.977605ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:01.452566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:00.541241Z","time spent":"911.257343ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:57:01.570007Z","caller":"traceutil/trace.go:171","msg":"trace[1452455112] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:832; }","duration":"826.985419ms","start":"2026-08-11T12:57:00.742993Z","end":"2026-08-11T12:57:01.569979Z","steps":["trace[1452455112] 'read index received' (duration: 709.299545ms)","trace[1452455112] 'applied index is now lower than readState.Index' (duration: 117.684974ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:57:01.57041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.387489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:57:01.570488Z","caller":"traceutil/trace.go:171","msg":"trace[1261724233] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:809; }","duration":"827.525533ms","start":"2026-08-11T12:57:00.742947Z","end":"2026-08-11T12:57:01.570472Z","steps":["trace[1261724233] 'agreement among raft nodes before linearized reading' (duration: 827.361369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:01.570533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:00.742928Z","time spent":"827.597095ms","remote":"127.0.0.1:59318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-08-11T12:57:01.570616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.177878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-11T12:57:01.570663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.061435ms","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-08-11T12:57:01.570739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.918044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:57:01.570722Z","caller":"traceutil/trace.go:171","msg":"trace[227519359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"279.327342ms","start":"2026-08-11T12:57:01.291369Z","end":"2026-08-11T12:57:01.570697Z","steps":["trace[227519359] 'agreement among raft nodes before linearized reading' (duration: 279.029834ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:01.57077Z","caller":"traceutil/trace.go:171","msg":"trace[1134168929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"199.977466ms","start":"2026-08-11T12:57:01.370783Z","end":"2026-08-11T12:57:01.57076Z","steps":["trace[1134168929] 'agreement among raft nodes before linearized reading' (duration: 199.940615ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:01.57076Z","caller":"traceutil/trace.go:171","msg":"trace[1240209836] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"256.21816ms","start":"2026-08-11T12:57:01.314517Z","end":"2026-08-11T12:57:01.570736Z","steps":["trace[1240209836] 'agreement among raft nodes before linearized reading' (duration: 255.931323ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:01.570645Z","caller":"traceutil/trace.go:171","msg":"trace[1846307480] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"809.723839ms","start":"2026-08-11T12:57:00.760889Z","end":"2026-08-11T12:57:01.570613Z","steps":["trace[1846307480] 'process raft request' (duration: 808.954959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:01.570696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.472413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T12:57:01.570945Z","caller":"traceutil/trace.go:171","msg":"trace[2136057287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"277.74665ms","start":"2026-08-11T12:57:01.293186Z","end":"2026-08-11T12:57:01.570933Z","steps":["trace[2136057287] 'agreement among raft nodes before linearized reading' (duration: 277.396341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:01.571051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:00.760864Z","time spent":"810.013557ms","remote":"127.0.0.1:59258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:57:01.57123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.766385ms","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-08-11T12:57:01.571372Z","caller":"traceutil/trace.go:171","msg":"trace[1517614879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"277.016232ms","start":"2026-08-11T12:57:01.294296Z","end":"2026-08-11T12:57:01.571312Z","steps":["trace[1517614879] 'agreement among raft nodes before linearized reading' (duration: 276.194891ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:14.778358Z","caller":"traceutil/trace.go:171","msg":"trace[1207000150] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"774.266556ms","start":"2026-08-11T12:57:14.004066Z","end":"2026-08-11T12:57:14.778333Z","steps":["trace[1207000150] 'process raft request' (duration: 773.758662ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:14.778514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:14.004047Z","time spent":"774.38547ms","remote":"127.0.0.1:49888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:57:15.093928Z","caller":"traceutil/trace.go:171","msg":"trace[2085128071] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"309.413275ms","start":"2026-08-11T12:57:14.7845Z","end":"2026-08-11T12:57:15.093913Z","steps":["trace[2085128071] 'process raft request' (duration: 309.320412ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:15.094033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:14.784481Z","time spent":"309.492076ms","remote":"127.0.0.1:49858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:57:15.110402Z","caller":"traceutil/trace.go:171","msg":"trace[1085269973] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"325.422191ms","start":"2026-08-11T12:57:14.784951Z","end":"2026-08-11T12:57:15.110373Z","steps":["trace[1085269973] 'process raft request' (duration: 325.206566ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:15.110433Z","caller":"traceutil/trace.go:171","msg":"trace[599442634] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"324.131438ms","start":"2026-08-11T12:57:14.786282Z","end":"2026-08-11T12:57:15.110413Z","steps":["trace[599442634] 'process raft request' (duration: 324.002725ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:15.11054Z","caller":"traceutil/trace.go:171","msg":"trace[1390648777] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"232.958834ms","start":"2026-08-11T12:57:14.877569Z","end":"2026-08-11T12:57:15.110528Z","steps":["trace[1390648777] 'process raft request' (duration: 232.80145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:15.11057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:14.784928Z","time spent":"325.555025ms","remote":"127.0.0.1:59292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1628,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:57:15.110596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:14.786272Z","time spent":"324.21802ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:57:15.703942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.782916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T12:57:15.704013Z","caller":"traceutil/trace.go:171","msg":"trace[660872376] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:946; }","duration":"190.893809ms","start":"2026-08-11T12:57:15.513104Z","end":"2026-08-11T12:57:15.703997Z","steps":["trace[660872376] 'range keys from in-memory index tree' (duration: 190.590062ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:16.146266Z","caller":"traceutil/trace.go:171","msg":"trace[660366887] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"117.286064ms","start":"2026-08-11T12:57:16.028952Z","end":"2026-08-11T12:57:16.146238Z","steps":["trace[660366887] 'process raft request' (duration: 72.874927ms)","trace[660366887] 'compare' (duration: 44.264473ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:22.134398Z","caller":"traceutil/trace.go:171","msg":"trace[1823012394] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"399.11757ms","start":"2026-08-11T12:57:21.735262Z","end":"2026-08-11T12:57:22.13438Z","steps":["trace[1823012394] 'read index received' (duration: 323.739328ms)","trace[1823012394] 'applied index is now lower than readState.Index' (duration: 75.376972ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:22.134508Z","caller":"traceutil/trace.go:171","msg":"trace[963182261] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"633.941974ms","start":"2026-08-11T12:57:21.500559Z","end":"2026-08-11T12:57:22.134501Z","steps":["trace[963182261] 'process raft request' (duration: 558.365146ms)","trace[963182261] 'compare' (duration: 75.247078ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:57:22.134581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:21.500541Z","time spent":"633.984715ms","remote":"127.0.0.1:49688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:57:22.134769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.307589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-11T12:57:22.134774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.537864ms","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-08-11T12:57:22.134837Z","caller":"traceutil/trace.go:171","msg":"trace[1809559831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:971; }","duration":"350.416993ms","start":"2026-08-11T12:57:21.784396Z","end":"2026-08-11T12:57:22.134813Z","steps":["trace[1809559831] 'agreement among raft nodes before linearized reading' (duration: 350.143146ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:22.134849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.518315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-11T12:57:22.134896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:21.784363Z","time spent":"350.520254ms","remote":"127.0.0.1:59284","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":"info","ts":"2026-08-11T12:57:22.134874Z","caller":"traceutil/trace.go:171","msg":"trace[705901822] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:971; }","duration":"353.647107ms","start":"2026-08-11T12:57:21.781196Z","end":"2026-08-11T12:57:22.134843Z","steps":["trace[705901822] 'agreement among raft nodes before linearized reading' (duration: 353.326639ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:22.134959Z","caller":"traceutil/trace.go:171","msg":"trace[1686320805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"350.652169ms","start":"2026-08-11T12:57:21.78428Z","end":"2026-08-11T12:57:22.134932Z","steps":["trace[1686320805] 'agreement among raft nodes before linearized reading' (duration: 350.394622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:22.134991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.313752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-11T12:57:22.135036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:21.784245Z","time spent":"350.772401ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T12:57:22.135044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:21.781184Z","time spent":"353.821992ms","remote":"127.0.0.1:59284","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":"info","ts":"2026-08-11T12:57:22.13509Z","caller":"traceutil/trace.go:171","msg":"trace[2027697077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:971; }","duration":"352.468756ms","start":"2026-08-11T12:57:21.782598Z","end":"2026-08-11T12:57:22.135066Z","steps":["trace[2027697077] 'agreement among raft nodes before linearized reading' (duration: 352.137008ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:22.135146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:21.782587Z","time spent":"352.549178ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T12:57:22.13521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.908541ms","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-08-11T12:57:22.135285Z","caller":"traceutil/trace.go:171","msg":"trace[1015219291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"400.041144ms","start":"2026-08-11T12:57:21.73523Z","end":"2026-08-11T12:57:22.135271Z","steps":["trace[1015219291] 'agreement among raft nodes before linearized reading' (duration: 399.536951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:22.135343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:21.735214Z","time spent":"400.117926ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T12:57:22.260956Z","caller":"traceutil/trace.go:171","msg":"trace[127087727] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"121.375251ms","start":"2026-08-11T12:57:22.139553Z","end":"2026-08-11T12:57:22.260928Z","steps":["trace[127087727] 'process raft request' (duration: 98.815363ms)","trace[127087727] 'compare' (duration: 22.287521ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:22.260987Z","caller":"traceutil/trace.go:171","msg":"trace[1498101630] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"121.235636ms","start":"2026-08-11T12:57:22.139723Z","end":"2026-08-11T12:57:22.260959Z","steps":["trace[1498101630] 'process raft request' (duration: 121.157284ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:22.260989Z","caller":"traceutil/trace.go:171","msg":"trace[1489628818] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"121.315039ms","start":"2026-08-11T12:57:22.139647Z","end":"2026-08-11T12:57:22.260962Z","steps":["trace[1489628818] 'process raft request' (duration: 121.158704ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:22.261261Z","caller":"traceutil/trace.go:171","msg":"trace[291834442] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1002; }","duration":"121.34981ms","start":"2026-08-11T12:57:22.139898Z","end":"2026-08-11T12:57:22.261248Z","steps":["trace[291834442] 'read index received' (duration: 66.83032ms)","trace[291834442] 'applied index is now lower than readState.Index' (duration: 54.51866ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:22.26136Z","caller":"traceutil/trace.go:171","msg":"trace[887423373] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"121.01858ms","start":"2026-08-11T12:57:22.140325Z","end":"2026-08-11T12:57:22.261344Z","steps":["trace[887423373] 'process raft request' (duration: 120.590009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:22.261406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.492303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-11T12:57:22.261795Z","caller":"traceutil/trace.go:171","msg":"trace[98124345] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:977; }","duration":"121.911224ms","start":"2026-08-11T12:57:22.13987Z","end":"2026-08-11T12:57:22.261781Z","steps":["trace[98124345] 'agreement among raft nodes before linearized reading' (duration: 121.423741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:49.13099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.797523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:57:49.131336Z","caller":"traceutil/trace.go:171","msg":"trace[819449214] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"698.371905ms","start":"2026-08-11T12:57:48.432945Z","end":"2026-08-11T12:57:49.131317Z","steps":["trace[819449214] 'process raft request' (duration: 698.295533ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:49.131392Z","caller":"traceutil/trace.go:171","msg":"trace[19991334] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"699.075173ms","start":"2026-08-11T12:57:48.432291Z","end":"2026-08-11T12:57:49.131366Z","steps":["trace[19991334] 'process raft request' (duration: 524.599932ms)","trace[19991334] 'compare' (duration: 173.422173ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:49.131423Z","caller":"traceutil/trace.go:171","msg":"trace[381177622] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"698.786586ms","start":"2026-08-11T12:57:48.432608Z","end":"2026-08-11T12:57:49.131394Z","steps":["trace[381177622] 'process raft request' (duration: 698.532849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:49.131439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:48.432936Z","time spent":"698.447477ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:57:49.131475Z","caller":"traceutil/trace.go:171","msg":"trace[104871361] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"697.988825ms","start":"2026-08-11T12:57:48.433445Z","end":"2026-08-11T12:57:49.131433Z","steps":["trace[104871361] 'process raft request' (duration: 697.835851ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:49.131467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:48.432243Z","time spent":"699.182036ms","remote":"127.0.0.1:59284","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-08-11T12:57:49.131555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:48.432591Z","time spent":"698.890218ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:57:49.13167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:57:48.433434Z","time spent":"698.129268ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:57:49.547589Z","caller":"traceutil/trace.go:171","msg":"trace[1907547802] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"168.596007ms","start":"2026-08-11T12:57:49.378969Z","end":"2026-08-11T12:57:49.547565Z","steps":["trace[1907547802] 'read index received' (duration: 168.399082ms)","trace[1907547802] 'applied index is now lower than readState.Index' (duration: 196.095µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:49.547636Z","caller":"traceutil/trace.go:171","msg":"trace[2011803476] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"191.624405ms","start":"2026-08-11T12:57:49.35599Z","end":"2026-08-11T12:57:49.547615Z","steps":["trace[2011803476] 'process raft request' (duration: 191.435451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:49.547719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.728461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:57:49.547758Z","caller":"traceutil/trace.go:171","msg":"trace[1073753300] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1067; }","duration":"168.833154ms","start":"2026-08-11T12:57:49.378915Z","end":"2026-08-11T12:57:49.547748Z","steps":["trace[1073753300] 'agreement among raft nodes before linearized reading' (duration: 168.745402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:49.95194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.556834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:57:49.952055Z","caller":"traceutil/trace.go:171","msg":"trace[1549579709] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1067; }","duration":"196.730498ms","start":"2026-08-11T12:57:49.755305Z","end":"2026-08-11T12:57:49.952036Z","steps":["trace[1549579709] 'count revisions from in-memory index tree' (duration: 196.472011ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:50.587088Z","caller":"traceutil/trace.go:171","msg":"trace[129127282] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"150.035275ms","start":"2026-08-11T12:57:50.437032Z","end":"2026-08-11T12:57:50.587067Z","steps":["trace[129127282] 'process raft request' (duration: 149.904442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:57:51.31303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.788996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:57:51.313444Z","caller":"traceutil/trace.go:171","msg":"trace[727078583] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"172.766905ms","start":"2026-08-11T12:57:51.140644Z","end":"2026-08-11T12:57:51.313411Z","steps":["trace[727078583] 'process raft request' (duration: 46.475446ms)","trace[727078583] 'compare' (duration: 125.686124ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:57:51.313925Z","caller":"traceutil/trace.go:171","msg":"trace[2120696202] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"173.060934ms","start":"2026-08-11T12:57:51.140832Z","end":"2026-08-11T12:57:51.313893Z","steps":["trace[2120696202] 'process raft request' (duration: 172.367405ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:57:51.313988Z","caller":"traceutil/trace.go:171","msg":"trace[959866522] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"171.556706ms","start":"2026-08-11T12:57:51.142406Z","end":"2026-08-11T12:57:51.313962Z","steps":["trace[959866522] 'process raft request' (duration: 171.030441ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:05.785025Z","caller":"traceutil/trace.go:171","msg":"trace[1945043517] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"189.628943ms","start":"2026-08-11T12:58:05.595362Z","end":"2026-08-11T12:58:05.784991Z","steps":["trace[1945043517] 'process raft request' (duration: 189.408108ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:06.853692Z","caller":"traceutil/trace.go:171","msg":"trace[1396737982] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"194.812269ms","start":"2026-08-11T12:58:06.658858Z","end":"2026-08-11T12:58:06.85367Z","steps":["trace[1396737982] 'process raft request' (duration: 194.671695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:07.742704Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369638223573264,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T12:58:08.067601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.384417ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:08.06771Z","caller":"traceutil/trace.go:171","msg":"trace[250529496] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1173; }","duration":"174.50576ms","start":"2026-08-11T12:58:07.893191Z","end":"2026-08-11T12:58:08.067696Z","steps":["trace[250529496] 'range keys from in-memory index tree' (duration: 174.371307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:08.069874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.045392ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T12:58:08.070156Z","caller":"traceutil/trace.go:171","msg":"trace[1205800442] linearizableReadLoop","detail":"{readStateIndex:1216; appliedIndex:1214; }","duration":"828.145544ms","start":"2026-08-11T12:58:07.241991Z","end":"2026-08-11T12:58:08.070137Z","steps":["trace[1205800442] 'read index received' (duration: 614.828995ms)","trace[1205800442] 'applied index is now lower than readState.Index' (duration: 213.313919ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:58:08.070445Z","caller":"traceutil/trace.go:171","msg":"trace[1931278134] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"803.203716ms","start":"2026-08-11T12:58:07.267226Z","end":"2026-08-11T12:58:08.07043Z","steps":["trace[1931278134] 'process raft request' (duration: 802.748015ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:08.070577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:07.267202Z","time spent":"803.311589ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:58:08.070839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.242465ms","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-08-11T12:58:08.070924Z","caller":"traceutil/trace.go:171","msg":"trace[471144097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1175; }","duration":"682.389808ms","start":"2026-08-11T12:58:07.388513Z","end":"2026-08-11T12:58:08.070903Z","steps":["trace[471144097] 'agreement among raft nodes before linearized reading' (duration: 682.157312ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:08.071021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:07.38849Z","time spent":"682.514602ms","remote":"127.0.0.1:59284","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-08-11T12:58:08.071174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.183951ms","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-08-11T12:58:08.071229Z","caller":"traceutil/trace.go:171","msg":"trace[526179802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1175; }","duration":"829.274343ms","start":"2026-08-11T12:58:07.24194Z","end":"2026-08-11T12:58:08.071215Z","steps":["trace[526179802] 'agreement among raft nodes before linearized reading' (duration: 829.095679ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:08.071269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:07.241922Z","time spent":"829.339725ms","remote":"127.0.0.1:59284","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":"warn","ts":"2026-08-11T12:58:08.071297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.796338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T12:58:08.071332Z","caller":"traceutil/trace.go:171","msg":"trace[450787452] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"680.860879ms","start":"2026-08-11T12:58:07.39046Z","end":"2026-08-11T12:58:08.071321Z","steps":["trace[450787452] 'agreement among raft nodes before linearized reading' (duration: 680.758917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:08.071368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:07.390446Z","time spent":"680.914561ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T12:58:08.071486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.933008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T12:58:08.071515Z","caller":"traceutil/trace.go:171","msg":"trace[2034226936] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1175; }","duration":"682.01064ms","start":"2026-08-11T12:58:07.389497Z","end":"2026-08-11T12:58:08.071507Z","steps":["trace[2034226936] 'agreement among raft nodes before linearized reading' (duration: 681.936468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:08.071541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:07.389476Z","time spent":"682.058842ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T12:58:08.071558Z","caller":"traceutil/trace.go:171","msg":"trace[134083632] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"280.70967ms","start":"2026-08-11T12:58:07.790834Z","end":"2026-08-11T12:58:08.071543Z","steps":["trace[134083632] 'process raft request' (duration: 279.254292ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:21.115572Z","caller":"traceutil/trace.go:171","msg":"trace[1863122180] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"199.020198ms","start":"2026-08-11T12:58:20.916532Z","end":"2026-08-11T12:58:21.115552Z","steps":["trace[1863122180] 'process raft request' (duration: 198.670549ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:23.212219Z","caller":"traceutil/trace.go:171","msg":"trace[18594174] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"141.957325ms","start":"2026-08-11T12:58:23.070242Z","end":"2026-08-11T12:58:23.212199Z","steps":["trace[18594174] 'process raft request' (duration: 141.840882ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:23.229356Z","caller":"traceutil/trace.go:171","msg":"trace[1130875494] linearizableReadLoop","detail":"{readStateIndex:1288; appliedIndex:1287; }","duration":"129.83217ms","start":"2026-08-11T12:58:23.099515Z","end":"2026-08-11T12:58:23.229347Z","steps":["trace[1130875494] 'read index received' (duration: 112.664695ms)","trace[1130875494] 'applied index is now lower than readState.Index' (duration: 17.165545ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:23.229444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.917613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:23.229461Z","caller":"traceutil/trace.go:171","msg":"trace[173733835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"129.968934ms","start":"2026-08-11T12:58:23.099488Z","end":"2026-08-11T12:58:23.229457Z","steps":["trace[173733835] 'agreement among raft nodes before linearized reading' (duration: 129.899192ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:23.229596Z","caller":"traceutil/trace.go:171","msg":"trace[352878670] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"146.051523ms","start":"2026-08-11T12:58:23.083539Z","end":"2026-08-11T12:58:23.229591Z","steps":["trace[352878670] 'process raft request' (duration: 145.717644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:23.264408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.19566ms","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-08-11T12:58:23.264449Z","caller":"traceutil/trace.go:171","msg":"trace[1864351176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1246; }","duration":"145.261412ms","start":"2026-08-11T12:58:23.119176Z","end":"2026-08-11T12:58:23.264438Z","steps":["trace[1864351176] 'agreement among raft nodes before linearized reading' (duration: 145.140039ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:24.286047Z","caller":"traceutil/trace.go:171","msg":"trace[1027976230] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"155.766615ms","start":"2026-08-11T12:58:24.130237Z","end":"2026-08-11T12:58:24.286004Z","steps":["trace[1027976230] 'process raft request' (duration: 155.330293ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:24.883499Z","caller":"traceutil/trace.go:171","msg":"trace[1342951600] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"592.66867ms","start":"2026-08-11T12:58:24.290802Z","end":"2026-08-11T12:58:24.883471Z","steps":["trace[1342951600] 'process raft request' (duration: 528.728559ms)","trace[1342951600] 'compare' (duration: 63.429798ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:24.883649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:24.29078Z","time spent":"592.789114ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:58:24.893224Z","caller":"traceutil/trace.go:171","msg":"trace[1644287986] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"601.859628ms","start":"2026-08-11T12:58:24.291342Z","end":"2026-08-11T12:58:24.893201Z","steps":["trace[1644287986] 'process raft request' (duration: 601.799077ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:24.893387Z","caller":"traceutil/trace.go:171","msg":"trace[1016778339] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1293; }","duration":"364.344921ms","start":"2026-08-11T12:58:24.529033Z","end":"2026-08-11T12:58:24.893378Z","steps":["trace[1016778339] 'read index received' (duration: 290.509214ms)","trace[1016778339] 'applied index is now lower than readState.Index' (duration: 73.834327ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:24.893389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:24.291326Z","time spent":"601.970902ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:58:24.893476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.438104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:24.893234Z","caller":"traceutil/trace.go:171","msg":"trace[1494730039] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"602.160546ms","start":"2026-08-11T12:58:24.291052Z","end":"2026-08-11T12:58:24.893213Z","steps":["trace[1494730039] 'process raft request' (duration: 601.976352ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:24.8935Z","caller":"traceutil/trace.go:171","msg":"trace[761890997] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1252; }","duration":"364.512875ms","start":"2026-08-11T12:58:24.528979Z","end":"2026-08-11T12:58:24.893492Z","steps":["trace[761890997] 'agreement among raft nodes before linearized reading' (duration: 364.432403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:24.893527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:24.528951Z","time spent":"364.568366ms","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-08-11T12:58:24.893528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:24.291032Z","time spent":"602.469694ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:58:24.893638Z","caller":"traceutil/trace.go:171","msg":"trace[1911892069] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"600.03137ms","start":"2026-08-11T12:58:24.293597Z","end":"2026-08-11T12:58:24.893629Z","steps":["trace[1911892069] 'process raft request' (duration: 599.573828ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:24.893748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:24.293586Z","time spent":"600.082732ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:58:26.211652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.701679ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:58:26.211744Z","caller":"traceutil/trace.go:171","msg":"trace[197978845] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"105.680004ms","start":"2026-08-11T12:58:26.106052Z","end":"2026-08-11T12:58:26.211732Z","steps":["trace[197978845] 'read index received' (duration: 80.012µs)","trace[197978845] 'applied index is now lower than readState.Index' (duration: 105.598742ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:26.211788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.758166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:26.211805Z","caller":"traceutil/trace.go:171","msg":"trace[168996230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"105.844029ms","start":"2026-08-11T12:58:26.105954Z","end":"2026-08-11T12:58:26.211798Z","steps":["trace[168996230] 'agreement among raft nodes before linearized reading' (duration: 105.806698ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:26.211834Z","caller":"traceutil/trace.go:171","msg":"trace[1203872589] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"765.891907ms","start":"2026-08-11T12:58:25.445883Z","end":"2026-08-11T12:58:26.211775Z","steps":["trace[1203872589] 'process raft request' (duration: 494.995373ms)","trace[1203872589] 'compare' (duration: 270.362851ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:26.212071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:25.445863Z","time spent":"766.082592ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:58:26.78356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.789303ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:58:26.783698Z","caller":"traceutil/trace.go:171","msg":"trace[465143425] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"471.718809ms","start":"2026-08-11T12:58:26.311958Z","end":"2026-08-11T12:58:26.783677Z","steps":["trace[465143425] 'process raft request' (duration: 260.681939ms)","trace[465143425] 'compare' (duration: 210.629699ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:26.783763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:26.311938Z","time spent":"471.792281ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:58:27.112626Z","caller":"traceutil/trace.go:171","msg":"trace[1499810250] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"149.218575ms","start":"2026-08-11T12:58:26.963361Z","end":"2026-08-11T12:58:27.112579Z","steps":["trace[1499810250] 'process raft request' (duration: 101.309171ms)","trace[1499810250] 'compare' (duration: 47.784421ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:58:27.112847Z","caller":"traceutil/trace.go:171","msg":"trace[1050038804] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"149.417161ms","start":"2026-08-11T12:58:26.963418Z","end":"2026-08-11T12:58:27.112835Z","steps":["trace[1050038804] 'process raft request' (duration: 149.258577ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:27.112873Z","caller":"traceutil/trace.go:171","msg":"trace[300804893] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"149.333158ms","start":"2026-08-11T12:58:26.963513Z","end":"2026-08-11T12:58:27.112847Z","steps":["trace[300804893] 'process raft request' (duration: 149.293227ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:27.710444Z","caller":"traceutil/trace.go:171","msg":"trace[275412552] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"298.200843ms","start":"2026-08-11T12:58:27.412226Z","end":"2026-08-11T12:58:27.710427Z","steps":["trace[275412552] 'process raft request' (duration: 298.09203ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:28.084754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.008822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:28.084831Z","caller":"traceutil/trace.go:171","msg":"trace[532746360] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1266; }","duration":"131.144256ms","start":"2026-08-11T12:58:27.953669Z","end":"2026-08-11T12:58:28.084813Z","steps":["trace[532746360] 'count revisions from in-memory index tree' (duration: 130.901699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:28.084769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.082128ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:28.084897Z","caller":"traceutil/trace.go:171","msg":"trace[48303698] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1266; }","duration":"192.220811ms","start":"2026-08-11T12:58:27.892658Z","end":"2026-08-11T12:58:28.084878Z","steps":["trace[48303698] 'range keys from in-memory index tree' (duration: 192.066018ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:29.241782Z","caller":"traceutil/trace.go:171","msg":"trace[1096157049] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"121.924707ms","start":"2026-08-11T12:58:29.119839Z","end":"2026-08-11T12:58:29.241764Z","steps":["trace[1096157049] 'process raft request' (duration: 121.793813ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:29.264019Z","caller":"traceutil/trace.go:171","msg":"trace[34275614] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"143.293201ms","start":"2026-08-11T12:58:29.120708Z","end":"2026-08-11T12:58:29.264002Z","steps":["trace[34275614] 'process raft request' (duration: 143.268811ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:29.264129Z","caller":"traceutil/trace.go:171","msg":"trace[1584720335] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"144.0091ms","start":"2026-08-11T12:58:29.120079Z","end":"2026-08-11T12:58:29.264088Z","steps":["trace[1584720335] 'process raft request' (duration: 143.804325ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:58:30.497394Z","caller":"traceutil/trace.go:171","msg":"trace[1353907202] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1318; }","duration":"396.552448ms","start":"2026-08-11T12:58:30.100813Z","end":"2026-08-11T12:58:30.497365Z","steps":["trace[1353907202] 'read index received' (duration: 396.295522ms)","trace[1353907202] 'applied index is now lower than readState.Index' (duration: 255.776µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:58:30.497519Z","caller":"traceutil/trace.go:171","msg":"trace[498790029] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"780.445626ms","start":"2026-08-11T12:58:29.717033Z","end":"2026-08-11T12:58:30.497478Z","steps":["trace[498790029] 'process raft request' (duration: 780.152729ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:30.497631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.792184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T12:58:30.497689Z","caller":"traceutil/trace.go:171","msg":"trace[2015045674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1273; }","duration":"396.902627ms","start":"2026-08-11T12:58:30.10077Z","end":"2026-08-11T12:58:30.497672Z","steps":["trace[2015045674] 'agreement among raft nodes before linearized reading' (duration: 396.739763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:30.497734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:29.717024Z","time spent":"780.6028ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:58:30.497776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:30.100749Z","time spent":"396.981439ms","remote":"127.0.0.1:49652","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-08-11T12:58:31.098267Z","caller":"traceutil/trace.go:171","msg":"trace[1484688055] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"258.529443ms","start":"2026-08-11T12:58:30.83972Z","end":"2026-08-11T12:58:31.09825Z","steps":["trace[1484688055] 'process raft request' (duration: 255.893444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:58:33.144069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.888955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T12:58:33.144211Z","caller":"traceutil/trace.go:171","msg":"trace[998337309] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"495.836285ms","start":"2026-08-11T12:58:32.648345Z","end":"2026-08-11T12:58:33.144181Z","steps":["trace[998337309] 'process raft request' (duration: 110.752735ms)","trace[998337309] 'compare' (duration: 384.68313ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:58:33.144355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:58:32.648324Z","time spent":"495.973439ms","remote":"127.0.0.1:59284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T13:01:29.981938Z","caller":"traceutil/trace.go:171","msg":"trace[172814847] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2233; }","duration":"100.119415ms","start":"2026-08-11T13:01:29.881795Z","end":"2026-08-11T13:01:29.981915Z","steps":["trace[172814847] 'read index received' (duration: 92.830706ms)","trace[172814847] 'applied index is now lower than readState.Index' (duration: 7.287669ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T13:01:29.982063Z","caller":"traceutil/trace.go:171","msg":"trace[1243757038] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"236.737515ms","start":"2026-08-11T13:01:29.745295Z","end":"2026-08-11T13:01:29.982033Z","steps":["trace[1243757038] 'process raft request' (duration: 229.21278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T13:01:29.98226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.440753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-08-11T13:01:29.982448Z","caller":"traceutil/trace.go:171","msg":"trace[1613427758] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2151; }","duration":"100.661359ms","start":"2026-08-11T13:01:29.881764Z","end":"2026-08-11T13:01:29.982425Z","steps":["trace[1613427758] 'agreement among raft nodes before linearized reading' (duration: 100.29325ms)"],"step_count":1}