{"level":"warn","ts":"2026-08-12T17:42:06.036961Z","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-12T17:42:06.037104Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.176:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.176:2380","--initial-cluster=instance=https://199.19.213.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.176: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-12T17:42:06.0372Z","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-12T17:42:06.037215Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.176:2380"]} {"level":"info","ts":"2026-08-12T17:42:06.03725Z","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-12T17:42:06.03829Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"]} {"level":"info","ts":"2026-08-12T17:42:06.0384Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.176:2380"],"listen-peer-urls":["https://199.19.213.176:2380"],"advertise-client-urls":["https://199.19.213.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.176: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-12T17:42:06.044515Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.862768ms"} {"level":"info","ts":"2026-08-12T17:42:06.052657Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e120e57916b9bd4","cluster-id":"e644555f29703ff6"} {"level":"info","ts":"2026-08-12T17:42:06.052755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=()"} {"level":"info","ts":"2026-08-12T17:42:06.052778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became follower at term 0"} {"level":"info","ts":"2026-08-12T17:42:06.05279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e120e57916b9bd4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-12T17:42:06.052803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became follower at term 1"} {"level":"info","ts":"2026-08-12T17:42:06.052846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=(7931417663017556948)"} {"level":"warn","ts":"2026-08-12T17:42:06.060794Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-12T17:42:06.062305Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-12T17:42:06.063564Z","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-12T17:42:06.065597Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e120e57916b9bd4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-12T17:42:06.066095Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e120e57916b9bd4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-12T17:42:06.06652Z","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-12T17:42:06.067299Z","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-12T17:42:06.067312Z","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-12T17:42:06.067683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=(7931417663017556948)"} {"level":"info","ts":"2026-08-12T17:42:06.067846Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e644555f29703ff6","local-member-id":"6e120e57916b9bd4","added-peer-id":"6e120e57916b9bd4","added-peer-peer-urls":["https://199.19.213.176:2380"]} {"level":"info","ts":"2026-08-12T17:42:06.070621Z","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-12T17:42:06.070725Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.176:2380"} {"level":"info","ts":"2026-08-12T17:42:06.070752Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.176:2380"} {"level":"info","ts":"2026-08-12T17:42:06.071018Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e120e57916b9bd4","initial-advertise-peer-urls":["https://199.19.213.176:2380"],"listen-peer-urls":["https://199.19.213.176:2380"],"advertise-client-urls":["https://199.19.213.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-12T17:42:06.071059Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-12T17:42:06.253593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 is starting a new election at term 1"} {"level":"info","ts":"2026-08-12T17:42:06.253722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-12T17:42:06.253788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 received MsgPreVoteResp from 6e120e57916b9bd4 at term 1"} {"level":"info","ts":"2026-08-12T17:42:06.253834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became candidate at term 2"} {"level":"info","ts":"2026-08-12T17:42:06.253884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 received MsgVoteResp from 6e120e57916b9bd4 at term 2"} {"level":"info","ts":"2026-08-12T17:42:06.253959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became leader at term 2"} {"level":"info","ts":"2026-08-12T17:42:06.254011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e120e57916b9bd4 elected leader 6e120e57916b9bd4 at term 2"} {"level":"info","ts":"2026-08-12T17:42:06.255021Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:42:06.255417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e120e57916b9bd4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.176:2379]}","request-path":"/0/members/6e120e57916b9bd4/attributes","cluster-id":"e644555f29703ff6","publish-timeout":"7s"} {"level":"info","ts":"2026-08-12T17:42:06.25545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T17:42:06.255429Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T17:42:06.256071Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e644555f29703ff6","local-member-id":"6e120e57916b9bd4","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:42:06.256195Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:42:06.25626Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:42:06.25647Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-12T17:42:06.256667Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-12T17:42:06.261419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-12T17:42:06.262569Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.176:2379"} {"level":"info","ts":"2026-08-12T17:42:43.695211Z","caller":"traceutil/trace.go:171","msg":"trace[1056455787] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"210.859567ms","start":"2026-08-12T17:42:43.484325Z","end":"2026-08-12T17:42:43.695184Z","steps":["trace[1056455787] 'process raft request' (duration: 210.713253ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.775362Z","caller":"traceutil/trace.go:171","msg":"trace[1109896529] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"280.408086ms","start":"2026-08-12T17:42:43.494913Z","end":"2026-08-12T17:42:43.775321Z","steps":["trace[1109896529] 'process raft request' (duration: 269.087803ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.775555Z","caller":"traceutil/trace.go:171","msg":"trace[186858050] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"257.221704ms","start":"2026-08-12T17:42:43.518308Z","end":"2026-08-12T17:42:43.77553Z","steps":["trace[186858050] 'process raft request' (duration: 257.033808ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.775412Z","caller":"traceutil/trace.go:171","msg":"trace[1662240480] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"274.283561ms","start":"2026-08-12T17:42:43.501093Z","end":"2026-08-12T17:42:43.775376Z","steps":["trace[1662240480] 'process raft request' (duration: 274.129916ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.775759Z","caller":"traceutil/trace.go:171","msg":"trace[393846905] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"257.053329ms","start":"2026-08-12T17:42:43.518572Z","end":"2026-08-12T17:42:43.775625Z","steps":["trace[393846905] 'process raft request' (duration: 256.870913ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.77592Z","caller":"traceutil/trace.go:171","msg":"trace[483689296] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"253.766958ms","start":"2026-08-12T17:42:43.522135Z","end":"2026-08-12T17:42:43.775902Z","steps":["trace[483689296] 'process raft request' (duration: 253.352065ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.776137Z","caller":"traceutil/trace.go:171","msg":"trace[1681914387] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"232.325928ms","start":"2026-08-12T17:42:43.543776Z","end":"2026-08-12T17:42:43.776102Z","steps":["trace[1681914387] 'process raft request' (duration: 232.088201ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.775882Z","caller":"traceutil/trace.go:171","msg":"trace[1369989715] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"257.44193ms","start":"2026-08-12T17:42:43.518367Z","end":"2026-08-12T17:42:43.775809Z","steps":["trace[1369989715] 'process raft request' (duration: 257.022997ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.778813Z","caller":"traceutil/trace.go:171","msg":"trace[1806633262] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"215.710914ms","start":"2026-08-12T17:42:43.563048Z","end":"2026-08-12T17:42:43.778759Z","steps":["trace[1806633262] 'process raft request' (duration: 213.754814ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.779271Z","caller":"traceutil/trace.go:171","msg":"trace[1224345488] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"238.97149ms","start":"2026-08-12T17:42:43.536986Z","end":"2026-08-12T17:42:43.775958Z","steps":["trace[1224345488] 'process raft request' (duration: 238.574388ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.775496Z","caller":"traceutil/trace.go:171","msg":"trace[1063323709] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"272.91232ms","start":"2026-08-12T17:42:43.502524Z","end":"2026-08-12T17:42:43.775436Z","steps":["trace[1063323709] 'process raft request' (duration: 272.762115ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.847453Z","caller":"traceutil/trace.go:171","msg":"trace[147962629] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"145.870745ms","start":"2026-08-12T17:42:43.701537Z","end":"2026-08-12T17:42:43.847408Z","steps":["trace[147962629] 'process raft request' (duration: 145.564686ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.847759Z","caller":"traceutil/trace.go:171","msg":"trace[1854782447] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"144.013649ms","start":"2026-08-12T17:42:43.703716Z","end":"2026-08-12T17:42:43.847729Z","steps":["trace[1854782447] 'process raft request' (duration: 143.541615ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:43.847892Z","caller":"traceutil/trace.go:171","msg":"trace[163648584] transaction","detail":"{read_only:false; number_of_response:1; response_revision:534; }","duration":"143.834704ms","start":"2026-08-12T17:42:43.704049Z","end":"2026-08-12T17:42:43.847883Z","steps":["trace[163648584] 'process raft request' (duration: 143.614847ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:49.199101Z","caller":"traceutil/trace.go:171","msg":"trace[115110525] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"193.129543ms","start":"2026-08-12T17:42:49.005942Z","end":"2026-08-12T17:42:49.199071Z","steps":["trace[115110525] 'process raft request' (duration: 192.948527ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:42:50.221782Z","caller":"traceutil/trace.go:171","msg":"trace[2091502990] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"134.147048ms","start":"2026-08-12T17:42:50.087595Z","end":"2026-08-12T17:42:50.221742Z","steps":["trace[2091502990] 'process raft request' (duration: 133.072804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:42:51.111211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.51484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T17:42:51.111526Z","caller":"traceutil/trace.go:171","msg":"trace[1604782459] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"848.876241ms","start":"2026-08-12T17:42:50.262625Z","end":"2026-08-12T17:42:51.111501Z","steps":["trace[1604782459] 'process raft request' (duration: 61.518535ms)","trace[1604782459] 'compare' (duration: 786.360585ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:42:51.111617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:42:50.262617Z","time spent":"848.955463ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:42:51.11172Z","caller":"traceutil/trace.go:171","msg":"trace[118347451] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"675.072492ms","start":"2026-08-12T17:42:50.436607Z","end":"2026-08-12T17:42:51.111679Z","steps":["trace[118347451] 'read index received' (duration: 330.80247ms)","trace[118347451] 'applied index is now lower than readState.Index' (duration: 344.268652ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:42:51.111735Z","caller":"traceutil/trace.go:171","msg":"trace[486031750] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"809.327993ms","start":"2026-08-12T17:42:50.302355Z","end":"2026-08-12T17:42:51.111683Z","steps":["trace[486031750] 'process raft request' (duration: 808.984743ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:42:51.111922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:42:50.302326Z","time spent":"809.511659ms","remote":"127.0.0.1:60652","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-12T17:42:51.112001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.680088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:42:51.112054Z","caller":"traceutil/trace.go:171","msg":"trace[1988554504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"393.769381ms","start":"2026-08-12T17:42:50.718267Z","end":"2026-08-12T17:42:51.112036Z","steps":["trace[1988554504] 'agreement among raft nodes before linearized reading' (duration: 393.696848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:42:51.112051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.129064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vn4s4\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-12T17:42:51.112087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:42:50.718242Z","time spent":"393.838393ms","remote":"127.0.0.1:60444","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-12T17:42:51.112094Z","caller":"traceutil/trace.go:171","msg":"trace[1441965894] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vn4s4; range_end:; response_count:1; response_revision:620; }","duration":"667.210267ms","start":"2026-08-12T17:42:50.444869Z","end":"2026-08-12T17:42:51.112079Z","steps":["trace[1441965894] 'agreement among raft nodes before linearized reading' (duration: 666.99659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:42:51.112139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:42:50.444862Z","time spent":"667.267818ms","remote":"127.0.0.1:60630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-vn4s4\" "} {"level":"warn","ts":"2026-08-12T17:42:51.112103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.459335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-12T17:42:51.112235Z","caller":"traceutil/trace.go:171","msg":"trace[1252693129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"675.64268ms","start":"2026-08-12T17:42:50.436538Z","end":"2026-08-12T17:42:51.112181Z","steps":["trace[1252693129] 'agreement among raft nodes before linearized reading' (duration: 675.224147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:42:51.112292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:42:50.43651Z","time spent":"675.771604ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-12T17:42:52.783915Z","caller":"traceutil/trace.go:171","msg":"trace[1872301402] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"195.391484ms","start":"2026-08-12T17:42:52.588499Z","end":"2026-08-12T17:42:52.78389Z","steps":["trace[1872301402] 'process raft request' (duration: 194.410063ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:43:02.734437Z","caller":"traceutil/trace.go:171","msg":"trace[1206284735] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"184.675588ms","start":"2026-08-12T17:43:02.549715Z","end":"2026-08-12T17:43:02.73439Z","steps":["trace[1206284735] 'process raft request' (duration: 127.159529ms)","trace[1206284735] 'compare' (duration: 57.20282ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:43:02.740327Z","caller":"traceutil/trace.go:171","msg":"trace[695515471] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"189.273003ms","start":"2026-08-12T17:43:02.551035Z","end":"2026-08-12T17:43:02.740308Z","steps":["trace[695515471] 'process raft request' (duration: 187.713084ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:43:02.741709Z","caller":"traceutil/trace.go:171","msg":"trace[2038316200] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"183.74938ms","start":"2026-08-12T17:43:02.557941Z","end":"2026-08-12T17:43:02.74169Z","steps":["trace[2038316200] 'process raft request' (duration: 181.612863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:05.693098Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11228775654435449513,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-12T17:43:05.758333Z","caller":"traceutil/trace.go:171","msg":"trace[557417201] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"565.758222ms","start":"2026-08-12T17:43:05.192532Z","end":"2026-08-12T17:43:05.75829Z","steps":["trace[557417201] 'read index received' (duration: 565.483424ms)","trace[557417201] 'applied index is now lower than readState.Index' (duration: 273.448µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:43:05.758467Z","caller":"traceutil/trace.go:171","msg":"trace[1873610254] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"570.390707ms","start":"2026-08-12T17:43:05.188066Z","end":"2026-08-12T17:43:05.758457Z","steps":["trace[1873610254] 'process raft request' (duration: 570.027055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:05.758725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.579396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-12T17:43:05.758834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.307929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-12T17:43:05.758841Z","caller":"traceutil/trace.go:171","msg":"trace[1944858312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"332.719531ms","start":"2026-08-12T17:43:05.426065Z","end":"2026-08-12T17:43:05.758785Z","steps":["trace[1944858312] 'agreement among raft nodes before linearized reading' (duration: 332.462163ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:43:05.758891Z","caller":"traceutil/trace.go:171","msg":"trace[1286822570] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"566.417573ms","start":"2026-08-12T17:43:05.19246Z","end":"2026-08-12T17:43:05.758878Z","steps":["trace[1286822570] 'agreement among raft nodes before linearized reading' (duration: 566.212306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:05.758927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:05.192436Z","time spent":"566.482945ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-12T17:43:05.758929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:05.426043Z","time spent":"332.876185ms","remote":"127.0.0.1:60710","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-12T17:43:05.759229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:05.188031Z","time spent":"570.46424ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:43:05.759274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.323171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r2hwb\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-12T17:43:05.759352Z","caller":"traceutil/trace.go:171","msg":"trace[2040400012] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-r2hwb; range_end:; response_count:1; response_revision:792; }","duration":"202.425244ms","start":"2026-08-12T17:43:05.556893Z","end":"2026-08-12T17:43:05.759318Z","steps":["trace[2040400012] 'agreement among raft nodes before linearized reading' (duration: 202.204437ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:43:20.163745Z","caller":"traceutil/trace.go:171","msg":"trace[2024111444] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"283.79259ms","start":"2026-08-12T17:43:19.879929Z","end":"2026-08-12T17:43:20.163722Z","steps":["trace[2024111444] 'process raft request' (duration: 218.865539ms)","trace[2024111444] 'compare' (duration: 64.2648ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:43:20.163934Z","caller":"traceutil/trace.go:171","msg":"trace[1403475389] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"282.958003ms","start":"2026-08-12T17:43:19.880964Z","end":"2026-08-12T17:43:20.163922Z","steps":["trace[1403475389] 'process raft request' (duration: 282.252861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:31.065618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.558675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:43:31.06576Z","caller":"traceutil/trace.go:171","msg":"trace[730053071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:970; }","duration":"347.817063ms","start":"2026-08-12T17:43:30.717913Z","end":"2026-08-12T17:43:31.06573Z","steps":["trace[730053071] 'range keys from in-memory index tree' (duration: 347.433761ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:31.065833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:30.71789Z","time spent":"347.931647ms","remote":"127.0.0.1:60444","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-12T17:43:31.066003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.798274ms","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-12T17:43:31.066099Z","caller":"traceutil/trace.go:171","msg":"trace[288975669] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:970; }","duration":"542.965039ms","start":"2026-08-12T17:43:30.523113Z","end":"2026-08-12T17:43:31.066078Z","steps":["trace[288975669] 'range keys from in-memory index tree' (duration: 542.565786ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:31.066147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:30.523086Z","time spent":"543.047761ms","remote":"127.0.0.1:60710","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-12T17:43:31.066313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.589225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T17:43:31.066423Z","caller":"traceutil/trace.go:171","msg":"trace[1043507846] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:970; }","duration":"470.74205ms","start":"2026-08-12T17:43:30.59566Z","end":"2026-08-12T17:43:31.066402Z","steps":["trace[1043507846] 'count revisions from in-memory index tree' (duration: 470.523642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:31.066455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:30.595651Z","time spent":"470.796101ms","remote":"127.0.0.1:41426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-08-12T17:43:54.512036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.069186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-12T17:43:54.512145Z","caller":"traceutil/trace.go:171","msg":"trace[920810722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1050; }","duration":"113.235301ms","start":"2026-08-12T17:43:54.398886Z","end":"2026-08-12T17:43:54.512122Z","steps":["trace[920810722] 'range keys from in-memory index tree' (duration: 112.827329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:54.51224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.279457ms","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-12T17:43:54.512513Z","caller":"traceutil/trace.go:171","msg":"trace[35272655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1050; }","duration":"109.722231ms","start":"2026-08-12T17:43:54.402758Z","end":"2026-08-12T17:43:54.51248Z","steps":["trace[35272655] 'range keys from in-memory index tree' (duration: 109.06794ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:43:54.727736Z","caller":"traceutil/trace.go:171","msg":"trace[1052202744] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"210.537199ms","start":"2026-08-12T17:43:54.517166Z","end":"2026-08-12T17:43:54.727704Z","steps":["trace[1052202744] 'process raft request' (duration: 210.350303ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:43:55.062701Z","caller":"traceutil/trace.go:171","msg":"trace[1827498692] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"545.480163ms","start":"2026-08-12T17:43:54.517195Z","end":"2026-08-12T17:43:55.062675Z","steps":["trace[1827498692] 'process raft request' (duration: 514.859288ms)","trace[1827498692] 'compare' (duration: 29.963584ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:43:55.062841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:54.517171Z","time spent":"545.606986ms","remote":"127.0.0.1:60710","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-12T17:43:55.089174Z","caller":"traceutil/trace.go:171","msg":"trace[84848687] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1089; }","duration":"505.167551ms","start":"2026-08-12T17:43:54.583986Z","end":"2026-08-12T17:43:55.089154Z","steps":["trace[84848687] 'read index received' (duration: 143.6332ms)","trace[84848687] 'applied index is now lower than readState.Index' (duration: 361.533311ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:43:55.089366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.376288ms","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-12T17:43:55.089408Z","caller":"traceutil/trace.go:171","msg":"trace[124012622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"505.465731ms","start":"2026-08-12T17:43:54.58393Z","end":"2026-08-12T17:43:55.089396Z","steps":["trace[124012622] 'agreement among raft nodes before linearized reading' (duration: 505.294766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:55.08944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:54.583913Z","time spent":"505.519543ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-12T17:43:56.526379Z","caller":"traceutil/trace.go:171","msg":"trace[1703957693] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"317.854894ms","start":"2026-08-12T17:43:56.208499Z","end":"2026-08-12T17:43:56.526354Z","steps":["trace[1703957693] 'process raft request' (duration: 317.697579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:43:56.526521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:43:56.208473Z","time spent":"317.979808ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:12.941695Z","caller":"traceutil/trace.go:171","msg":"trace[426582760] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"224.401767ms","start":"2026-08-12T17:44:12.717277Z","end":"2026-08-12T17:44:12.941679Z","steps":["trace[426582760] 'read index received' (duration: 224.297734ms)","trace[426582760] 'applied index is now lower than readState.Index' (duration: 103.173µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:12.94181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.526171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:12.941838Z","caller":"traceutil/trace.go:171","msg":"trace[269317158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1160; }","duration":"224.598703ms","start":"2026-08-12T17:44:12.717233Z","end":"2026-08-12T17:44:12.941831Z","steps":["trace[269317158] 'agreement among raft nodes before linearized reading' (duration: 224.543601ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:12.941795Z","caller":"traceutil/trace.go:171","msg":"trace[1408989265] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"337.978299ms","start":"2026-08-12T17:44:12.603771Z","end":"2026-08-12T17:44:12.941749Z","steps":["trace[1408989265] 'process raft request' (duration: 337.810274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:12.942039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:12.603752Z","time spent":"338.141684ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:25.515686Z","caller":"traceutil/trace.go:171","msg":"trace[1079683746] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"119.655654ms","start":"2026-08-12T17:44:25.396Z","end":"2026-08-12T17:44:25.515655Z","steps":["trace[1079683746] 'read index received' (duration: 76.494563ms)","trace[1079683746] 'applied index is now lower than readState.Index' (duration: 43.157601ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:44:25.515779Z","caller":"traceutil/trace.go:171","msg":"trace[1656341021] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"123.502485ms","start":"2026-08-12T17:44:25.392246Z","end":"2026-08-12T17:44:25.515748Z","steps":["trace[1656341021] 'process raft request' (duration: 80.285332ms)","trace[1656341021] 'compare' (duration: 42.347885ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:25.515994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.966254ms","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-12T17:44:25.516047Z","caller":"traceutil/trace.go:171","msg":"trace[1929753218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1203; }","duration":"120.048496ms","start":"2026-08-12T17:44:25.395979Z","end":"2026-08-12T17:44:25.516028Z","steps":["trace[1929753218] 'agreement among raft nodes before linearized reading' (duration: 119.837369ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:31.109864Z","caller":"traceutil/trace.go:171","msg":"trace[1011756621] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"252.433691ms","start":"2026-08-12T17:44:30.857398Z","end":"2026-08-12T17:44:31.109831Z","steps":["trace[1011756621] 'process raft request' (duration: 252.174613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:31.45112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.368883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T17:44:31.451325Z","caller":"traceutil/trace.go:171","msg":"trace[996169197] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1288; }","duration":"119.486788ms","start":"2026-08-12T17:44:31.331822Z","end":"2026-08-12T17:44:31.451309Z","steps":["trace[996169197] 'read index received' (duration: 94.421988ms)","trace[996169197] 'applied index is now lower than readState.Index' (duration: 25.06378ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:31.451437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.618162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:31.451487Z","caller":"traceutil/trace.go:171","msg":"trace[2063590320] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1241; }","duration":"119.710885ms","start":"2026-08-12T17:44:31.331761Z","end":"2026-08-12T17:44:31.451472Z","steps":["trace[2063590320] 'agreement among raft nodes before linearized reading' (duration: 119.604102ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:31.451672Z","caller":"traceutil/trace.go:171","msg":"trace[1494977716] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"336.725659ms","start":"2026-08-12T17:44:31.114925Z","end":"2026-08-12T17:44:31.451651Z","steps":["trace[1494977716] 'process raft request' (duration: 152.749037ms)","trace[1494977716] 'compare' (duration: 183.148316ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:31.45176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.114906Z","time spent":"336.815452ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:31.451723Z","caller":"traceutil/trace.go:171","msg":"trace[860341875] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"336.644246ms","start":"2026-08-12T17:44:31.115049Z","end":"2026-08-12T17:44:31.451693Z","steps":["trace[860341875] 'process raft request' (duration: 336.183182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:31.452698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.115027Z","time spent":"337.573586ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:44:32.171858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11228775654435450541,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T17:44:32.755821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.062176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T17:44:32.756193Z","caller":"traceutil/trace.go:171","msg":"trace[71125791] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1290; }","duration":"1.084966476s","start":"2026-08-12T17:44:31.671208Z","end":"2026-08-12T17:44:32.756174Z","steps":["trace[71125791] 'read index received' (duration: 762.470536ms)","trace[71125791] 'applied index is now lower than readState.Index' (duration: 322.49485ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:44:32.756471Z","caller":"traceutil/trace.go:171","msg":"trace[94426527] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"1.298406207s","start":"2026-08-12T17:44:31.458048Z","end":"2026-08-12T17:44:32.756454Z","steps":["trace[94426527] 'process raft request' (duration: 975.622838ms)","trace[94426527] 'compare' (duration: 321.927092ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:32.756535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085312047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-12T17:44:32.756545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084286524s","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-12T17:44:32.756515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.347831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:32.756605Z","caller":"traceutil/trace.go:171","msg":"trace[1291474149] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"1.175856423s","start":"2026-08-12T17:44:31.580733Z","end":"2026-08-12T17:44:32.75659Z","steps":["trace[1291474149] 'process raft request' (duration: 1.175193712s)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:32.756611Z","caller":"traceutil/trace.go:171","msg":"trace[1406549557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1243; }","duration":"1.08540068s","start":"2026-08-12T17:44:31.671194Z","end":"2026-08-12T17:44:32.756595Z","steps":["trace[1406549557] 'agreement among raft nodes before linearized reading' (duration: 1.085163682s)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:32.756623Z","caller":"traceutil/trace.go:171","msg":"trace[903198488] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1243; }","duration":"1.084413999s","start":"2026-08-12T17:44:31.672192Z","end":"2026-08-12T17:44:32.756606Z","steps":["trace[903198488] 'agreement among raft nodes before linearized reading' (duration: 1.084240774s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:32.756647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.671152Z","time spent":"1.085486322s","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-12T17:44:32.756683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.58071Z","time spent":"1.175922575s","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:44:32.756685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.672171Z","time spent":"1.084499911s","remote":"127.0.0.1:60710","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-12T17:44:32.756626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.039793331s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T17:44:32.75674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.45801Z","time spent":"1.29849203s","remote":"127.0.0.1:60710","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-12T17:44:32.756767Z","caller":"traceutil/trace.go:171","msg":"trace[1275029557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"1.039997088s","start":"2026-08-12T17:44:31.716741Z","end":"2026-08-12T17:44:32.756738Z","steps":["trace[1275029557] 'agreement among raft nodes before linearized reading' (duration: 1.03972487s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:32.756827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:31.716719Z","time spent":"1.040097851s","remote":"127.0.0.1:60444","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-12T17:44:32.756861Z","caller":"traceutil/trace.go:171","msg":"trace[971752242] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1243; }","duration":"612.504846ms","start":"2026-08-12T17:44:32.144109Z","end":"2026-08-12T17:44:32.756614Z","steps":["trace[971752242] 'agreement among raft nodes before linearized reading' (duration: 612.332191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:32.756981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:32.144095Z","time spent":"612.858647ms","remote":"127.0.0.1:60588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-08-12T17:44:33.323739Z","caller":"traceutil/trace.go:171","msg":"trace[96297682] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"563.47299ms","start":"2026-08-12T17:44:32.760244Z","end":"2026-08-12T17:44:33.323717Z","steps":["trace[96297682] 'process raft request' (duration: 465.919444ms)","trace[96297682] 'compare' (duration: 97.465344ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:33.323867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:32.760215Z","time spent":"563.575454ms","remote":"127.0.0.1:60710","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-12T17:44:33.376403Z","caller":"traceutil/trace.go:171","msg":"trace[312597399] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1292; }","duration":"611.9807ms","start":"2026-08-12T17:44:32.764395Z","end":"2026-08-12T17:44:33.376375Z","steps":["trace[312597399] 'read index received' (duration: 461.748992ms)","trace[312597399] 'applied index is now lower than readState.Index' (duration: 150.230458ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:33.376617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.202198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:33.376647Z","caller":"traceutil/trace.go:171","msg":"trace[1505121261] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"616.029559ms","start":"2026-08-12T17:44:32.760579Z","end":"2026-08-12T17:44:33.376609Z","steps":["trace[1505121261] 'process raft request' (duration: 615.635756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:33.376684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.498544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T17:44:33.376705Z","caller":"traceutil/trace.go:171","msg":"trace[332940950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"612.336612ms","start":"2026-08-12T17:44:32.764349Z","end":"2026-08-12T17:44:33.376686Z","steps":["trace[332940950] 'agreement among raft nodes before linearized reading' (duration: 612.195167ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:33.37676Z","caller":"traceutil/trace.go:171","msg":"trace[893515444] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1245; }","duration":"285.635859ms","start":"2026-08-12T17:44:33.091106Z","end":"2026-08-12T17:44:33.376742Z","steps":["trace[893515444] 'agreement among raft nodes before linearized reading' (duration: 285.485924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:33.37677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:32.764342Z","time spent":"612.420504ms","remote":"127.0.0.1:60444","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-12T17:44:33.376816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:32.76057Z","time spent":"616.151342ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:33.775429Z","caller":"traceutil/trace.go:171","msg":"trace[2126076190] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"221.829866ms","start":"2026-08-12T17:44:33.553562Z","end":"2026-08-12T17:44:33.775392Z","steps":["trace[2126076190] 'process raft request' (duration: 131.381424ms)","trace[2126076190] 'compare' (duration: 90.333629ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:44:34.069196Z","caller":"traceutil/trace.go:171","msg":"trace[225066783] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"151.049144ms","start":"2026-08-12T17:44:33.918121Z","end":"2026-08-12T17:44:34.06917Z","steps":["trace[225066783] 'process raft request' (duration: 150.892699ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:34.736117Z","caller":"traceutil/trace.go:171","msg":"trace[1193124784] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"269.121137ms","start":"2026-08-12T17:44:34.466971Z","end":"2026-08-12T17:44:34.736092Z","steps":["trace[1193124784] 'process raft request' (duration: 268.967472ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:35.261798Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11228775654435450558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T17:44:36.067071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.101332ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-12T17:44:36.067467Z","caller":"traceutil/trace.go:171","msg":"trace[1250308398] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1298; }","duration":"1.305955035s","start":"2026-08-12T17:44:34.761492Z","end":"2026-08-12T17:44:36.067447Z","steps":["trace[1250308398] 'read index received' (duration: 817.551103ms)","trace[1250308398] 'applied index is now lower than readState.Index' (duration: 488.402932ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:44:36.067569Z","caller":"traceutil/trace.go:171","msg":"trace[1154723759] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"1.305971295s","start":"2026-08-12T17:44:34.76157Z","end":"2026-08-12T17:44:36.067541Z","steps":["trace[1154723759] 'process raft request' (duration: 1.305594253s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.067691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:34.761546Z","time spent":"1.306081249s","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:44:36.067692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.306180632s","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-12T17:44:36.067745Z","caller":"traceutil/trace.go:171","msg":"trace[1114717453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1250; }","duration":"1.306246314s","start":"2026-08-12T17:44:34.761486Z","end":"2026-08-12T17:44:36.067733Z","steps":["trace[1114717453] 'agreement among raft nodes before linearized reading' (duration: 1.306058338s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.067773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:34.761427Z","time spent":"1.306339967s","remote":"127.0.0.1:60710","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-12T17:44:36.06779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.14408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-12T17:44:36.067833Z","caller":"traceutil/trace.go:171","msg":"trace[1420631283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1250; }","duration":"473.260004ms","start":"2026-08-12T17:44:35.594561Z","end":"2026-08-12T17:44:36.067821Z","steps":["trace[1420631283] 'agreement among raft nodes before linearized reading' (duration: 473.105749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.067868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:35.59453Z","time spent":"473.328796ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-12T17:44:36.067874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.296864ms","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-12T17:44:36.067904Z","caller":"traceutil/trace.go:171","msg":"trace[652348067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1250; }","duration":"687.366267ms","start":"2026-08-12T17:44:35.38053Z","end":"2026-08-12T17:44:36.067896Z","steps":["trace[652348067] 'agreement among raft nodes before linearized reading' (duration: 687.238543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.067925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:35.380509Z","time spent":"687.412938ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-12T17:44:36.067971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.114339ms","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-12T17:44:36.067993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.092374ms","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-12T17:44:36.06805Z","caller":"traceutil/trace.go:171","msg":"trace[166509798] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1250; }","duration":"740.240444ms","start":"2026-08-12T17:44:35.327785Z","end":"2026-08-12T17:44:36.068026Z","steps":["trace[166509798] 'agreement among raft nodes before linearized reading' (duration: 739.994867ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:36.068069Z","caller":"traceutil/trace.go:171","msg":"trace[1934530787] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1250; }","duration":"288.235599ms","start":"2026-08-12T17:44:35.779815Z","end":"2026-08-12T17:44:36.068051Z","steps":["trace[1934530787] 'agreement among raft nodes before linearized reading' (duration: 287.993141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.068108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:35.327765Z","time spent":"740.332907ms","remote":"127.0.0.1:60710","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-12T17:44:36.068257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291813949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:36.068321Z","caller":"traceutil/trace.go:171","msg":"trace[1511543353] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1250; }","duration":"1.291922392s","start":"2026-08-12T17:44:34.776387Z","end":"2026-08-12T17:44:36.068309Z","steps":["trace[1511543353] 'agreement among raft nodes before linearized reading' (duration: 1.291237751s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.068425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:34.776367Z","time spent":"1.292044236s","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-08-12T17:44:36.47175Z","caller":"traceutil/trace.go:171","msg":"trace[158573625] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"151.009062ms","start":"2026-08-12T17:44:36.320725Z","end":"2026-08-12T17:44:36.471734Z","steps":["trace[158573625] 'read index received' (duration: 150.911049ms)","trace[158573625] 'applied index is now lower than readState.Index' (duration: 97.373µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:44:36.471809Z","caller":"traceutil/trace.go:171","msg":"trace[1768031965] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"151.354223ms","start":"2026-08-12T17:44:36.320404Z","end":"2026-08-12T17:44:36.471758Z","steps":["trace[1768031965] 'process raft request' (duration: 151.218269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:36.471914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.168407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:471"} {"level":"info","ts":"2026-08-12T17:44:36.471935Z","caller":"traceutil/trace.go:171","msg":"trace[515295155] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1258; }","duration":"151.23264ms","start":"2026-08-12T17:44:36.320695Z","end":"2026-08-12T17:44:36.471928Z","steps":["trace[515295155] 'agreement among raft nodes before linearized reading' (duration: 151.103905ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:36.5251Z","caller":"traceutil/trace.go:171","msg":"trace[1155220197] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"162.66326ms","start":"2026-08-12T17:44:36.362403Z","end":"2026-08-12T17:44:36.525066Z","steps":["trace[1155220197] 'process raft request' (duration: 162.449524ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:36.598395Z","caller":"traceutil/trace.go:171","msg":"trace[733328071] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"121.899394ms","start":"2026-08-12T17:44:36.476467Z","end":"2026-08-12T17:44:36.598367Z","steps":["trace[733328071] 'process raft request' (duration: 81.161649ms)","trace[733328071] 'compare' (duration: 40.213068ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:37.3769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.842018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T17:44:37.377021Z","caller":"traceutil/trace.go:171","msg":"trace[824153437] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1261; }","duration":"581.040844ms","start":"2026-08-12T17:44:36.795955Z","end":"2026-08-12T17:44:37.376995Z","steps":["trace[824153437] 'count revisions from in-memory index tree' (duration: 580.637511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:37.377079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:36.795932Z","time spent":"581.135427ms","remote":"127.0.0.1:60544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-08-12T17:44:37.377168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.213641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:37.377267Z","caller":"traceutil/trace.go:171","msg":"trace[748460704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1261; }","duration":"660.383947ms","start":"2026-08-12T17:44:36.716858Z","end":"2026-08-12T17:44:37.377242Z","steps":["trace[748460704] 'range keys from in-memory index tree' (duration: 660.104737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:37.377314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:36.716815Z","time spent":"660.48914ms","remote":"127.0.0.1:60444","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-12T17:44:38.494365Z","caller":"traceutil/trace.go:171","msg":"trace[94699187] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"323.075129ms","start":"2026-08-12T17:44:38.171253Z","end":"2026-08-12T17:44:38.494328Z","steps":["trace[94699187] 'process raft request' (duration: 322.839151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:38.494599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:38.171235Z","time spent":"323.243215ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:38.53972Z","caller":"traceutil/trace.go:171","msg":"trace[1422467717] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"366.492948ms","start":"2026-08-12T17:44:38.173177Z","end":"2026-08-12T17:44:38.53967Z","steps":["trace[1422467717] 'process raft request' (duration: 366.429556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:38.539913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:38.173155Z","time spent":"366.653833ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:38.539908Z","caller":"traceutil/trace.go:171","msg":"trace[1431247172] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1312; }","duration":"261.646832ms","start":"2026-08-12T17:44:38.278236Z","end":"2026-08-12T17:44:38.539883Z","steps":["trace[1431247172] 'read index received' (duration: 215.858127ms)","trace[1431247172] 'applied index is now lower than readState.Index' (duration: 45.787345ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:44:38.539876Z","caller":"traceutil/trace.go:171","msg":"trace[2076435216] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"366.703505ms","start":"2026-08-12T17:44:38.173128Z","end":"2026-08-12T17:44:38.539831Z","steps":["trace[2076435216] 'process raft request' (duration: 366.437657ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:38.540031Z","caller":"traceutil/trace.go:171","msg":"trace[1264445356] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"366.53231ms","start":"2026-08-12T17:44:38.173477Z","end":"2026-08-12T17:44:38.540009Z","steps":["trace[1264445356] 'process raft request' (duration: 366.158588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:38.540128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:38.17347Z","time spent":"366.597231ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:44:38.540061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.800106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:38.53982Z","caller":"traceutil/trace.go:171","msg":"trace[438472716] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"367.411088ms","start":"2026-08-12T17:44:38.172377Z","end":"2026-08-12T17:44:38.539788Z","steps":["trace[438472716] 'process raft request' (duration: 367.037536ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:38.540174Z","caller":"traceutil/trace.go:171","msg":"trace[797638278] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1267; }","duration":"261.971591ms","start":"2026-08-12T17:44:38.278191Z","end":"2026-08-12T17:44:38.540162Z","steps":["trace[797638278] 'agreement among raft nodes before linearized reading' (duration: 261.776145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:38.540258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:38.173113Z","time spent":"366.950492ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:44:38.540541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:38.17236Z","time spent":"367.955754ms","remote":"127.0.0.1:60710","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-12T17:44:40.459308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:39.632605Z","time spent":"826.693872ms","remote":"127.0.0.1:50732","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-12T17:44:40.459782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.346725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T17:44:40.459911Z","caller":"traceutil/trace.go:171","msg":"trace[456192480] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1318; }","duration":"627.18405ms","start":"2026-08-12T17:44:39.83271Z","end":"2026-08-12T17:44:40.459894Z","steps":["trace[456192480] 'read index received' (duration: 220.675219ms)","trace[456192480] 'applied index is now lower than readState.Index' (duration: 406.507611ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:40.460107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.388636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T17:44:40.460154Z","caller":"traceutil/trace.go:171","msg":"trace[2109590231] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1268; }","duration":"627.439037ms","start":"2026-08-12T17:44:39.832702Z","end":"2026-08-12T17:44:40.460141Z","steps":["trace[2109590231] 'agreement among raft nodes before linearized reading' (duration: 627.271592ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:40.460188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:39.832637Z","time spent":"627.541691ms","remote":"127.0.0.1:60620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-08-12T17:44:40.460012Z","caller":"traceutil/trace.go:171","msg":"trace[191045347] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"1.031040475s","start":"2026-08-12T17:44:39.428924Z","end":"2026-08-12T17:44:40.459965Z","steps":["trace[191045347] 'process raft request' (duration: 624.427351ms)","trace[191045347] 'compare' (duration: 405.946343ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:44:40.460509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:44:39.428903Z","time spent":"1.031480189s","remote":"127.0.0.1:60474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:44:40.469705Z","caller":"traceutil/trace.go:171","msg":"trace[1130512492] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"295.147948ms","start":"2026-08-12T17:44:40.174534Z","end":"2026-08-12T17:44:40.469682Z","steps":["trace[1130512492] 'process raft request' (duration: 294.8884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:44:40.469887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.838768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:44:40.469987Z","caller":"traceutil/trace.go:171","msg":"trace[689622970] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1269; }","duration":"281.979772ms","start":"2026-08-12T17:44:40.187987Z","end":"2026-08-12T17:44:40.469967Z","steps":["trace[689622970] 'agreement among raft nodes before linearized reading' (duration: 281.809877ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:44:41.71054Z","caller":"traceutil/trace.go:171","msg":"trace[1826441616] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"102.11446ms","start":"2026-08-12T17:44:41.608402Z","end":"2026-08-12T17:44:41.710516Z","steps":["trace[1826441616] 'process raft request' (duration: 101.953265ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:47:41.150035Z","caller":"traceutil/trace.go:171","msg":"trace[933980658] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"280.027534ms","start":"2026-08-12T17:47:40.869979Z","end":"2026-08-12T17:47:41.150007Z","steps":["trace[933980658] 'process raft request' (duration: 279.836748ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:47:46.397309Z","caller":"traceutil/trace.go:171","msg":"trace[1246415508] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"235.4876ms","start":"2026-08-12T17:47:46.161791Z","end":"2026-08-12T17:47:46.397278Z","steps":["trace[1246415508] 'process raft request' (duration: 235.211011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:47:46.794157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.248998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:47:46.794264Z","caller":"traceutil/trace.go:171","msg":"trace[1677562318] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2178; }","duration":"265.408454ms","start":"2026-08-12T17:47:46.528833Z","end":"2026-08-12T17:47:46.794241Z","steps":["trace[1677562318] 'count revisions from in-memory index tree' (duration: 265.178177ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:47:46.794269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.502841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-12T17:47:46.794351Z","caller":"traceutil/trace.go:171","msg":"trace[1475118257] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2178; }","duration":"308.640356ms","start":"2026-08-12T17:47:46.48569Z","end":"2026-08-12T17:47:46.794331Z","steps":["trace[1475118257] 'range keys from in-memory index tree' (duration: 308.334746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:47:46.794405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:47:46.485668Z","time spent":"308.727208ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}