{"level":"warn","ts":"2026-04-20T11:53:48.441818Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T11:53:48.441949Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T11:53:48.442046Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T11:53:48.442065Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-20T11:53:48.442091Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T11:53:48.442903Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-04-20T11:53:48.442998Z","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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T11:53:48.460202Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"16.887949ms"} {"level":"info","ts":"2026-04-20T11:53:48.48323Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-04-20T11:53:48.483362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T11:53:48.483393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-04-20T11:53:48.48341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T11:53:48.483446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-04-20T11:53:48.483514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-04-20T11:53:48.504476Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T11:53:48.506808Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T11:53:48.50861Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T11:53:48.511034Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T11:53:48.511167Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T11:53:48.511264Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T11:53:48.511289Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T11:53:48.512445Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T11:53:48.514929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-04-20T11:53:48.514997Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T11:53:48.515087Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-20T11:53:48.515148Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-20T11:53:48.515189Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-20T11:53:48.515215Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T11:53:48.515256Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T11:53:49.384429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T11:53:49.384544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T11:53:49.384603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-04-20T11:53:49.38463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-04-20T11:53:49.384642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-20T11:53:49.384661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-04-20T11:53:49.384678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-20T11:53:49.579603Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:53:49.971941Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:53:49.971969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:53:49.972515Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T11:53:49.971932Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T11:53:49.972616Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T11:53:49.975387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-04-20T11:53:49.976148Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T11:53:50.008303Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:53:50.008467Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:53:50.008501Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-20T11:53:50.22841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.365976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T11:53:50.228531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.100142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231015Z","caller":"traceutil/trace.go:171","msg":"trace[1267267970] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"138.6009ms","start":"2026-04-20T11:53:50.092398Z","end":"2026-04-20T11:53:50.230999Z","steps":["trace[1267267970] 'range keys from in-memory index tree' (duration: 135.905828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:50.228553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.076035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231087Z","caller":"traceutil/trace.go:171","msg":"trace[1315536335] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"153.643784ms","start":"2026-04-20T11:53:50.077429Z","end":"2026-04-20T11:53:50.231073Z","steps":["trace[1315536335] 'count revisions from in-memory index tree' (duration: 150.900892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:50.228582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.992163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231193Z","caller":"traceutil/trace.go:171","msg":"trace[1903680847] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"153.606773ms","start":"2026-04-20T11:53:50.077577Z","end":"2026-04-20T11:53:50.231183Z","steps":["trace[1903680847] 'range keys from in-memory index tree' (duration: 150.945532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:50.228598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.090202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231262Z","caller":"traceutil/trace.go:171","msg":"trace[408926938] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"138.767882ms","start":"2026-04-20T11:53:50.092488Z","end":"2026-04-20T11:53:50.231256Z","steps":["trace[408926938] 'count revisions from in-memory index tree' (duration: 135.999781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:50.229836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.286589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231335Z","caller":"traceutil/trace.go:171","msg":"trace[554311845] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"125.852719ms","start":"2026-04-20T11:53:50.105449Z","end":"2026-04-20T11:53:50.231302Z","steps":["trace[554311845] 'range keys from in-memory index tree' (duration: 124.170207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:50.229895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.498803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231462Z","caller":"traceutil/trace.go:171","msg":"trace[702190246] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"126.090203ms","start":"2026-04-20T11:53:50.105355Z","end":"2026-04-20T11:53:50.231446Z","steps":["trace[702190246] 'count revisions from in-memory index tree' (duration: 124.445372ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:53:50.230942Z","caller":"traceutil/trace.go:171","msg":"trace[410621900] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"111.276093ms","start":"2026-04-20T11:53:50.118957Z","end":"2026-04-20T11:53:50.230233Z","steps":["trace[410621900] 'count revisions from in-memory index tree' (duration: 109.263235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:50.230027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.002328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T11:53:50.231667Z","caller":"traceutil/trace.go:171","msg":"trace[1598097177] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"112.615988ms","start":"2026-04-20T11:53:50.119005Z","end":"2026-04-20T11:53:50.231621Z","steps":["trace[1598097177] 'range keys from in-memory index tree' (duration: 110.930066ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:17.915173Z","caller":"traceutil/trace.go:171","msg":"trace[1082622807] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"145.046701ms","start":"2026-04-20T11:54:17.770105Z","end":"2026-04-20T11:54:17.915152Z","steps":["trace[1082622807] 'process raft request' (duration: 144.925439ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:18.911013Z","caller":"traceutil/trace.go:171","msg":"trace[124964520] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"438.271534ms","start":"2026-04-20T11:54:18.472716Z","end":"2026-04-20T11:54:18.910987Z","steps":["trace[124964520] 'process raft request' (duration: 438.100601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:18.911553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.472696Z","time spent":"438.391427ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:54:19.038164Z","caller":"traceutil/trace.go:171","msg":"trace[1536286707] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"560.228548ms","start":"2026-04-20T11:54:18.477904Z","end":"2026-04-20T11:54:19.038133Z","steps":["trace[1536286707] 'process raft request' (duration: 559.78866ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.038224Z","caller":"traceutil/trace.go:171","msg":"trace[1769352585] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"547.417656ms","start":"2026-04-20T11:54:18.490759Z","end":"2026-04-20T11:54:19.038177Z","steps":["trace[1769352585] 'process raft request' (duration: 547.10286ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.0382Z","caller":"traceutil/trace.go:171","msg":"trace[1180953831] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"548.108059ms","start":"2026-04-20T11:54:18.490029Z","end":"2026-04-20T11:54:19.038137Z","steps":["trace[1180953831] 'process raft request' (duration: 547.785663ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.038306Z","caller":"traceutil/trace.go:171","msg":"trace[860079566] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"538.12451ms","start":"2026-04-20T11:54:18.500172Z","end":"2026-04-20T11:54:19.038296Z","steps":["trace[860079566] 'process raft request' (duration: 537.821675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:19.038344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.490749Z","time spent":"547.537469ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:54:19.038339Z","caller":"traceutil/trace.go:171","msg":"trace[417873423] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:525; }","duration":"229.316024ms","start":"2026-04-20T11:54:18.809006Z","end":"2026-04-20T11:54:19.038322Z","steps":["trace[417873423] 'read index received' (duration: 101.867975ms)","trace[417873423] 'applied index is now lower than readState.Index' (duration: 127.446869ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:54:19.038335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.477898Z","time spent":"560.35588ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:54:19.038393Z","caller":"traceutil/trace.go:171","msg":"trace[248298641] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"563.153134ms","start":"2026-04-20T11:54:18.475228Z","end":"2026-04-20T11:54:19.038382Z","steps":["trace[248298641] 'process raft request' (duration: 557.695292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:19.038433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.500161Z","time spent":"538.195531ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:19.038451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.475206Z","time spent":"563.223215ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:54:19.038507Z","caller":"traceutil/trace.go:171","msg":"trace[666810384] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"536.901178ms","start":"2026-04-20T11:54:18.501597Z","end":"2026-04-20T11:54:19.038498Z","steps":["trace[666810384] 'process raft request' (duration: 536.446379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:19.038577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.501587Z","time spent":"536.953779ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:54:19.038524Z","caller":"traceutil/trace.go:171","msg":"trace[705227484] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"545.388828ms","start":"2026-04-20T11:54:18.493034Z","end":"2026-04-20T11:54:19.038423Z","steps":["trace[705227484] 'process raft request' (duration: 544.921059ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.038583Z","caller":"traceutil/trace.go:171","msg":"trace[660294259] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"557.929196ms","start":"2026-04-20T11:54:18.480622Z","end":"2026-04-20T11:54:19.038551Z","steps":["trace[660294259] 'process raft request' (duration: 557.144081ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.038649Z","caller":"traceutil/trace.go:171","msg":"trace[196651374] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"376.328312ms","start":"2026-04-20T11:54:18.662309Z","end":"2026-04-20T11:54:19.038638Z","steps":["trace[196651374] 'process raft request' (duration: 375.942164ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.038217Z","caller":"traceutil/trace.go:171","msg":"trace[1720993837] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"547.364776ms","start":"2026-04-20T11:54:18.490802Z","end":"2026-04-20T11:54:19.038166Z","steps":["trace[1720993837] 'process raft request' (duration: 547.113061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:19.038706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.480613Z","time spent":"558.050678ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:19.038706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.66228Z","time spent":"376.398674ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:19.038788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.490023Z","time spent":"548.520918ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:19.038804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.798973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T11:54:19.038834Z","caller":"traceutil/trace.go:171","msg":"trace[490803285] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"517.720226ms","start":"2026-04-20T11:54:18.521105Z","end":"2026-04-20T11:54:19.038825Z","steps":["trace[490803285] 'process raft request' (duration: 517.071863ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.038842Z","caller":"traceutil/trace.go:171","msg":"trace[93488620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"229.876425ms","start":"2026-04-20T11:54:18.808955Z","end":"2026-04-20T11:54:19.038832Z","steps":["trace[93488620] 'agreement among raft nodes before linearized reading' (duration: 229.698602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:19.038818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.49079Z","time spent":"547.930457ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:19.038788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.493026Z","time spent":"545.634583ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:19.038888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:18.521065Z","time spent":"517.801527ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:54:19.088439Z","caller":"traceutil/trace.go:171","msg":"trace[1699203115] transaction","detail":"{read_only:false; number_of_response:1; response_revision:522; }","duration":"167.856513ms","start":"2026-04-20T11:54:18.920558Z","end":"2026-04-20T11:54:19.088415Z","steps":["trace[1699203115] 'process raft request' (duration: 167.71483ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.088492Z","caller":"traceutil/trace.go:171","msg":"trace[608244339] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"169.463933ms","start":"2026-04-20T11:54:18.918998Z","end":"2026-04-20T11:54:19.088462Z","steps":["trace[608244339] 'process raft request' (duration: 169.051465ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:19.088588Z","caller":"traceutil/trace.go:171","msg":"trace[1080325737] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"168.460614ms","start":"2026-04-20T11:54:18.920104Z","end":"2026-04-20T11:54:19.088565Z","steps":["trace[1080325737] 'process raft request' (duration: 168.112867ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:24.946142Z","caller":"traceutil/trace.go:171","msg":"trace[265129048] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"450.339592ms","start":"2026-04-20T11:54:24.495762Z","end":"2026-04-20T11:54:24.946102Z","steps":["trace[265129048] 'process raft request' (duration: 449.839912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:24.946312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:24.495723Z","time spent":"450.518875ms","remote":"127.0.0.1:58462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:54:25.435536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.428897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:54:25.435647Z","caller":"traceutil/trace.go:171","msg":"trace[1823176068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"128.62764ms","start":"2026-04-20T11:54:25.306997Z","end":"2026-04-20T11:54:25.435625Z","steps":["trace[1823176068] 'range keys from in-memory index tree' (duration: 128.345815ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:25.436168Z","caller":"traceutil/trace.go:171","msg":"trace[866984286] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"121.975756ms","start":"2026-04-20T11:54:25.314173Z","end":"2026-04-20T11:54:25.436148Z","steps":["trace[866984286] 'process raft request' (duration: 117.040872ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:25.687569Z","caller":"traceutil/trace.go:171","msg":"trace[781082190] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"259.25912ms","start":"2026-04-20T11:54:25.428265Z","end":"2026-04-20T11:54:25.687525Z","steps":["trace[781082190] 'process raft request' (duration: 256.561679ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:25.97953Z","caller":"traceutil/trace.go:171","msg":"trace[1488104574] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"248.199311ms","start":"2026-04-20T11:54:25.731298Z","end":"2026-04-20T11:54:25.979498Z","steps":["trace[1488104574] 'read index received' (duration: 248.11676ms)","trace[1488104574] 'applied index is now lower than readState.Index' (duration: 80.931µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:54:25.97965Z","caller":"traceutil/trace.go:171","msg":"trace[2014198375] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"283.597631ms","start":"2026-04-20T11:54:25.696012Z","end":"2026-04-20T11:54:25.97961Z","steps":["trace[2014198375] 'process raft request' (duration: 283.287865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:25.979918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.585778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nstpd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T11:54:25.980025Z","caller":"traceutil/trace.go:171","msg":"trace[1432806463] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nstpd; range_end:; response_count:1; response_revision:609; }","duration":"248.746731ms","start":"2026-04-20T11:54:25.731255Z","end":"2026-04-20T11:54:25.980002Z","steps":["trace[1432806463] 'agreement among raft nodes before linearized reading' (duration: 248.382004ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:26.003435Z","caller":"traceutil/trace.go:171","msg":"trace[1005021754] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"255.794025ms","start":"2026-04-20T11:54:25.747606Z","end":"2026-04-20T11:54:26.0034Z","steps":["trace[1005021754] 'process raft request' (duration: 255.607862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:27.098521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004375324s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:54:27.098802Z","caller":"traceutil/trace.go:171","msg":"trace[1678141934] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.105031296s","start":"2026-04-20T11:54:25.993748Z","end":"2026-04-20T11:54:27.09878Z","steps":["trace[1678141934] 'process raft request' (duration: 99.938509ms)","trace[1678141934] 'compare' (duration: 1.00416028s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:54:27.098873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:25.993714Z","time spent":"1.105127537s","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:54:27.099034Z","caller":"traceutil/trace.go:171","msg":"trace[1269093238] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"1.080265338s","start":"2026-04-20T11:54:26.018701Z","end":"2026-04-20T11:54:27.098967Z","steps":["trace[1269093238] 'read index received' (duration: 75.157461ms)","trace[1269093238] 'applied index is now lower than readState.Index' (duration: 1.005104337s)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:54:27.099066Z","caller":"traceutil/trace.go:171","msg":"trace[902501562] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.089947771s","start":"2026-04-20T11:54:26.009082Z","end":"2026-04-20T11:54:27.099029Z","steps":["trace[902501562] 'process raft request' (duration: 1.089574824s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:27.099215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080513233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:54:27.099264Z","caller":"traceutil/trace.go:171","msg":"trace[182174994] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:612; }","duration":"1.080601195s","start":"2026-04-20T11:54:26.018648Z","end":"2026-04-20T11:54:27.099249Z","steps":["trace[182174994] 'agreement among raft nodes before linearized reading' (duration: 1.080529093s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:27.099271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.028228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:54:27.099286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:26.009051Z","time spent":"1.090106004s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:54:27.099333Z","caller":"traceutil/trace.go:171","msg":"trace[177544421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"794.154571ms","start":"2026-04-20T11:54:26.305163Z","end":"2026-04-20T11:54:27.099317Z","steps":["trace[177544421] 'agreement among raft nodes before linearized reading' (duration: 794.027709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:27.099375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:26.305136Z","time spent":"794.230713ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T11:54:27.099306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:26.018617Z","time spent":"1.080682816s","remote":"127.0.0.1:58708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":27,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-20T11:54:27.376002Z","caller":"traceutil/trace.go:171","msg":"trace[708936829] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"239.67329ms","start":"2026-04-20T11:54:27.136248Z","end":"2026-04-20T11:54:27.375921Z","steps":["trace[708936829] 'process raft request' (duration: 208.320827ms)","trace[708936829] 'compare' (duration: 31.008916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:54:44.380278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.528998ms","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-04-20T11:54:44.380403Z","caller":"traceutil/trace.go:171","msg":"trace[38614208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"585.66576ms","start":"2026-04-20T11:54:43.794688Z","end":"2026-04-20T11:54:44.380353Z","steps":["trace[38614208] 'range keys from in-memory index tree' (duration: 585.381855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:44.380448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:43.794676Z","time spent":"585.761031ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T11:54:44.380504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.045397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bq6dn\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-20T11:54:44.380688Z","caller":"traceutil/trace.go:171","msg":"trace[204785752] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bq6dn; range_end:; response_count:1; response_revision:787; }","duration":"549.300363ms","start":"2026-04-20T11:54:43.831334Z","end":"2026-04-20T11:54:44.380635Z","steps":["trace[204785752] 'range keys from in-memory index tree' (duration: 548.836044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:44.380637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.862745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-20T11:54:44.380647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.200168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-20T11:54:44.380776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:43.831324Z","time spent":"549.437365ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bq6dn\" "} {"level":"info","ts":"2026-04-20T11:54:44.380868Z","caller":"traceutil/trace.go:171","msg":"trace[1649501339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"242.435132ms","start":"2026-04-20T11:54:44.13841Z","end":"2026-04-20T11:54:44.380845Z","steps":["trace[1649501339] 'range keys from in-memory index tree' (duration: 241.965454ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:44.380791Z","caller":"traceutil/trace.go:171","msg":"trace[1593881627] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"640.098779ms","start":"2026-04-20T11:54:43.740663Z","end":"2026-04-20T11:54:44.380762Z","steps":["trace[1593881627] 'range keys from in-memory index tree' (duration: 639.577579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:44.380992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:43.740638Z","time spent":"640.337794ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T11:54:44.380706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.588214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:54:44.381179Z","caller":"traceutil/trace.go:171","msg":"trace[966937469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:787; }","duration":"590.074424ms","start":"2026-04-20T11:54:43.791063Z","end":"2026-04-20T11:54:44.381137Z","steps":["trace[966937469] 'range keys from in-memory index tree' (duration: 589.461612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:44.381275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:54:43.791042Z","time spent":"590.199857ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T11:54:44.488961Z","caller":"traceutil/trace.go:171","msg":"trace[803879413] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"102.335494ms","start":"2026-04-20T11:54:44.386595Z","end":"2026-04-20T11:54:44.48893Z","steps":["trace[803879413] 'process raft request' (duration: 102.154891ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:44.501877Z","caller":"traceutil/trace.go:171","msg":"trace[1423669230] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"115.114675ms","start":"2026-04-20T11:54:44.386738Z","end":"2026-04-20T11:54:44.501853Z","steps":["trace[1423669230] 'process raft request' (duration: 114.746519ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:44.501975Z","caller":"traceutil/trace.go:171","msg":"trace[1481143770] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"115.126036ms","start":"2026-04-20T11:54:44.38682Z","end":"2026-04-20T11:54:44.501946Z","steps":["trace[1481143770] 'process raft request' (duration: 114.948643ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:44.502021Z","caller":"traceutil/trace.go:171","msg":"trace[880606487] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"105.178438ms","start":"2026-04-20T11:54:44.396776Z","end":"2026-04-20T11:54:44.501955Z","steps":["trace[880606487] 'process raft request' (duration: 105.081666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:19.434448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.177621ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:55:19.434579Z","caller":"traceutil/trace.go:171","msg":"trace[464318772] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1037; }","duration":"127.894967ms","start":"2026-04-20T11:55:19.306666Z","end":"2026-04-20T11:55:19.434561Z","steps":["trace[464318772] 'read index received' (duration: 85.111µs)","trace[464318772] 'applied index is now lower than readState.Index' (duration: 127.808525ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:19.434717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.056851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:55:19.434685Z","caller":"traceutil/trace.go:171","msg":"trace[1283984128] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"355.763855ms","start":"2026-04-20T11:55:19.078882Z","end":"2026-04-20T11:55:19.434646Z","steps":["trace[1283984128] 'process raft request' (duration: 35.250827ms)","trace[1283984128] 'compare' (duration: 320.009598ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:55:19.434751Z","caller":"traceutil/trace.go:171","msg":"trace[587416207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"128.130042ms","start":"2026-04-20T11:55:19.306612Z","end":"2026-04-20T11:55:19.434742Z","steps":["trace[587416207] 'agreement among raft nodes before linearized reading' (duration: 128.059971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:19.434897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:19.078817Z","time spent":"355.964939ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:55:19.967939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.378782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:55:19.968093Z","caller":"traceutil/trace.go:171","msg":"trace[207610878] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1038; }","duration":"292.651241ms","start":"2026-04-20T11:55:19.675419Z","end":"2026-04-20T11:55:19.96807Z","steps":["trace[207610878] 'read index received' (duration: 86.643µs)","trace[207610878] 'applied index is now lower than readState.Index' (duration: 292.562898ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:55:19.968222Z","caller":"traceutil/trace.go:171","msg":"trace[1959952712] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"529.248673ms","start":"2026-04-20T11:55:19.438926Z","end":"2026-04-20T11:55:19.968175Z","steps":["trace[1959952712] 'process raft request' (duration: 151.530214ms)","trace[1959952712] 'compare' (duration: 377.2755ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:19.96829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.873036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T11:55:19.968346Z","caller":"traceutil/trace.go:171","msg":"trace[1441529672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"292.968408ms","start":"2026-04-20T11:55:19.675362Z","end":"2026-04-20T11:55:19.96833Z","steps":["trace[1441529672] 'agreement among raft nodes before linearized reading' (duration: 292.771715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:19.968485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:19.438904Z","time spent":"529.425327ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:20.198805Z","caller":"traceutil/trace.go:171","msg":"trace[359982989] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"225.90946ms","start":"2026-04-20T11:55:19.972866Z","end":"2026-04-20T11:55:20.198776Z","steps":["trace[359982989] 'process raft request' (duration: 225.755477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:43.38398Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696222013606961,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T11:55:43.599502Z","caller":"traceutil/trace.go:171","msg":"trace[1245815782] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"715.85948ms","start":"2026-04-20T11:55:42.883608Z","end":"2026-04-20T11:55:43.599468Z","steps":["trace[1245815782] 'read index received' (duration: 715.573135ms)","trace[1245815782] 'applied index is now lower than readState.Index' (duration: 285.145µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:43.59978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.145266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T11:55:43.599871Z","caller":"traceutil/trace.go:171","msg":"trace[1906894539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1078; }","duration":"716.300169ms","start":"2026-04-20T11:55:42.88355Z","end":"2026-04-20T11:55:43.59985Z","steps":["trace[1906894539] 'agreement among raft nodes before linearized reading' (duration: 716.064795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:43.599913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:42.883529Z","time spent":"716.37491ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T11:55:43.599811Z","caller":"traceutil/trace.go:171","msg":"trace[1698493607] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"725.159186ms","start":"2026-04-20T11:55:42.874431Z","end":"2026-04-20T11:55:43.59959Z","steps":["trace[1698493607] 'process raft request' (duration: 724.830799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:43.600238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:42.874419Z","time spent":"725.675785ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:55:44.099918Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696222013606965,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T11:55:44.277865Z","caller":"traceutil/trace.go:171","msg":"trace[793583481] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"756.240393ms","start":"2026-04-20T11:55:43.521596Z","end":"2026-04-20T11:55:44.277836Z","steps":["trace[793583481] 'process raft request' (duration: 756.182402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.278031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:43.52157Z","time spent":"756.371446ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:44.278176Z","caller":"traceutil/trace.go:171","msg":"trace[279768805] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"762.270227ms","start":"2026-04-20T11:55:43.515896Z","end":"2026-04-20T11:55:44.278166Z","steps":["trace[279768805] 'process raft request' (duration: 761.747038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.278231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:43.515868Z","time spent":"762.335898ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:55:44.673749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.13588ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:55:44.673873Z","caller":"traceutil/trace.go:171","msg":"trace[279961591] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1117; }","duration":"1.074247294s","start":"2026-04-20T11:55:43.599604Z","end":"2026-04-20T11:55:44.673852Z","steps":["trace[279961591] 'read index received' (duration: 678.129957ms)","trace[279961591] 'applied index is now lower than readState.Index' (duration: 396.115727ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:44.674047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368423624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:55:44.674149Z","caller":"traceutil/trace.go:171","msg":"trace[307053370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1081; }","duration":"1.368575706s","start":"2026-04-20T11:55:43.305556Z","end":"2026-04-20T11:55:44.674131Z","steps":["trace[307053370] 'agreement among raft nodes before linearized reading' (duration: 1.368402033s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.674197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:43.305537Z","time spent":"1.368651498s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T11:55:44.67429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.950539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-20T11:55:44.674341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.643436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T11:55:44.674373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.743218047s","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-04-20T11:55:44.674388Z","caller":"traceutil/trace.go:171","msg":"trace[1506555229] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1081; }","duration":"260.730938ms","start":"2026-04-20T11:55:44.413644Z","end":"2026-04-20T11:55:44.674375Z","steps":["trace[1506555229] 'agreement among raft nodes before linearized reading' (duration: 260.633896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.674411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690408269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T11:55:44.674435Z","caller":"traceutil/trace.go:171","msg":"trace[1243663013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1081; }","duration":"1.74331801s","start":"2026-04-20T11:55:42.931102Z","end":"2026-04-20T11:55:44.67442Z","steps":["trace[1243663013] 'agreement among raft nodes before linearized reading' (duration: 1.743130806s)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:44.674461Z","caller":"traceutil/trace.go:171","msg":"trace[845290683] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"1.070449452s","start":"2026-04-20T11:55:43.603994Z","end":"2026-04-20T11:55:44.674443Z","steps":["trace[845290683] 'process raft request' (duration: 766.521107ms)","trace[845290683] 'compare' (duration: 303.002958ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:44.674479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.737792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T11:55:44.674479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:42.931082Z","time spent":"1.74338408s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T11:55:44.674517Z","caller":"traceutil/trace.go:171","msg":"trace[732273616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1081; }","duration":"366.812863ms","start":"2026-04-20T11:55:44.307696Z","end":"2026-04-20T11:55:44.674508Z","steps":["trace[732273616] 'agreement among raft nodes before linearized reading' (duration: 366.718311ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:44.674508Z","caller":"traceutil/trace.go:171","msg":"trace[542069611] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:1081; }","duration":"1.690542392s","start":"2026-04-20T11:55:42.983916Z","end":"2026-04-20T11:55:44.674458Z","steps":["trace[542069611] 'agreement among raft nodes before linearized reading' (duration: 1.690357599s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.674559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.307678Z","time spent":"366.873154ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T11:55:44.674612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:43.603974Z","time spent":"1.070562064s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:44.674372Z","caller":"traceutil/trace.go:171","msg":"trace[1171400642] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1081; }","duration":"592.099411ms","start":"2026-04-20T11:55:44.082255Z","end":"2026-04-20T11:55:44.674355Z","steps":["trace[1171400642] 'agreement among raft nodes before linearized reading' (duration: 591.872117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.674638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:42.983905Z","time spent":"1.690683635s","remote":"127.0.0.1:58406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.155\" "} {"level":"warn","ts":"2026-04-20T11:55:44.674728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142114386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:55:44.674734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26347422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T11:55:44.674668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.082233Z","time spent":"592.429117ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-20T11:55:44.674771Z","caller":"traceutil/trace.go:171","msg":"trace[1023719503] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1081; }","duration":"1.263538892s","start":"2026-04-20T11:55:43.411222Z","end":"2026-04-20T11:55:44.674761Z","steps":["trace[1023719503] 'agreement among raft nodes before linearized reading' (duration: 1.263479051s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.674812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:43.411211Z","time spent":"1.263589133s","remote":"127.0.0.1:58746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-04-20T11:55:44.674768Z","caller":"traceutil/trace.go:171","msg":"trace[266005612] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1081; }","duration":"1.142192628s","start":"2026-04-20T11:55:43.532563Z","end":"2026-04-20T11:55:44.674755Z","steps":["trace[266005612] 'agreement among raft nodes before linearized reading' (duration: 1.142138087s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:44.674984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:43.53254Z","time spent":"1.142432423s","remote":"127.0.0.1:58604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:55:45.136646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.676346Z","time spent":"460.29581ms","remote":"127.0.0.1:58406","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-20T11:55:45.136894Z","caller":"traceutil/trace.go:171","msg":"trace[1657464159] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"455.769616ms","start":"2026-04-20T11:55:44.681101Z","end":"2026-04-20T11:55:45.13687Z","steps":["trace[1657464159] 'process raft request' (duration: 455.735114ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:45.136862Z","caller":"traceutil/trace.go:171","msg":"trace[547171430] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"459.74462ms","start":"2026-04-20T11:55:44.677051Z","end":"2026-04-20T11:55:45.136795Z","steps":["trace[547171430] 'read index received' (duration: 432.107695ms)","trace[547171430] 'applied index is now lower than readState.Index' (duration: 27.624985ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:45.137024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.681084Z","time spent":"455.853317ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:45.13706Z","caller":"traceutil/trace.go:171","msg":"trace[1792446782] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"456.868086ms","start":"2026-04-20T11:55:44.680149Z","end":"2026-04-20T11:55:45.137017Z","steps":["trace[1792446782] 'process raft request' (duration: 456.654301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:45.137231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.680126Z","time spent":"457.02436ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:55:45.137262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.851559ms","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-04-20T11:55:45.137332Z","caller":"traceutil/trace.go:171","msg":"trace[578874292] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1084; }","duration":"276.995971ms","start":"2026-04-20T11:55:44.860314Z","end":"2026-04-20T11:55:45.13731Z","steps":["trace[578874292] 'agreement among raft nodes before linearized reading' (duration: 276.770857ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:45.137382Z","caller":"traceutil/trace.go:171","msg":"trace[1983742541] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"457.497568ms","start":"2026-04-20T11:55:44.679871Z","end":"2026-04-20T11:55:45.137369Z","steps":["trace[1983742541] 'process raft request' (duration: 456.773154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:45.137445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.679853Z","time spent":"457.563729ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:55:45.137404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.332932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:55:45.137812Z","caller":"traceutil/trace.go:171","msg":"trace[1679269064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"460.81936ms","start":"2026-04-20T11:55:44.676974Z","end":"2026-04-20T11:55:45.137794Z","steps":["trace[1679269064] 'agreement among raft nodes before linearized reading' (duration: 460.135058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:45.137867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:44.676942Z","time spent":"460.912621ms","remote":"127.0.0.1:58384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T11:55:46.416415Z","caller":"traceutil/trace.go:171","msg":"trace[921112458] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"808.084266ms","start":"2026-04-20T11:55:45.608265Z","end":"2026-04-20T11:55:46.41635Z","steps":["trace[921112458] 'process raft request' (duration: 807.832232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:46.416823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:45.608243Z","time spent":"808.2813ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:46.54779Z","caller":"traceutil/trace.go:171","msg":"trace[1474790820] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1125; }","duration":"241.979147ms","start":"2026-04-20T11:55:46.305776Z","end":"2026-04-20T11:55:46.547755Z","steps":["trace[1474790820] 'read index received' (duration: 110.465812ms)","trace[1474790820] 'applied index is now lower than readState.Index' (duration: 131.511865ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:55:46.547835Z","caller":"traceutil/trace.go:171","msg":"trace[711682341] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"263.642812ms","start":"2026-04-20T11:55:46.284151Z","end":"2026-04-20T11:55:46.547794Z","steps":["trace[711682341] 'process raft request' (duration: 242.863564ms)","trace[711682341] 'compare' (duration: 20.289199ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:46.547969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.172212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:55:46.548028Z","caller":"traceutil/trace.go:171","msg":"trace[35978487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1087; }","duration":"242.284753ms","start":"2026-04-20T11:55:46.305727Z","end":"2026-04-20T11:55:46.548012Z","steps":["trace[35978487] 'agreement among raft nodes before linearized reading' (duration: 242.12804ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:47.302006Z","caller":"traceutil/trace.go:171","msg":"trace[1545523453] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"157.924068ms","start":"2026-04-20T11:55:47.144056Z","end":"2026-04-20T11:55:47.30198Z","steps":["trace[1545523453] 'process raft request' (duration: 157.781646ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:47.465808Z","caller":"traceutil/trace.go:171","msg":"trace[202047793] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"321.380231ms","start":"2026-04-20T11:55:47.144402Z","end":"2026-04-20T11:55:47.465782Z","steps":["trace[202047793] 'process raft request' (duration: 321.186157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:47.46596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:47.144351Z","time spent":"321.530463ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:47.466028Z","caller":"traceutil/trace.go:171","msg":"trace[1748053270] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1130; }","duration":"159.628551ms","start":"2026-04-20T11:55:47.306375Z","end":"2026-04-20T11:55:47.466004Z","steps":["trace[1748053270] 'read index received' (duration: 159.246984ms)","trace[1748053270] 'applied index is now lower than readState.Index' (duration: 379.996µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:47.46611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.730922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:55:47.466088Z","caller":"traceutil/trace.go:171","msg":"trace[1663490340] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"321.193696ms","start":"2026-04-20T11:55:47.144863Z","end":"2026-04-20T11:55:47.466056Z","steps":["trace[1663490340] 'process raft request' (duration: 320.877391ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:47.466145Z","caller":"traceutil/trace.go:171","msg":"trace[580253107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"159.804534ms","start":"2026-04-20T11:55:47.306329Z","end":"2026-04-20T11:55:47.466134Z","steps":["trace[580253107] 'agreement among raft nodes before linearized reading' (duration: 159.742663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:47.466239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:47.144853Z","time spent":"321.301888ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:00.023371Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696222013607197,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T11:56:00.128081Z","caller":"traceutil/trace.go:171","msg":"trace[236630961] linearizableReadLoop","detail":"{readStateIndex:1224; appliedIndex:1223; }","duration":"605.387342ms","start":"2026-04-20T11:55:59.522677Z","end":"2026-04-20T11:56:00.128064Z","steps":["trace[236630961] 'read index received' (duration: 605.229799ms)","trace[236630961] 'applied index is now lower than readState.Index' (duration: 156.833µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:00.128205Z","caller":"traceutil/trace.go:171","msg":"trace[659649810] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"767.451349ms","start":"2026-04-20T11:55:59.360737Z","end":"2026-04-20T11:56:00.128189Z","steps":["trace[659649810] 'process raft request' (duration: 767.218274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.128274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.259325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T11:56:00.128298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:59.360727Z","time spent":"767.51495ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:00.12831Z","caller":"traceutil/trace.go:171","msg":"trace[274596255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"602.323336ms","start":"2026-04-20T11:55:59.525978Z","end":"2026-04-20T11:56:00.128301Z","steps":["trace[274596255] 'agreement among raft nodes before linearized reading' (duration: 602.179593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.128334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:59.525968Z","time spent":"602.360026ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T11:56:00.128354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.659038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T11:56:00.128481Z","caller":"traceutil/trace.go:171","msg":"trace[948437285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1180; }","duration":"605.796981ms","start":"2026-04-20T11:55:59.522661Z","end":"2026-04-20T11:56:00.128458Z","steps":["trace[948437285] 'agreement among raft nodes before linearized reading' (duration: 605.513136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.128528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:59.522596Z","time spent":"605.920913ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T11:56:00.128422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.60351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:00.128627Z","caller":"traceutil/trace.go:171","msg":"trace[1407278931] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"482.820185ms","start":"2026-04-20T11:55:59.645789Z","end":"2026-04-20T11:56:00.128609Z","steps":["trace[1407278931] 'agreement among raft nodes before linearized reading' (duration: 482.614751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.128682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:59.645773Z","time spent":"482.899726ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T11:56:00.472968Z","caller":"traceutil/trace.go:171","msg":"trace[61291454] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"341.15538ms","start":"2026-04-20T11:56:00.131759Z","end":"2026-04-20T11:56:00.472914Z","steps":["trace[61291454] 'process raft request' (duration: 340.948776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.47313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.131742Z","time spent":"341.299002ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:00.510328Z","caller":"traceutil/trace.go:171","msg":"trace[992829488] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"377.245313ms","start":"2026-04-20T11:56:00.133058Z","end":"2026-04-20T11:56:00.510303Z","steps":["trace[992829488] 'process raft request' (duration: 377.030229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.510461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.133048Z","time spent":"377.343796ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:00.514799Z","caller":"traceutil/trace.go:171","msg":"trace[592876024] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1224; }","duration":"332.313045ms","start":"2026-04-20T11:56:00.182466Z","end":"2026-04-20T11:56:00.514779Z","steps":["trace[592876024] 'read index received' (duration: 290.264671ms)","trace[592876024] 'applied index is now lower than readState.Index' (duration: 42.047154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:56:00.51493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.404866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:56:00.514942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.453308ms","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-04-20T11:56:00.515001Z","caller":"traceutil/trace.go:171","msg":"trace[246737894] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1182; }","duration":"332.569269ms","start":"2026-04-20T11:56:00.182419Z","end":"2026-04-20T11:56:00.514988Z","steps":["trace[246737894] 'agreement among raft nodes before linearized reading' (duration: 332.449897ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:00.515002Z","caller":"traceutil/trace.go:171","msg":"trace[610958162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1182; }","duration":"212.511038ms","start":"2026-04-20T11:56:00.30247Z","end":"2026-04-20T11:56:00.514981Z","steps":["trace[610958162] 'agreement among raft nodes before linearized reading' (duration: 212.418816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:00.515035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.182399Z","time spent":"332.629981ms","remote":"127.0.0.1:58888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-04-20T11:56:02.692654Z","caller":"traceutil/trace.go:171","msg":"trace[1025116894] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"134.96813ms","start":"2026-04-20T11:56:02.55766Z","end":"2026-04-20T11:56:02.692628Z","steps":["trace[1025116894] 'process raft request' (duration: 100.67548ms)","trace[1025116894] 'compare' (duration: 34.133507ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:56:13.142502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.252538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T11:56:13.142825Z","caller":"traceutil/trace.go:171","msg":"trace[1815909701] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:1224; }","duration":"156.649865ms","start":"2026-04-20T11:56:12.98614Z","end":"2026-04-20T11:56:13.14279Z","steps":["trace[1815909701] 'range keys from in-memory index tree' (duration: 156.022833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:15.430915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.298012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:15.431004Z","caller":"traceutil/trace.go:171","msg":"trace[1212044801] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"123.439564ms","start":"2026-04-20T11:56:15.307544Z","end":"2026-04-20T11:56:15.430983Z","steps":["trace[1212044801] 'range keys from in-memory index tree' (duration: 123.224301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.183496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.430475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T11:56:17.183549Z","caller":"traceutil/trace.go:171","msg":"trace[1448612170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1252; }","duration":"574.528927ms","start":"2026-04-20T11:56:16.609008Z","end":"2026-04-20T11:56:17.183537Z","steps":["trace[1448612170] 'range keys from in-memory index tree' (duration: 574.321572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.183574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.608989Z","time spent":"574.577038ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T11:56:17.183644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.345825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:56:17.183657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.446707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-20T11:56:17.183702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.884135ms","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-04-20T11:56:17.183719Z","caller":"traceutil/trace.go:171","msg":"trace[1361498152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1252; }","duration":"490.942096ms","start":"2026-04-20T11:56:16.692772Z","end":"2026-04-20T11:56:17.183714Z","steps":["trace[1361498152] 'range keys from in-memory index tree' (duration: 490.770943ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:17.183712Z","caller":"traceutil/trace.go:171","msg":"trace[2055290001] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1252; }","duration":"820.477598ms","start":"2026-04-20T11:56:16.363218Z","end":"2026-04-20T11:56:17.183696Z","steps":["trace[2055290001] 'count revisions from in-memory index tree' (duration: 820.246054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.183732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.692741Z","time spent":"490.988517ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T11:56:17.183733Z","caller":"traceutil/trace.go:171","msg":"trace[1073876121] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1252; }","duration":"941.564609ms","start":"2026-04-20T11:56:16.242147Z","end":"2026-04-20T11:56:17.183712Z","steps":["trace[1073876121] 'range keys from in-memory index tree' (duration: 941.247172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.183756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.363192Z","time spent":"820.55062ms","remote":"127.0.0.1:58288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:56:17.183774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.242129Z","time spent":"941.6361ms","remote":"127.0.0.1:58624","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":"info","ts":"2026-04-20T11:56:17.184307Z","caller":"traceutil/trace.go:171","msg":"trace[1532855764] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1300; }","duration":"331.183313ms","start":"2026-04-20T11:56:16.853116Z","end":"2026-04-20T11:56:17.184299Z","steps":["trace[1532855764] 'read index received' (duration: 325.481727ms)","trace[1532855764] 'applied index is now lower than readState.Index' (duration: 5.700876ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:17.184366Z","caller":"traceutil/trace.go:171","msg":"trace[648458855] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"339.856065ms","start":"2026-04-20T11:56:16.844497Z","end":"2026-04-20T11:56:17.184353Z","steps":["trace[648458855] 'process raft request' (duration: 334.129538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.184433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.314735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T11:56:17.184451Z","caller":"traceutil/trace.go:171","msg":"trace[317955125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1253; }","duration":"331.361895ms","start":"2026-04-20T11:56:16.853082Z","end":"2026-04-20T11:56:17.184444Z","steps":["trace[317955125] 'agreement among raft nodes before linearized reading' (duration: 331.270964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.184465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.853066Z","time spent":"331.394756ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T11:56:17.184477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.844472Z","time spent":"339.948316ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:17.184486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.175629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T11:56:17.184528Z","caller":"traceutil/trace.go:171","msg":"trace[1017683379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1253; }","duration":"304.258471ms","start":"2026-04-20T11:56:16.880257Z","end":"2026-04-20T11:56:17.184515Z","steps":["trace[1017683379] 'agreement among raft nodes before linearized reading' (duration: 304.152298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:17.184562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:16.880241Z","time spent":"304.314502ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T11:56:17.346463Z","caller":"traceutil/trace.go:171","msg":"trace[1028811637] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"157.042242ms","start":"2026-04-20T11:56:17.189393Z","end":"2026-04-20T11:56:17.346435Z","steps":["trace[1028811637] 'process raft request' (duration: 119.250817ms)","trace[1028811637] 'compare' (duration: 36.9319ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:17.34663Z","caller":"traceutil/trace.go:171","msg":"trace[2073535653] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"156.403979ms","start":"2026-04-20T11:56:17.190215Z","end":"2026-04-20T11:56:17.346619Z","steps":["trace[2073535653] 'process raft request' (duration: 155.695027ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:17.347153Z","caller":"traceutil/trace.go:171","msg":"trace[832868843] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"154.715958ms","start":"2026-04-20T11:56:17.192399Z","end":"2026-04-20T11:56:17.347115Z","steps":["trace[832868843] 'process raft request' (duration: 153.677109ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:17.347359Z","caller":"traceutil/trace.go:171","msg":"trace[371457825] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"157.047032ms","start":"2026-04-20T11:56:17.190279Z","end":"2026-04-20T11:56:17.347326Z","steps":["trace[371457825] 'process raft request' (duration: 155.683677ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:17.347555Z","caller":"traceutil/trace.go:171","msg":"trace[611929277] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"156.94859ms","start":"2026-04-20T11:56:17.190596Z","end":"2026-04-20T11:56:17.347545Z","steps":["trace[611929277] 'process raft request' (duration: 155.400841ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:18.365077Z","caller":"traceutil/trace.go:171","msg":"trace[810173572] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"239.148485ms","start":"2026-04-20T11:56:18.125909Z","end":"2026-04-20T11:56:18.365057Z","steps":["trace[810173572] 'process raft request' (duration: 239.020293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:18.871127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.946936ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-20T11:56:18.871347Z","caller":"traceutil/trace.go:171","msg":"trace[1287530087] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"475.346295ms","start":"2026-04-20T11:56:18.395984Z","end":"2026-04-20T11:56:18.871331Z","steps":["trace[1287530087] 'process raft request' (duration: 475.237963ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:18.8714Z","caller":"traceutil/trace.go:171","msg":"trace[264690761] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1308; }","duration":"671.023168ms","start":"2026-04-20T11:56:18.200343Z","end":"2026-04-20T11:56:18.871367Z","steps":["trace[264690761] 'read index received' (duration: 164.594114ms)","trace[264690761] 'applied index is now lower than readState.Index' (duration: 506.426064ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:56:18.87144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:18.395964Z","time spent":"475.429236ms","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:18.871599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.229421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:18.871638Z","caller":"traceutil/trace.go:171","msg":"trace[1962770129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1262; }","duration":"566.305922ms","start":"2026-04-20T11:56:18.30532Z","end":"2026-04-20T11:56:18.871626Z","steps":["trace[1962770129] 'agreement among raft nodes before linearized reading' (duration: 566.19931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:18.871671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:18.305307Z","time spent":"566.354173ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T11:56:18.871658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.286893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:18.871738Z","caller":"traceutil/trace.go:171","msg":"trace[1934053161] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1262; }","duration":"671.413125ms","start":"2026-04-20T11:56:18.200305Z","end":"2026-04-20T11:56:18.871718Z","steps":["trace[1934053161] 'agreement among raft nodes before linearized reading' (duration: 671.165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:18.871763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.821218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:18.871786Z","caller":"traceutil/trace.go:171","msg":"trace[1557609107] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1262; }","duration":"397.866039ms","start":"2026-04-20T11:56:18.473912Z","end":"2026-04-20T11:56:18.871778Z","steps":["trace[1557609107] 'agreement among raft nodes before linearized reading' (duration: 397.830118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:18.871781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:18.200287Z","time spent":"671.484237ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T11:56:18.871806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:18.473897Z","time spent":"397.90407ms","remote":"127.0.0.1:58278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:56:19.636335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.697856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:56:19.636603Z","caller":"traceutil/trace.go:171","msg":"trace[394044281] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1311; }","duration":"284.839028ms","start":"2026-04-20T11:56:19.351748Z","end":"2026-04-20T11:56:19.636587Z","steps":["trace[394044281] 'read index received' (duration: 100.825712ms)","trace[394044281] 'applied index is now lower than readState.Index' (duration: 184.012466ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:19.63664Z","caller":"traceutil/trace.go:171","msg":"trace[1978443428] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"761.348654ms","start":"2026-04-20T11:56:18.875237Z","end":"2026-04-20T11:56:19.636586Z","steps":["trace[1978443428] 'process raft request' (duration: 100.336183ms)","trace[1978443428] 'compare' (duration: 660.571033ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:19.636695Z","caller":"traceutil/trace.go:171","msg":"trace[74974007] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"760.136872ms","start":"2026-04-20T11:56:18.876549Z","end":"2026-04-20T11:56:19.636685Z","steps":["trace[74974007] 'process raft request' (duration: 759.934258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:19.636752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:18.876529Z","time spent":"760.196333ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:19.636795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.033022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T11:56:19.636814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:18.875211Z","time spent":"761.519998ms","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:19.636841Z","caller":"traceutil/trace.go:171","msg":"trace[1093934295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1265; }","duration":"285.112624ms","start":"2026-04-20T11:56:19.351716Z","end":"2026-04-20T11:56:19.636829Z","steps":["trace[1093934295] 'agreement among raft nodes before linearized reading' (duration: 284.984481ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:19.636917Z","caller":"traceutil/trace.go:171","msg":"trace[1463057772] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"444.548719ms","start":"2026-04-20T11:56:19.192362Z","end":"2026-04-20T11:56:19.636911Z","steps":["trace[1463057772] 'process raft request' (duration: 444.175252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:19.636965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.192336Z","time spent":"444.5921ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:19.637072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.275847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T11:56:19.637107Z","caller":"traceutil/trace.go:171","msg":"trace[800850853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1265; }","duration":"285.321797ms","start":"2026-04-20T11:56:19.351775Z","end":"2026-04-20T11:56:19.637096Z","steps":["trace[800850853] 'agreement among raft nodes before linearized reading' (duration: 285.197055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:19.637206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.40711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T11:56:19.637231Z","caller":"traceutil/trace.go:171","msg":"trace[1358463296] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1265; }","duration":"284.439421ms","start":"2026-04-20T11:56:19.352784Z","end":"2026-04-20T11:56:19.637223Z","steps":["trace[1358463296] 'agreement among raft nodes before linearized reading' (duration: 284.3862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:19.63724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.042121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T11:56:19.637278Z","caller":"traceutil/trace.go:171","msg":"trace[182520363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1265; }","duration":"285.090073ms","start":"2026-04-20T11:56:19.35218Z","end":"2026-04-20T11:56:19.63727Z","steps":["trace[182520363] 'agreement among raft nodes before linearized reading' (duration: 285.002481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:19.637317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.893281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T11:56:19.637367Z","caller":"traceutil/trace.go:171","msg":"trace[681693960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1265; }","duration":"282.951623ms","start":"2026-04-20T11:56:19.354401Z","end":"2026-04-20T11:56:19.637352Z","steps":["trace[681693960] 'agreement among raft nodes before linearized reading' (duration: 282.7891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:19.937139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.535556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:56:19.937252Z","caller":"traceutil/trace.go:171","msg":"trace[1556521074] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"293.132144ms","start":"2026-04-20T11:56:19.644101Z","end":"2026-04-20T11:56:19.937233Z","steps":["trace[1556521074] 'process raft request' (duration: 177.406973ms)","trace[1556521074] 'compare' (duration: 115.389764ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:20.021139Z","caller":"traceutil/trace.go:171","msg":"trace[107826719] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"376.55203ms","start":"2026-04-20T11:56:19.644552Z","end":"2026-04-20T11:56:20.021104Z","steps":["trace[107826719] 'process raft request' (duration: 376.243604ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:20.021144Z","caller":"traceutil/trace.go:171","msg":"trace[1783778753] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"376.468458ms","start":"2026-04-20T11:56:19.644645Z","end":"2026-04-20T11:56:20.021114Z","steps":["trace[1783778753] 'process raft request' (duration: 376.362026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:20.021298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.644523Z","time spent":"376.686973ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:20.02132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.644637Z","time spent":"376.588201ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:20.021409Z","caller":"traceutil/trace.go:171","msg":"trace[1004949577] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"376.721874ms","start":"2026-04-20T11:56:19.644676Z","end":"2026-04-20T11:56:20.021398Z","steps":["trace[1004949577] 'process raft request' (duration: 376.388617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:20.021453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.644654Z","time spent":"376.781814ms","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:20.021562Z","caller":"traceutil/trace.go:171","msg":"trace[400559040] linearizableReadLoop","detail":"{readStateIndex:1320; appliedIndex:1314; }","duration":"376.408507ms","start":"2026-04-20T11:56:19.645131Z","end":"2026-04-20T11:56:20.021539Z","steps":["trace[400559040] 'read index received' (duration: 176.440244ms)","trace[400559040] 'applied index is now lower than readState.Index' (duration: 199.967113ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:20.021613Z","caller":"traceutil/trace.go:171","msg":"trace[1255769305] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"376.908117ms","start":"2026-04-20T11:56:19.644698Z","end":"2026-04-20T11:56:20.021606Z","steps":["trace[1255769305] 'process raft request' (duration: 376.603401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:20.021646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.64469Z","time spent":"376.937817ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:20.021695Z","caller":"traceutil/trace.go:171","msg":"trace[917381060] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"376.929787ms","start":"2026-04-20T11:56:19.644742Z","end":"2026-04-20T11:56:20.021672Z","steps":["trace[917381060] 'process raft request' (duration: 376.717813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:20.021717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.943906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:56:20.021748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.618181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-04-20T11:56:20.021761Z","caller":"traceutil/trace.go:171","msg":"trace[1292041373] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1271; }","duration":"376.654652ms","start":"2026-04-20T11:56:19.645103Z","end":"2026-04-20T11:56:20.021757Z","steps":["trace[1292041373] 'agreement among raft nodes before linearized reading' (duration: 376.586841ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:20.021758Z","caller":"traceutil/trace.go:171","msg":"trace[100568222] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1271; }","duration":"325.017928ms","start":"2026-04-20T11:56:19.696727Z","end":"2026-04-20T11:56:20.021745Z","steps":["trace[100568222] 'agreement among raft nodes before linearized reading' (duration: 324.952227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:20.021776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.645092Z","time spent":"376.679672ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T11:56:20.02179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.696713Z","time spent":"325.069199ms","remote":"127.0.0.1:58802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:56:20.021801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:19.644736Z","time spent":"376.988758ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:20.546798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.276165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:20.546931Z","caller":"traceutil/trace.go:171","msg":"trace[129358812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"241.440508ms","start":"2026-04-20T11:56:20.305466Z","end":"2026-04-20T11:56:20.546907Z","steps":["trace[129358812] 'range keys from in-memory index tree' (duration: 241.188083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:30.367885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.724961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-20T11:56:30.367949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.203789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-04-20T11:56:30.36818Z","caller":"traceutil/trace.go:171","msg":"trace[294922651] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1339; }","duration":"251.448314ms","start":"2026-04-20T11:56:30.11671Z","end":"2026-04-20T11:56:30.368159Z","steps":["trace[294922651] 'range keys from in-memory index tree' (duration: 251.026086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:30.36836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.657859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T11:56:30.368437Z","caller":"traceutil/trace.go:171","msg":"trace[1660724258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1339; }","duration":"341.76909ms","start":"2026-04-20T11:56:30.026656Z","end":"2026-04-20T11:56:30.368425Z","steps":["trace[1660724258] 'range keys from in-memory index tree' (duration: 341.535566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:30.368479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.026635Z","time spent":"341.831652ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T11:56:30.368722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.44756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-20T11:56:30.368762Z","caller":"traceutil/trace.go:171","msg":"trace[1537259996] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1339; }","duration":"292.488421ms","start":"2026-04-20T11:56:30.076262Z","end":"2026-04-20T11:56:30.36875Z","steps":["trace[1537259996] 'range keys from in-memory index tree' (duration: 292.358769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:30.368779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.934743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T11:56:30.368852Z","caller":"traceutil/trace.go:171","msg":"trace[1456841797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1339; }","duration":"305.046836ms","start":"2026-04-20T11:56:30.063787Z","end":"2026-04-20T11:56:30.368834Z","steps":["trace[1456841797] 'range keys from in-memory index tree' (duration: 304.77665ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:30.367983Z","caller":"traceutil/trace.go:171","msg":"trace[1234928154] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1339; }","duration":"303.887323ms","start":"2026-04-20T11:56:30.064073Z","end":"2026-04-20T11:56:30.367961Z","steps":["trace[1234928154] 'range keys from in-memory index tree' (duration: 303.529947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:30.368896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.063777Z","time spent":"305.109427ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T11:56:30.368912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.064052Z","time spent":"304.848072ms","remote":"127.0.0.1:58624","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-04-20T11:56:30.369205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.708466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-20T11:56:30.369314Z","caller":"traceutil/trace.go:171","msg":"trace[1747080349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1339; }","duration":"306.883739ms","start":"2026-04-20T11:56:30.062406Z","end":"2026-04-20T11:56:30.36929Z","steps":["trace[1747080349] 'range keys from in-memory index tree' (duration: 305.83655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:30.36937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.062389Z","time spent":"306.967731ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T11:56:31.131826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696222013607537,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T11:56:31.31428Z","caller":"traceutil/trace.go:171","msg":"trace[1525612299] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"941.194492ms","start":"2026-04-20T11:56:30.373067Z","end":"2026-04-20T11:56:31.314261Z","steps":["trace[1525612299] 'process raft request' (duration: 941.05741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.314413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.373037Z","time spent":"941.306734ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:31.588958Z","caller":"traceutil/trace.go:171","msg":"trace[480058874] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"1.21584676s","start":"2026-04-20T11:56:30.373076Z","end":"2026-04-20T11:56:31.588923Z","steps":["trace[480058874] 'process raft request' (duration: 1.180680733s)","trace[480058874] 'compare' (duration: 34.610587ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:31.589002Z","caller":"traceutil/trace.go:171","msg":"trace[1569660705] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"1.21588091s","start":"2026-04-20T11:56:30.373084Z","end":"2026-04-20T11:56:31.588965Z","steps":["trace[1569660705] 'process raft request' (duration: 1.215649936s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.589079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.373051Z","time spent":"1.215963422s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:31.589136Z","caller":"traceutil/trace.go:171","msg":"trace[126000929] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"1.215783249s","start":"2026-04-20T11:56:30.373213Z","end":"2026-04-20T11:56:31.588996Z","steps":["trace[126000929] 'process raft request' (duration: 1.215579165s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.589171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.373067Z","time spent":"1.216009474s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:31.589254Z","caller":"traceutil/trace.go:171","msg":"trace[223578338] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"1.215770069s","start":"2026-04-20T11:56:30.373465Z","end":"2026-04-20T11:56:31.589235Z","steps":["trace[223578338] 'process raft request' (duration: 1.215374471s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.589297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.373193Z","time spent":"1.216014134s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:31.589411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.373455Z","time spent":"1.215877412s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:56:31.589647Z","caller":"traceutil/trace.go:171","msg":"trace[155456309] linearizableReadLoop","detail":"{readStateIndex:1396; appliedIndex:1390; }","duration":"958.504116ms","start":"2026-04-20T11:56:30.631114Z","end":"2026-04-20T11:56:31.589619Z","steps":["trace[155456309] 'read index received' (duration: 683.025932ms)","trace[155456309] 'applied index is now lower than readState.Index' (duration: 275.477054ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:31.589714Z","caller":"traceutil/trace.go:171","msg":"trace[1739575792] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"1.216092285s","start":"2026-04-20T11:56:30.373599Z","end":"2026-04-20T11:56:31.589692Z","steps":["trace[1739575792] 'process raft request' (duration: 1.21527164s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.589772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.373587Z","time spent":"1.216156716s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:56:31.589872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.147895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:31.589953Z","caller":"traceutil/trace.go:171","msg":"trace[1165606725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1345; }","duration":"284.263798ms","start":"2026-04-20T11:56:31.305676Z","end":"2026-04-20T11:56:31.58994Z","steps":["trace[1165606725] 'agreement among raft nodes before linearized reading' (duration: 284.164936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.589889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.783521ms","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-04-20T11:56:31.590041Z","caller":"traceutil/trace.go:171","msg":"trace[468552492] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1345; }","duration":"958.980754ms","start":"2026-04-20T11:56:30.631045Z","end":"2026-04-20T11:56:31.590026Z","steps":["trace[468552492] 'agreement among raft nodes before linearized reading' (duration: 958.684199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.590086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.631017Z","time spent":"959.057016ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T11:56:31.589886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.114131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T11:56:31.590186Z","caller":"traceutil/trace.go:171","msg":"trace[792933214] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1345; }","duration":"805.457268ms","start":"2026-04-20T11:56:30.784716Z","end":"2026-04-20T11:56:31.590173Z","steps":["trace[792933214] 'agreement among raft nodes before linearized reading' (duration: 805.068691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:31.590221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:30.784682Z","time spent":"805.52872ms","remote":"127.0.0.1:58922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-20T11:56:34.075804Z","caller":"traceutil/trace.go:171","msg":"trace[2026283088] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1407; }","duration":"237.323382ms","start":"2026-04-20T11:56:33.83846Z","end":"2026-04-20T11:56:34.075783Z","steps":["trace[2026283088] 'read index received' (duration: 237.125027ms)","trace[2026283088] 'applied index is now lower than readState.Index' (duration: 197.535µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:34.075863Z","caller":"traceutil/trace.go:171","msg":"trace[218672247] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"255.821606ms","start":"2026-04-20T11:56:33.820013Z","end":"2026-04-20T11:56:34.075835Z","steps":["trace[218672247] 'process raft request' (duration: 255.614522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:34.076036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.560656ms","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-04-20T11:56:34.076077Z","caller":"traceutil/trace.go:171","msg":"trace[264837916] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1356; }","duration":"237.662768ms","start":"2026-04-20T11:56:33.838404Z","end":"2026-04-20T11:56:34.076066Z","steps":["trace[264837916] 'agreement among raft nodes before linearized reading' (duration: 237.514285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:34.076111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.327665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:34.07619Z","caller":"traceutil/trace.go:171","msg":"trace[1605800752] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1356; }","duration":"227.478938ms","start":"2026-04-20T11:56:33.848694Z","end":"2026-04-20T11:56:34.076173Z","steps":["trace[1605800752] 'agreement among raft nodes before linearized reading' (duration: 227.354805ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:59.543241Z","caller":"traceutil/trace.go:171","msg":"trace[1795711270] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"111.811491ms","start":"2026-04-20T11:56:59.431397Z","end":"2026-04-20T11:56:59.543209Z","steps":["trace[1795711270] 'process raft request' (duration: 111.110037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:21.905573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.710237ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:57:21.905804Z","caller":"traceutil/trace.go:171","msg":"trace[769933380] transaction","detail":"{read_only:false; response_revision:1572; number_of_response:1; }","duration":"202.428732ms","start":"2026-04-20T11:57:21.703347Z","end":"2026-04-20T11:57:21.905776Z","steps":["trace[769933380] 'process raft request' (duration: 62.417579ms)","trace[769933380] 'compare' (duration: 139.606605ms)"],"step_count":2}