{"level":"warn","ts":"2026-07-23T19:16:56.163954Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T19:16:56.164098Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-07-23T19:16:56.164208Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T19:16:56.16422Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-07-23T19:16:56.164257Z","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-07-23T19:16:56.165187Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-07-23T19:16:56.165425Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-07-23T19:16:56.170378Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.386052ms"} {"level":"info","ts":"2026-07-23T19:16:56.176917Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-07-23T19:16:56.177126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T19:16:56.17726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-07-23T19:16:56.177332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T19:16:56.177413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-07-23T19:16:56.177505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-07-23T19:16:56.190989Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T19:16:56.192779Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T19:16:56.193971Z","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-07-23T19:16:56.196115Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T19:16:56.196377Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T19:16:56.196735Z","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-07-23T19:16:56.196853Z","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-07-23T19:16:56.196863Z","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-07-23T19:16:56.197758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-07-23T19:16:56.200023Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-07-23T19:16:56.203703Z","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-07-23T19:16:56.204065Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T19:16:56.204067Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-07-23T19:16:56.204242Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-07-23T19:16:56.204105Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T19:16:56.978015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T19:16:56.978076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T19:16:56.978113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-07-23T19:16:56.978125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-07-23T19:16:56.97813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-07-23T19:16:56.978139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-07-23T19:16:56.978149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-07-23T19:16:56.979286Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T19:16:56.979441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T19:16:56.979497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T19:16:56.979761Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T19:16:56.980898Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T19:16:56.980987Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T19:16:56.981026Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T19:16:56.981225Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-07-23T19:16:56.98134Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T19:16:56.981416Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T19:16:56.982748Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-23T19:17:00.949363Z","caller":"traceutil/trace.go:171","msg":"trace[2024528221] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"201.331381ms","start":"2026-07-23T19:17:00.748011Z","end":"2026-07-23T19:17:00.949343Z","steps":["trace[2024528221] 'process raft request' (duration: 201.215216ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.011383Z","caller":"traceutil/trace.go:171","msg":"trace[367437641] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"210.873624ms","start":"2026-07-23T19:17:32.800483Z","end":"2026-07-23T19:17:33.011356Z","steps":["trace[367437641] 'process raft request' (duration: 210.730023ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.017665Z","caller":"traceutil/trace.go:171","msg":"trace[1523450437] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"216.792278ms","start":"2026-07-23T19:17:32.80084Z","end":"2026-07-23T19:17:33.017632Z","steps":["trace[1523450437] 'process raft request' (duration: 216.373595ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.017738Z","caller":"traceutil/trace.go:171","msg":"trace[2099302685] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"216.244154ms","start":"2026-07-23T19:17:32.80145Z","end":"2026-07-23T19:17:33.017694Z","steps":["trace[2099302685] 'process raft request' (duration: 215.898162ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.017767Z","caller":"traceutil/trace.go:171","msg":"trace[442851832] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"207.979897ms","start":"2026-07-23T19:17:32.809772Z","end":"2026-07-23T19:17:33.017752Z","steps":["trace[442851832] 'process raft request' (duration: 207.667125ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.01788Z","caller":"traceutil/trace.go:171","msg":"trace[1963939218] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"214.438281ms","start":"2026-07-23T19:17:32.803428Z","end":"2026-07-23T19:17:33.017866Z","steps":["trace[1963939218] 'process raft request' (duration: 213.950669ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.017858Z","caller":"traceutil/trace.go:171","msg":"trace[764738077] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"207.993837ms","start":"2026-07-23T19:17:32.809836Z","end":"2026-07-23T19:17:33.01783Z","steps":["trace[764738077] 'process raft request' (duration: 207.634095ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.017983Z","caller":"traceutil/trace.go:171","msg":"trace[344717497] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"207.991177ms","start":"2026-07-23T19:17:32.809981Z","end":"2026-07-23T19:17:33.017972Z","steps":["trace[344717497] 'process raft request' (duration: 207.555985ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.025001Z","caller":"traceutil/trace.go:171","msg":"trace[352876672] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"212.827944ms","start":"2026-07-23T19:17:32.812128Z","end":"2026-07-23T19:17:33.024956Z","steps":["trace[352876672] 'process raft request' (duration: 205.45709ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.028501Z","caller":"traceutil/trace.go:171","msg":"trace[556772013] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"164.28276ms","start":"2026-07-23T19:17:32.863923Z","end":"2026-07-23T19:17:33.028206Z","steps":["trace[556772013] 'process raft request' (duration: 161.426569ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.04046Z","caller":"traceutil/trace.go:171","msg":"trace[562093083] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"176.264619ms","start":"2026-07-23T19:17:32.864169Z","end":"2026-07-23T19:17:33.040433Z","steps":["trace[562093083] 'process raft request' (duration: 164.149829ms)","trace[562093083] 'compare' (duration: 11.349934ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:17:33.040474Z","caller":"traceutil/trace.go:171","msg":"trace[1462294041] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"148.677009ms","start":"2026-07-23T19:17:32.891779Z","end":"2026-07-23T19:17:33.040456Z","steps":["trace[1462294041] 'process raft request' (duration: 148.090984ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.040516Z","caller":"traceutil/trace.go:171","msg":"trace[1716281639] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"162.112771ms","start":"2026-07-23T19:17:32.878377Z","end":"2026-07-23T19:17:33.04049Z","steps":["trace[1716281639] 'process raft request' (duration: 161.439246ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.202711Z","caller":"traceutil/trace.go:171","msg":"trace[1303047984] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"107.725658ms","start":"2026-07-23T19:17:33.094957Z","end":"2026-07-23T19:17:33.202683Z","steps":["trace[1303047984] 'process raft request' (duration: 100.370934ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.20296Z","caller":"traceutil/trace.go:171","msg":"trace[1788987687] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"103.350806ms","start":"2026-07-23T19:17:33.099572Z","end":"2026-07-23T19:17:33.202923Z","steps":["trace[1788987687] 'process raft request' (duration: 102.450179ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:33.203192Z","caller":"traceutil/trace.go:171","msg":"trace[1321577574] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"103.429107ms","start":"2026-07-23T19:17:33.09969Z","end":"2026-07-23T19:17:33.203119Z","steps":["trace[1321577574] 'process raft request' (duration: 102.458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:36.431329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.352799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:17:36.431527Z","caller":"traceutil/trace.go:171","msg":"trace[1742644589] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"365.604877ms","start":"2026-07-23T19:17:36.065901Z","end":"2026-07-23T19:17:36.431506Z","steps":["trace[1742644589] 'process raft request' (duration: 176.869372ms)","trace[1742644589] 'compare' (duration: 181.168699ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:17:36.431599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:17:36.065869Z","time spent":"365.705718ms","remote":"127.0.0.1:40792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T19:17:36.43191Z","caller":"traceutil/trace.go:171","msg":"trace[1868599801] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"197.065339ms","start":"2026-07-23T19:17:36.234401Z","end":"2026-07-23T19:17:36.431467Z","steps":["trace[1868599801] 'read index received' (duration: 7.98645ms)","trace[1868599801] 'applied index is now lower than readState.Index' (duration: 189.077589ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:17:36.431921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.491593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:36.432178Z","caller":"traceutil/trace.go:171","msg":"trace[598984240] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:567; }","duration":"197.774405ms","start":"2026-07-23T19:17:36.234365Z","end":"2026-07-23T19:17:36.432139Z","steps":["trace[598984240] 'agreement among raft nodes before linearized reading' (duration: 197.371142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:36.432239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.357483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:36.432282Z","caller":"traceutil/trace.go:171","msg":"trace[1074521237] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:567; }","duration":"178.427465ms","start":"2026-07-23T19:17:36.253835Z","end":"2026-07-23T19:17:36.432263Z","steps":["trace[1074521237] 'agreement among raft nodes before linearized reading' (duration: 178.366794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:36.432353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.626155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:36.432517Z","caller":"traceutil/trace.go:171","msg":"trace[514925498] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:567; }","duration":"179.910378ms","start":"2026-07-23T19:17:36.252555Z","end":"2026-07-23T19:17:36.432466Z","steps":["trace[514925498] 'agreement among raft nodes before linearized reading' (duration: 179.601025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:36.432748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.18135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:36.432782Z","caller":"traceutil/trace.go:171","msg":"trace[241788893] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:567; }","duration":"180.23784ms","start":"2026-07-23T19:17:36.252537Z","end":"2026-07-23T19:17:36.432775Z","steps":["trace[241788893] 'agreement among raft nodes before linearized reading' (duration: 180.14928ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:36.435214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.161067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:36.435479Z","caller":"traceutil/trace.go:171","msg":"trace[57693892] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:567; }","duration":"200.450749ms","start":"2026-07-23T19:17:36.235009Z","end":"2026-07-23T19:17:36.43546Z","steps":["trace[57693892] 'agreement among raft nodes before linearized reading' (duration: 200.153397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:36.432086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.652574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:36.437399Z","caller":"traceutil/trace.go:171","msg":"trace[267261096] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:567; }","duration":"202.215465ms","start":"2026-07-23T19:17:36.234389Z","end":"2026-07-23T19:17:36.436604Z","steps":["trace[267261096] 'agreement among raft nodes before linearized reading' (duration: 197.671944ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:39.587889Z","caller":"traceutil/trace.go:171","msg":"trace[257151009] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"189.889012ms","start":"2026-07-23T19:17:39.397975Z","end":"2026-07-23T19:17:39.587864Z","steps":["trace[257151009] 'read index received' (duration: 189.113094ms)","trace[257151009] 'applied index is now lower than readState.Index' (duration: 774.948µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:17:39.588019Z","caller":"traceutil/trace.go:171","msg":"trace[1292219596] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"229.011561ms","start":"2026-07-23T19:17:39.358943Z","end":"2026-07-23T19:17:39.587955Z","steps":["trace[1292219596] 'process raft request' (duration: 228.393625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:39.588083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.090294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:39.588134Z","caller":"traceutil/trace.go:171","msg":"trace[167110109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"190.199825ms","start":"2026-07-23T19:17:39.397923Z","end":"2026-07-23T19:17:39.588123Z","steps":["trace[167110109] 'agreement among raft nodes before linearized reading' (duration: 190.104695ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:39.95961Z","caller":"traceutil/trace.go:171","msg":"trace[1926636764] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"341.348665ms","start":"2026-07-23T19:17:39.618183Z","end":"2026-07-23T19:17:39.959531Z","steps":["trace[1926636764] 'process raft request' (duration: 341.182014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:39.96007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:17:39.618153Z","time spent":"341.545957ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:17:40.332441Z","caller":"traceutil/trace.go:171","msg":"trace[1141706760] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"576.275399ms","start":"2026-07-23T19:17:39.756138Z","end":"2026-07-23T19:17:40.332414Z","steps":["trace[1141706760] 'read index received' (duration: 203.255989ms)","trace[1141706760] 'applied index is now lower than readState.Index' (duration: 373.01793ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:17:40.332637Z","caller":"traceutil/trace.go:171","msg":"trace[1195646047] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"681.593972ms","start":"2026-07-23T19:17:39.650899Z","end":"2026-07-23T19:17:40.332493Z","steps":["trace[1195646047] 'process raft request' (duration: 649.591032ms)","trace[1195646047] 'compare' (duration: 31.640676ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:17:40.332706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.553783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-23T19:17:40.332746Z","caller":"traceutil/trace.go:171","msg":"trace[121582391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"576.648564ms","start":"2026-07-23T19:17:39.756087Z","end":"2026-07-23T19:17:40.332736Z","steps":["trace[121582391] 'agreement among raft nodes before linearized reading' (duration: 576.457552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:40.332733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.855669ms","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-07-23T19:17:40.332773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:17:39.75607Z","time spent":"576.698184ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T19:17:40.332659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.830263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-23T19:17:40.332983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:17:39.650879Z","time spent":"681.925016ms","remote":"127.0.0.1:41194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T19:17:40.333286Z","caller":"traceutil/trace.go:171","msg":"trace[1121201148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"276.985511ms","start":"2026-07-23T19:17:40.055798Z","end":"2026-07-23T19:17:40.332784Z","steps":["trace[1121201148] 'agreement among raft nodes before linearized reading' (duration: 276.775369ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:40.332949Z","caller":"traceutil/trace.go:171","msg":"trace[284360689] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:590; }","duration":"138.123605ms","start":"2026-07-23T19:17:40.194759Z","end":"2026-07-23T19:17:40.332882Z","steps":["trace[284360689] 'agreement among raft nodes before linearized reading' (duration: 137.823863ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:17:53.240231Z","caller":"traceutil/trace.go:171","msg":"trace[1816590413] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"102.390748ms","start":"2026-07-23T19:17:53.137811Z","end":"2026-07-23T19:17:53.240201Z","steps":["trace[1816590413] 'process raft request' (duration: 102.150244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:55.707851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.744126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:17:55.707951Z","caller":"traceutil/trace.go:171","msg":"trace[2025070213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"311.190434ms","start":"2026-07-23T19:17:55.396739Z","end":"2026-07-23T19:17:55.70793Z","steps":["trace[2025070213] 'range keys from in-memory index tree' (duration: 310.603535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:17:55.708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:17:55.396717Z","time spent":"311.274255ms","remote":"127.0.0.1:40676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-23T19:18:03.380447Z","caller":"traceutil/trace.go:171","msg":"trace[1353840225] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"153.38413ms","start":"2026-07-23T19:18:03.227044Z","end":"2026-07-23T19:18:03.380428Z","steps":["trace[1353840225] 'process raft request' (duration: 153.249318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:18:03.380582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.39084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T19:18:03.38061Z","caller":"traceutil/trace.go:171","msg":"trace[1743500237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:837; }","duration":"134.477761ms","start":"2026-07-23T19:18:03.246127Z","end":"2026-07-23T19:18:03.380605Z","steps":["trace[1743500237] 'agreement among raft nodes before linearized reading' (duration: 134.347849ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:18:03.380431Z","caller":"traceutil/trace.go:171","msg":"trace[1040046257] linearizableReadLoop","detail":"{readStateIndex:865; appliedIndex:864; }","duration":"134.236367ms","start":"2026-07-23T19:18:03.246176Z","end":"2026-07-23T19:18:03.380412Z","steps":["trace[1040046257] 'read index received' (duration: 134.088894ms)","trace[1040046257] 'applied index is now lower than readState.Index' (duration: 146.723µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:18:03.498911Z","caller":"traceutil/trace.go:171","msg":"trace[798775809] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"189.649238ms","start":"2026-07-23T19:18:03.309229Z","end":"2026-07-23T19:18:03.498878Z","steps":["trace[798775809] 'process raft request' (duration: 151.588696ms)","trace[798775809] 'compare' (duration: 37.896769ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:18:03.498949Z","caller":"traceutil/trace.go:171","msg":"trace[9611861] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"113.90434ms","start":"2026-07-23T19:18:03.385007Z","end":"2026-07-23T19:18:03.498912Z","steps":["trace[9611861] 'process raft request' (duration: 113.815919ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:18:10.727573Z","caller":"traceutil/trace.go:171","msg":"trace[1870571850] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"112.893358ms","start":"2026-07-23T19:18:10.614653Z","end":"2026-07-23T19:18:10.727546Z","steps":["trace[1870571850] 'process raft request' (duration: 112.748075ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:18:10.954028Z","caller":"traceutil/trace.go:171","msg":"trace[504650872] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"246.015709ms","start":"2026-07-23T19:18:10.707975Z","end":"2026-07-23T19:18:10.95399Z","steps":["trace[504650872] 'process raft request' (duration: 167.114684ms)","trace[504650872] 'compare' (duration: 78.67465ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:43.651396Z","caller":"traceutil/trace.go:171","msg":"trace[1663050471] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"164.141136ms","start":"2026-07-23T19:19:43.487221Z","end":"2026-07-23T19:19:43.651362Z","steps":["trace[1663050471] 'process raft request' (duration: 136.542783ms)","trace[1663050471] 'compare' (duration: 27.437537ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:46.065635Z","caller":"traceutil/trace.go:171","msg":"trace[1280515553] linearizableReadLoop","detail":"{readStateIndex:1521; appliedIndex:1520; }","duration":"250.23966ms","start":"2026-07-23T19:19:45.81538Z","end":"2026-07-23T19:19:46.06562Z","steps":["trace[1280515553] 'read index received' (duration: 249.502795ms)","trace[1280515553] 'applied index is now lower than readState.Index' (duration: 736.145µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:46.065841Z","caller":"traceutil/trace.go:171","msg":"trace[1864284870] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"252.173906ms","start":"2026-07-23T19:19:45.813661Z","end":"2026-07-23T19:19:46.065835Z","steps":["trace[1864284870] 'process raft request' (duration: 251.336898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:46.066351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.958815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6249"} {"level":"info","ts":"2026-07-23T19:19:46.06637Z","caller":"traceutil/trace.go:171","msg":"trace[399468462] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:1466; }","duration":"251.008907ms","start":"2026-07-23T19:19:45.815356Z","end":"2026-07-23T19:19:46.066365Z","steps":["trace[399468462] 'agreement among raft nodes before linearized reading' (duration: 250.912304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:46.068187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.431238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/rook-ceph/\" range_end:\"/registry/secrets/rook-ceph0\" ","response":"range_response_count:1 size:307179"} {"level":"info","ts":"2026-07-23T19:19:46.068239Z","caller":"traceutil/trace.go:171","msg":"trace[1526886563] range","detail":"{range_begin:/registry/secrets/rook-ceph/; range_end:/registry/secrets/rook-ceph0; response_count:1; response_revision:1467; }","duration":"194.520611ms","start":"2026-07-23T19:19:45.873707Z","end":"2026-07-23T19:19:46.068227Z","steps":["trace[1526886563] 'agreement among raft nodes before linearized reading' (duration: 194.290292ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:47.699317Z","caller":"traceutil/trace.go:171","msg":"trace[1704559757] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"174.682078ms","start":"2026-07-23T19:19:47.524612Z","end":"2026-07-23T19:19:47.699294Z","steps":["trace[1704559757] 'process raft request' (duration: 149.977388ms)","trace[1704559757] 'compare' (duration: 24.560284ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:47.759401Z","caller":"traceutil/trace.go:171","msg":"trace[279412748] linearizableReadLoop","detail":"{readStateIndex:1572; appliedIndex:1570; }","duration":"204.038367ms","start":"2026-07-23T19:19:47.555343Z","end":"2026-07-23T19:19:47.759382Z","steps":["trace[279412748] 'read index received' (duration: 119.182199ms)","trace[279412748] 'applied index is now lower than readState.Index' (duration: 84.855518ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:19:47.759565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.203213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-ph4mz\" ","response":"range_response_count:1 size:7666"} {"level":"info","ts":"2026-07-23T19:19:47.759532Z","caller":"traceutil/trace.go:171","msg":"trace[700845025] transaction","detail":"{read_only:false; response_revision:1516; number_of_response:1; }","duration":"230.022231ms","start":"2026-07-23T19:19:47.529475Z","end":"2026-07-23T19:19:47.759498Z","steps":["trace[700845025] 'process raft request' (duration: 229.758602ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:47.759616Z","caller":"traceutil/trace.go:171","msg":"trace[1709754970] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-cf56b6468-ph4mz; range_end:; response_count:1; response_revision:1516; }","duration":"204.300466ms","start":"2026-07-23T19:19:47.555308Z","end":"2026-07-23T19:19:47.759608Z","steps":["trace[1709754970] 'agreement among raft nodes before linearized reading' (duration: 204.14402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:47.977742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.976618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:19:47.978004Z","caller":"traceutil/trace.go:171","msg":"trace[1713579033] linearizableReadLoop","detail":"{readStateIndex:1575; appliedIndex:1572; }","duration":"195.550356ms","start":"2026-07-23T19:19:47.782436Z","end":"2026-07-23T19:19:47.977986Z","steps":["trace[1713579033] 'read index received' (duration: 63.327768ms)","trace[1713579033] 'applied index is now lower than readState.Index' (duration: 132.221388ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:47.978027Z","caller":"traceutil/trace.go:171","msg":"trace[328368840] transaction","detail":"{read_only:false; response_revision:1518; number_of_response:1; }","duration":"205.086953ms","start":"2026-07-23T19:19:47.772916Z","end":"2026-07-23T19:19:47.978003Z","steps":["trace[328368840] 'process raft request' (duration: 204.940597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:47.978088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.643109ms","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-07-23T19:19:47.978116Z","caller":"traceutil/trace.go:171","msg":"trace[1902130073] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1519; }","duration":"195.722352ms","start":"2026-07-23T19:19:47.782384Z","end":"2026-07-23T19:19:47.978107Z","steps":["trace[1902130073] 'agreement among raft nodes before linearized reading' (duration: 195.654199ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:47.978225Z","caller":"traceutil/trace.go:171","msg":"trace[2128466633] transaction","detail":"{read_only:false; response_revision:1519; number_of_response:1; }","duration":"204.827845ms","start":"2026-07-23T19:19:47.773237Z","end":"2026-07-23T19:19:47.978065Z","steps":["trace[2128466633] 'process raft request' (duration: 204.685721ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:47.978031Z","caller":"traceutil/trace.go:171","msg":"trace[1732764024] transaction","detail":"{read_only:false; response_revision:1517; number_of_response:1; }","duration":"277.147042ms","start":"2026-07-23T19:19:47.700834Z","end":"2026-07-23T19:19:47.977981Z","steps":["trace[1732764024] 'process raft request' (duration: 144.839081ms)","trace[1732764024] 'compare' (duration: 131.757621ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:48.197142Z","caller":"traceutil/trace.go:171","msg":"trace[133529296] transaction","detail":"{read_only:false; response_revision:1524; number_of_response:1; }","duration":"193.667592ms","start":"2026-07-23T19:19:48.003441Z","end":"2026-07-23T19:19:48.197109Z","steps":["trace[133529296] 'process raft request' (duration: 193.61955ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.197165Z","caller":"traceutil/trace.go:171","msg":"trace[1543614655] transaction","detail":"{read_only:false; response_revision:1522; number_of_response:1; }","duration":"213.610808ms","start":"2026-07-23T19:19:47.983521Z","end":"2026-07-23T19:19:48.197131Z","steps":["trace[1543614655] 'process raft request' (duration: 213.444471ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.197349Z","caller":"traceutil/trace.go:171","msg":"trace[22144322] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"215.726601ms","start":"2026-07-23T19:19:47.981613Z","end":"2026-07-23T19:19:48.19734Z","steps":["trace[22144322] 'process raft request' (duration: 170.524593ms)","trace[22144322] 'compare' (duration: 44.656179ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:48.197672Z","caller":"traceutil/trace.go:171","msg":"trace[2105733988] transaction","detail":"{read_only:false; response_revision:1523; number_of_response:1; }","duration":"214.116254ms","start":"2026-07-23T19:19:47.983546Z","end":"2026-07-23T19:19:48.197663Z","steps":["trace[2105733988] 'process raft request' (duration: 213.475632ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.197759Z","caller":"traceutil/trace.go:171","msg":"trace[1746238772] linearizableReadLoop","detail":"{readStateIndex:1579; appliedIndex:1576; }","duration":"208.859065ms","start":"2026-07-23T19:19:47.98889Z","end":"2026-07-23T19:19:48.197749Z","steps":["trace[1746238772] 'read index received' (duration: 11.827167ms)","trace[1746238772] 'applied index is now lower than readState.Index' (duration: 197.030648ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:19:48.197869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.966298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/ingress-nginx/ingress-nginx-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:19:48.197894Z","caller":"traceutil/trace.go:171","msg":"trace[745482029] range","detail":"{range_begin:/registry/roles/ingress-nginx/ingress-nginx-admission; range_end:; response_count:0; response_revision:1524; }","duration":"209.025241ms","start":"2026-07-23T19:19:47.988861Z","end":"2026-07-23T19:19:48.197886Z","steps":["trace[745482029] 'agreement among raft nodes before linearized reading' (duration: 208.963889ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.316539Z","caller":"traceutil/trace.go:171","msg":"trace[1056446971] linearizableReadLoop","detail":"{readStateIndex:1582; appliedIndex:1580; }","duration":"111.725548ms","start":"2026-07-23T19:19:48.204787Z","end":"2026-07-23T19:19:48.316513Z","steps":["trace[1056446971] 'read index received' (duration: 39.010553ms)","trace[1056446971] 'applied index is now lower than readState.Index' (duration: 72.713775ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:48.316689Z","caller":"traceutil/trace.go:171","msg":"trace[516462612] transaction","detail":"{read_only:false; response_revision:1526; number_of_response:1; }","duration":"111.947837ms","start":"2026-07-23T19:19:48.204687Z","end":"2026-07-23T19:19:48.316634Z","steps":["trace[516462612] 'process raft request' (duration: 93.580075ms)","trace[516462612] 'compare' (duration: 17.98694ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:19:48.316819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.009399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:5 size:29425"} {"level":"info","ts":"2026-07-23T19:19:48.316863Z","caller":"traceutil/trace.go:171","msg":"trace[1152874784] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:5; response_revision:1527; }","duration":"112.113622ms","start":"2026-07-23T19:19:48.204738Z","end":"2026-07-23T19:19:48.316851Z","steps":["trace[1152874784] 'agreement among raft nodes before linearized reading' (duration: 111.908295ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:48.316922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.03402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/node-feature-discovery-worker\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:19:48.316993Z","caller":"traceutil/trace.go:171","msg":"trace[142063140] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/node-feature-discovery-worker; range_end:; response_count:0; response_revision:1527; }","duration":"112.134294ms","start":"2026-07-23T19:19:48.204841Z","end":"2026-07-23T19:19:48.316975Z","steps":["trace[142063140] 'agreement among raft nodes before linearized reading' (duration: 112.02396ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.616517Z","caller":"traceutil/trace.go:171","msg":"trace[1804477461] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"138.762361ms","start":"2026-07-23T19:19:48.477716Z","end":"2026-07-23T19:19:48.616479Z","steps":["trace[1804477461] 'process raft request' (duration: 138.511501ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.6285Z","caller":"traceutil/trace.go:171","msg":"trace[1284755726] transaction","detail":"{read_only:false; response_revision:1534; number_of_response:1; }","duration":"108.27156ms","start":"2026-07-23T19:19:48.520211Z","end":"2026-07-23T19:19:48.628483Z","steps":["trace[1284755726] 'process raft request' (duration: 108.187007ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.628521Z","caller":"traceutil/trace.go:171","msg":"trace[1093414914] transaction","detail":"{read_only:false; response_revision:1533; number_of_response:1; }","duration":"108.395485ms","start":"2026-07-23T19:19:48.520107Z","end":"2026-07-23T19:19:48.628503Z","steps":["trace[1093414914] 'process raft request' (duration: 108.199918ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:48.628516Z","caller":"traceutil/trace.go:171","msg":"trace[1118446085] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"107.783383ms","start":"2026-07-23T19:19:48.520713Z","end":"2026-07-23T19:19:48.628496Z","steps":["trace[1118446085] 'process raft request' (duration: 107.713941ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:49.054902Z","caller":"traceutil/trace.go:171","msg":"trace[1813945022] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"136.64571ms","start":"2026-07-23T19:19:48.918232Z","end":"2026-07-23T19:19:49.054878Z","steps":["trace[1813945022] 'process raft request' (duration: 136.589018ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:49.054967Z","caller":"traceutil/trace.go:171","msg":"trace[1441523103] transaction","detail":"{read_only:false; response_revision:1551; number_of_response:1; }","duration":"228.672011ms","start":"2026-07-23T19:19:48.826258Z","end":"2026-07-23T19:19:49.05493Z","steps":["trace[1441523103] 'process raft request' (duration: 185.403908ms)","trace[1441523103] 'compare' (duration: 43.003884ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:49.055177Z","caller":"traceutil/trace.go:171","msg":"trace[31465898] linearizableReadLoop","detail":"{readStateIndex:1608; appliedIndex:1607; }","duration":"138.468713ms","start":"2026-07-23T19:19:48.916697Z","end":"2026-07-23T19:19:49.055165Z","steps":["trace[31465898] 'read index received' (duration: 94.980582ms)","trace[31465898] 'applied index is now lower than readState.Index' (duration: 43.486941ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:19:49.055337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.619578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-controller-orders\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:19:49.055367Z","caller":"traceutil/trace.go:171","msg":"trace[1488514404] range","detail":"{range_begin:/registry/clusterroles/cert-manager-controller-orders; range_end:; response_count:0; response_revision:1552; }","duration":"138.687661ms","start":"2026-07-23T19:19:48.916671Z","end":"2026-07-23T19:19:49.055358Z","steps":["trace[1488514404] 'agreement among raft nodes before linearized reading' (duration: 138.579907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:49.055508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.023759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-jt9c8\" ","response":"range_response_count:1 size:3276"} {"level":"info","ts":"2026-07-23T19:19:49.05556Z","caller":"traceutil/trace.go:171","msg":"trace[2062948540] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-jt9c8; range_end:; response_count:1; response_revision:1552; }","duration":"136.105632ms","start":"2026-07-23T19:19:48.919434Z","end":"2026-07-23T19:19:49.05554Z","steps":["trace[2062948540] 'agreement among raft nodes before linearized reading' (duration: 135.932366ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:49.226992Z","caller":"traceutil/trace.go:171","msg":"trace[306779422] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"115.153504ms","start":"2026-07-23T19:19:49.111821Z","end":"2026-07-23T19:19:49.226974Z","steps":["trace[306779422] 'process raft request' (duration: 115.127053ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:49.227152Z","caller":"traceutil/trace.go:171","msg":"trace[486271268] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"116.364875ms","start":"2026-07-23T19:19:49.110761Z","end":"2026-07-23T19:19:49.227126Z","steps":["trace[486271268] 'process raft request' (duration: 116.156108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:49.227331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.954756ms","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-07-23T19:19:49.227363Z","caller":"traceutil/trace.go:171","msg":"trace[166766950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1557; }","duration":"115.016029ms","start":"2026-07-23T19:19:49.112339Z","end":"2026-07-23T19:19:49.227355Z","steps":["trace[166766950] 'agreement among raft nodes before linearized reading' (duration: 114.892304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:49.227424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.812443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-cluster-view\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:19:49.227511Z","caller":"traceutil/trace.go:171","msg":"trace[1592175440] range","detail":"{range_begin:/registry/clusterroles/cert-manager-cluster-view; range_end:; response_count:0; response_revision:1557; }","duration":"123.951847ms","start":"2026-07-23T19:19:49.103536Z","end":"2026-07-23T19:19:49.227488Z","steps":["trace[1592175440] 'agreement among raft nodes before linearized reading' (duration: 123.786982ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:49.227858Z","caller":"traceutil/trace.go:171","msg":"trace[558598210] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"117.35273ms","start":"2026-07-23T19:19:49.109702Z","end":"2026-07-23T19:19:49.227055Z","steps":["trace[558598210] 'process raft request' (duration: 117.108981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.437932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.376413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:19:50.438454Z","caller":"traceutil/trace.go:171","msg":"trace[1541988841] transaction","detail":"{read_only:false; response_revision:1705; number_of_response:1; }","duration":"468.570533ms","start":"2026-07-23T19:19:49.969844Z","end":"2026-07-23T19:19:50.438415Z","steps":["trace[1541988841] 'process raft request' (duration: 468.250492ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:50.438553Z","caller":"traceutil/trace.go:171","msg":"trace[443713187] transaction","detail":"{read_only:false; response_revision:1704; number_of_response:1; }","duration":"472.595142ms","start":"2026-07-23T19:19:49.965927Z","end":"2026-07-23T19:19:50.438522Z","steps":["trace[443713187] 'process raft request' (duration: 472.107185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.438616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:49.965908Z","time spent":"472.680755ms","remote":"127.0.0.1:40780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":728,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T19:19:50.43868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.820641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-webhook-7d6b59cfdc\" ","response":"range_response_count:1 size:4693"} {"level":"info","ts":"2026-07-23T19:19:50.438713Z","caller":"traceutil/trace.go:171","msg":"trace[1438729417] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-webhook-7d6b59cfdc; range_end:; response_count:1; response_revision:1709; }","duration":"468.883383ms","start":"2026-07-23T19:19:49.96982Z","end":"2026-07-23T19:19:50.438703Z","steps":["trace[1438729417] 'agreement among raft nodes before linearized reading' (duration: 468.77987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.438737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:49.9698Z","time spent":"468.932325ms","remote":"127.0.0.1:41162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":4716,"request content":"key:\"/registry/replicasets/cert-manager/cert-manager-webhook-7d6b59cfdc\" "} {"level":"info","ts":"2026-07-23T19:19:50.438754Z","caller":"traceutil/trace.go:171","msg":"trace[704954845] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"475.791612ms","start":"2026-07-23T19:19:49.962954Z","end":"2026-07-23T19:19:50.438745Z","steps":["trace[704954845] 'process raft request' (duration: 143.532428ms)","trace[704954845] 'compare' (duration: 331.048913ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:19:50.438787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:49.962945Z","time spent":"475.825125ms","remote":"127.0.0.1:40780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T19:19:50.438911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:49.969835Z","time spent":"468.798921ms","remote":"127.0.0.1:41162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3656,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:19:50.438517Z","caller":"traceutil/trace.go:171","msg":"trace[730999101] linearizableReadLoop","detail":"{readStateIndex:1761; appliedIndex:1759; }","duration":"468.652566ms","start":"2026-07-23T19:19:49.969851Z","end":"2026-07-23T19:19:50.438503Z","steps":["trace[730999101] 'read index received' (duration: 136.709522ms)","trace[730999101] 'applied index is now lower than readState.Index' (duration: 331.942244ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:50.440508Z","caller":"traceutil/trace.go:171","msg":"trace[1501187687] transaction","detail":"{read_only:false; response_revision:1706; number_of_response:1; }","duration":"468.843833ms","start":"2026-07-23T19:19:49.969922Z","end":"2026-07-23T19:19:50.438766Z","steps":["trace[1501187687] 'process raft request' (duration: 468.222872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.444716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:49.969912Z","time spent":"474.758757ms","remote":"127.0.0.1:41162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4906,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:19:50.440573Z","caller":"traceutil/trace.go:171","msg":"trace[193056398] transaction","detail":"{read_only:false; response_revision:1707; number_of_response:1; }","duration":"462.195364ms","start":"2026-07-23T19:19:49.976587Z","end":"2026-07-23T19:19:50.438782Z","steps":["trace[193056398] 'process raft request' (duration: 461.582973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.44587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:49.976579Z","time spent":"469.263508ms","remote":"127.0.0.1:40876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3682,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:19:50.444777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.45015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T19:19:50.446375Z","caller":"traceutil/trace.go:171","msg":"trace[1322335980] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1709; }","duration":"347.056776ms","start":"2026-07-23T19:19:50.099286Z","end":"2026-07-23T19:19:50.446342Z","steps":["trace[1322335980] 'agreement among raft nodes before linearized reading' (duration: 345.328746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.446433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:50.099273Z","time spent":"347.149488ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-07-23T19:19:50.440601Z","caller":"traceutil/trace.go:171","msg":"trace[950705023] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"432.605692ms","start":"2026-07-23T19:19:50.006242Z","end":"2026-07-23T19:19:50.438847Z","steps":["trace[950705023] 'process raft request' (duration: 431.9747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.447508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:50.006208Z","time spent":"440.778924ms","remote":"127.0.0.1:40746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":88538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:19:50.440626Z","caller":"traceutil/trace.go:171","msg":"trace[486589561] transaction","detail":"{read_only:false; response_revision:1709; number_of_response:1; }","duration":"363.035658ms","start":"2026-07-23T19:19:50.075984Z","end":"2026-07-23T19:19:50.439019Z","steps":["trace[486589561] 'process raft request' (duration: 362.361604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.447752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:50.075949Z","time spent":"371.705098ms","remote":"127.0.0.1:40792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":286398,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:19:50.445305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.918493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T19:19:50.447974Z","caller":"traceutil/trace.go:171","msg":"trace[1681415550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1709; }","duration":"126.598786ms","start":"2026-07-23T19:19:50.321357Z","end":"2026-07-23T19:19:50.447956Z","steps":["trace[1681415550] 'agreement among raft nodes before linearized reading' (duration: 123.909733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.559305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:19:50.448125Z","caller":"traceutil/trace.go:171","msg":"trace[1184938530] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:1709; }","duration":"127.341951ms","start":"2026-07-23T19:19:50.320775Z","end":"2026-07-23T19:19:50.448117Z","steps":["trace[1184938530] 'agreement among raft nodes before linearized reading' (duration: 124.544135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.074421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:971"} {"level":"info","ts":"2026-07-23T19:19:50.448251Z","caller":"traceutil/trace.go:171","msg":"trace[1274371090] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:1709; }","duration":"201.9569ms","start":"2026-07-23T19:19:50.246284Z","end":"2026-07-23T19:19:50.448241Z","steps":["trace[1274371090] 'agreement among raft nodes before linearized reading' (duration: 199.094682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.143903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:986"} {"level":"info","ts":"2026-07-23T19:19:50.448447Z","caller":"traceutil/trace.go:171","msg":"trace[1235292402] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:1709; }","duration":"202.133516ms","start":"2026-07-23T19:19:50.246305Z","end":"2026-07-23T19:19:50.448439Z","steps":["trace[1235292402] 'agreement among raft nodes before linearized reading' (duration: 199.117362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.242426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:968"} {"level":"info","ts":"2026-07-23T19:19:50.44863Z","caller":"traceutil/trace.go:171","msg":"trace[263603711] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:1709; }","duration":"202.365396ms","start":"2026-07-23T19:19:50.246218Z","end":"2026-07-23T19:19:50.448583Z","steps":["trace[263603711] 'agreement among raft nodes before linearized reading' (duration: 199.246477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.837676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:19:50.448805Z","caller":"traceutil/trace.go:171","msg":"trace[1617705421] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1709; }","duration":"240.155611ms","start":"2026-07-23T19:19:50.208634Z","end":"2026-07-23T19:19:50.44879Z","steps":["trace[1617705421] 'agreement among raft nodes before linearized reading' (duration: 236.869747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.726084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-23T19:19:50.448905Z","caller":"traceutil/trace.go:171","msg":"trace[92148372] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:1709; }","duration":"249.09057ms","start":"2026-07-23T19:19:50.199804Z","end":"2026-07-23T19:19:50.448895Z","steps":["trace[92148372] 'agreement among raft nodes before linearized reading' (duration: 245.725774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:50.445593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.7967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T19:19:50.449018Z","caller":"traceutil/trace.go:171","msg":"trace[2091049459] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1709; }","duration":"296.230059ms","start":"2026-07-23T19:19:50.152758Z","end":"2026-07-23T19:19:50.448988Z","steps":["trace[2091049459] 'agreement among raft nodes before linearized reading' (duration: 292.811471ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:56.830616Z","caller":"traceutil/trace.go:171","msg":"trace[269837268] linearizableReadLoop","detail":"{readStateIndex:1868; appliedIndex:1867; }","duration":"338.759276ms","start":"2026-07-23T19:19:56.491827Z","end":"2026-07-23T19:19:56.830586Z","steps":["trace[269837268] 'read index received' (duration: 338.514318ms)","trace[269837268] 'applied index is now lower than readState.Index' (duration: 243.288µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:19:56.830957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.098889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:6 size:41963"} {"level":"info","ts":"2026-07-23T19:19:56.831043Z","caller":"traceutil/trace.go:171","msg":"trace[436617905] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:6; response_revision:1808; }","duration":"339.214454ms","start":"2026-07-23T19:19:56.491812Z","end":"2026-07-23T19:19:56.831026Z","steps":["trace[436617905] 'agreement among raft nodes before linearized reading' (duration: 338.895854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:56.8311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:56.491806Z","time spent":"339.280886ms","remote":"127.0.0.1:40876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":6,"response size":41986,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-07-23T19:19:56.830971Z","caller":"traceutil/trace.go:171","msg":"trace[501911834] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"339.890247ms","start":"2026-07-23T19:19:56.491016Z","end":"2026-07-23T19:19:56.830906Z","steps":["trace[501911834] 'process raft request' (duration: 339.299076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:56.831565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:56.491004Z","time spent":"340.412626ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:19:57.037489Z","caller":"traceutil/trace.go:171","msg":"trace[860159438] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"541.816423ms","start":"2026-07-23T19:19:56.49561Z","end":"2026-07-23T19:19:57.037426Z","steps":["trace[860159438] 'process raft request' (duration: 541.617517ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:57.03767Z","caller":"traceutil/trace.go:171","msg":"trace[1526238292] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"229.749427ms","start":"2026-07-23T19:19:56.80787Z","end":"2026-07-23T19:19:57.03762Z","steps":["trace[1526238292] 'process raft request' (duration: 229.512709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:57.037803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:19:56.492219Z","time spent":"545.444349ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:19:57.460596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.966936ms","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-07-23T19:19:57.460674Z","caller":"traceutil/trace.go:171","msg":"trace[561401775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1810; }","duration":"188.06132ms","start":"2026-07-23T19:19:57.272593Z","end":"2026-07-23T19:19:57.460654Z","steps":["trace[561401775] 'range keys from in-memory index tree' (duration: 187.78182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:57.46067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.918028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-23T19:19:57.460725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.749782ms","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-07-23T19:19:57.460766Z","caller":"traceutil/trace.go:171","msg":"trace[216788005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1810; }","duration":"132.064933ms","start":"2026-07-23T19:19:57.328678Z","end":"2026-07-23T19:19:57.460743Z","steps":["trace[216788005] 'range keys from in-memory index tree' (duration: 131.741572ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:57.460787Z","caller":"traceutil/trace.go:171","msg":"trace[1518788757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1810; }","duration":"131.844017ms","start":"2026-07-23T19:19:57.328929Z","end":"2026-07-23T19:19:57.460773Z","steps":["trace[1518788757] 'range keys from in-memory index tree' (duration: 131.608517ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:58.799268Z","caller":"traceutil/trace.go:171","msg":"trace[2064779128] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"158.517406ms","start":"2026-07-23T19:19:58.640716Z","end":"2026-07-23T19:19:58.799233Z","steps":["trace[2064779128] 'process raft request' (duration: 158.300918ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:19:59.039139Z","caller":"traceutil/trace.go:171","msg":"trace[1118436009] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1877; }","duration":"104.236479ms","start":"2026-07-23T19:19:58.93488Z","end":"2026-07-23T19:19:59.039117Z","steps":["trace[1118436009] 'read index received' (duration: 104.035652ms)","trace[1118436009] 'applied index is now lower than readState.Index' (duration: 199.987µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:19:59.039269Z","caller":"traceutil/trace.go:171","msg":"trace[1455922642] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"105.066458ms","start":"2026-07-23T19:19:58.934164Z","end":"2026-07-23T19:19:59.039231Z","steps":["trace[1455922642] 'process raft request' (duration: 104.817299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:19:59.03939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.491457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:6 size:42165"} {"level":"info","ts":"2026-07-23T19:19:59.039436Z","caller":"traceutil/trace.go:171","msg":"trace[1109446357] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:6; response_revision:1818; }","duration":"104.556909ms","start":"2026-07-23T19:19:58.934868Z","end":"2026-07-23T19:19:59.039425Z","steps":["trace[1109446357] 'agreement among raft nodes before linearized reading' (duration: 104.339362ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:01.258791Z","caller":"traceutil/trace.go:171","msg":"trace[794229066] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"172.561901ms","start":"2026-07-23T19:20:01.0862Z","end":"2026-07-23T19:20:01.258762Z","steps":["trace[794229066] 'process raft request' (duration: 172.418966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:01.456244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.37116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:20:01.45638Z","caller":"traceutil/trace.go:171","msg":"trace[1961374671] linearizableReadLoop","detail":"{readStateIndex:1891; appliedIndex:1890; }","duration":"360.10423ms","start":"2026-07-23T19:20:01.096254Z","end":"2026-07-23T19:20:01.456359Z","steps":["trace[1961374671] 'read index received' (duration: 162.774578ms)","trace[1961374671] 'applied index is now lower than readState.Index' (duration: 197.327772ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:01.456459Z","caller":"traceutil/trace.go:171","msg":"trace[892855602] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"365.427466ms","start":"2026-07-23T19:20:01.091004Z","end":"2026-07-23T19:20:01.456432Z","steps":["trace[892855602] 'process raft request' (duration: 263.739585ms)","trace[892855602] 'compare' (duration: 101.199424ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:20:01.456612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:01.090995Z","time spent":"365.538431ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:20:01.456764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.497634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:6 size:42266"} {"level":"info","ts":"2026-07-23T19:20:01.456823Z","caller":"traceutil/trace.go:171","msg":"trace[1196591015] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:6; response_revision:1830; }","duration":"360.570386ms","start":"2026-07-23T19:20:01.096237Z","end":"2026-07-23T19:20:01.456807Z","steps":["trace[1196591015] 'agreement among raft nodes before linearized reading' (duration: 360.231134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:01.456866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:01.096229Z","time spent":"360.623747ms","remote":"127.0.0.1:40876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":6,"response size":42289,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-07-23T19:20:01.457884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.743023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T19:20:01.457944Z","caller":"traceutil/trace.go:171","msg":"trace[1201377612] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1830; }","duration":"331.05413ms","start":"2026-07-23T19:20:01.126875Z","end":"2026-07-23T19:20:01.45793Z","steps":["trace[1201377612] 'agreement among raft nodes before linearized reading' (duration: 329.620129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:01.457983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:01.126861Z","time spent":"331.113331ms","remote":"127.0.0.1:40950","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":"info","ts":"2026-07-23T19:20:01.655839Z","caller":"traceutil/trace.go:171","msg":"trace[1774771152] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"103.212066ms","start":"2026-07-23T19:20:01.552597Z","end":"2026-07-23T19:20:01.655809Z","steps":["trace[1774771152] 'process raft request' (duration: 102.994258ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:04.829581Z","caller":"traceutil/trace.go:171","msg":"trace[1407512114] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"154.512049ms","start":"2026-07-23T19:20:04.67505Z","end":"2026-07-23T19:20:04.829562Z","steps":["trace[1407512114] 'process raft request' (duration: 154.373004ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:06.000829Z","caller":"traceutil/trace.go:171","msg":"trace[1572427843] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1912; }","duration":"329.915029ms","start":"2026-07-23T19:20:05.670891Z","end":"2026-07-23T19:20:06.000806Z","steps":["trace[1572427843] 'read index received' (duration: 319.421389ms)","trace[1572427843] 'applied index is now lower than readState.Index' (duration: 10.49208ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:06.001003Z","caller":"traceutil/trace.go:171","msg":"trace[388925870] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"344.176863ms","start":"2026-07-23T19:20:05.656801Z","end":"2026-07-23T19:20:06.000978Z","steps":["trace[388925870] 'process raft request' (duration: 333.562119ms)","trace[388925870] 'compare' (duration: 10.118196ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:20:06.001126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:05.656777Z","time spent":"344.283817ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:20:06.001147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.23381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-23T19:20:06.001445Z","caller":"traceutil/trace.go:171","msg":"trace[1367065114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1852; }","duration":"330.560352ms","start":"2026-07-23T19:20:05.670872Z","end":"2026-07-23T19:20:06.001432Z","steps":["trace[1367065114] 'agreement among raft nodes before linearized reading' (duration: 330.119946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:06.001495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:05.670863Z","time spent":"330.615174ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-23T19:20:06.048195Z","caller":"traceutil/trace.go:171","msg":"trace[1200644533] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"173.553309ms","start":"2026-07-23T19:20:05.874619Z","end":"2026-07-23T19:20:06.048172Z","steps":["trace[1200644533] 'process raft request' (duration: 173.328961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:06.050949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.227042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T19:20:06.051011Z","caller":"traceutil/trace.go:171","msg":"trace[139647990] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1854; }","duration":"185.339806ms","start":"2026-07-23T19:20:05.865656Z","end":"2026-07-23T19:20:06.050996Z","steps":["trace[139647990] 'agreement among raft nodes before linearized reading' (duration: 185.18522ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:09.663795Z","caller":"traceutil/trace.go:171","msg":"trace[907050640] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1930; }","duration":"269.178672ms","start":"2026-07-23T19:20:09.394599Z","end":"2026-07-23T19:20:09.663778Z","steps":["trace[907050640] 'read index received' (duration: 269.019917ms)","trace[907050640] 'applied index is now lower than readState.Index' (duration: 158.015µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:09.663858Z","caller":"traceutil/trace.go:171","msg":"trace[1811589812] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"373.13476ms","start":"2026-07-23T19:20:09.290686Z","end":"2026-07-23T19:20:09.663821Z","steps":["trace[1811589812] 'process raft request' (duration: 372.985744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:09.663934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.318657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:09.663955Z","caller":"traceutil/trace.go:171","msg":"trace[1472403524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1869; }","duration":"269.390179ms","start":"2026-07-23T19:20:09.394558Z","end":"2026-07-23T19:20:09.663949Z","steps":["trace[1472403524] 'agreement among raft nodes before linearized reading' (duration: 269.315216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:09.663974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:09.29067Z","time spent":"373.240373ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:20:11.832661Z","caller":"traceutil/trace.go:171","msg":"trace[1113690310] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"119.555282ms","start":"2026-07-23T19:20:11.713086Z","end":"2026-07-23T19:20:11.832641Z","steps":["trace[1113690310] 'process raft request' (duration: 119.454388ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:11.832681Z","caller":"traceutil/trace.go:171","msg":"trace[594439976] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"119.437428ms","start":"2026-07-23T19:20:11.713213Z","end":"2026-07-23T19:20:11.83265Z","steps":["trace[594439976] 'read index received' (duration: 119.400867ms)","trace[594439976] 'applied index is now lower than readState.Index' (duration: 34.391µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:20:11.832973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.733788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:6 size:42719"} {"level":"info","ts":"2026-07-23T19:20:11.833045Z","caller":"traceutil/trace.go:171","msg":"trace[1058603690] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:6; response_revision:1877; }","duration":"119.844042ms","start":"2026-07-23T19:20:11.713185Z","end":"2026-07-23T19:20:11.833029Z","steps":["trace[1058603690] 'agreement among raft nodes before linearized reading' (duration: 119.557652ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:11.841651Z","caller":"traceutil/trace.go:171","msg":"trace[2079435374] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"128.220851ms","start":"2026-07-23T19:20:11.71341Z","end":"2026-07-23T19:20:11.841631Z","steps":["trace[2079435374] 'process raft request' (duration: 128.182389ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:11.841863Z","caller":"traceutil/trace.go:171","msg":"trace[188464109] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"128.613024ms","start":"2026-07-23T19:20:11.71323Z","end":"2026-07-23T19:20:11.841843Z","steps":["trace[188464109] 'process raft request' (duration: 128.260031ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:14.017115Z","caller":"traceutil/trace.go:171","msg":"trace[1372574099] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"105.808451ms","start":"2026-07-23T19:20:13.911284Z","end":"2026-07-23T19:20:14.017093Z","steps":["trace[1372574099] 'process raft request' (duration: 105.782651ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:14.017167Z","caller":"traceutil/trace.go:171","msg":"trace[1121936211] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"106.159864ms","start":"2026-07-23T19:20:13.910964Z","end":"2026-07-23T19:20:14.017124Z","steps":["trace[1121936211] 'process raft request' (duration: 106.011219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:15.651857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.401733ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-23T19:20:16.04667Z","caller":"traceutil/trace.go:171","msg":"trace[1746081333] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"132.333519ms","start":"2026-07-23T19:20:15.914315Z","end":"2026-07-23T19:20:16.046649Z","steps":["trace[1746081333] 'read index received' (duration: 132.138132ms)","trace[1746081333] 'applied index is now lower than readState.Index' (duration: 194.326µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:16.046738Z","caller":"traceutil/trace.go:171","msg":"trace[1207426064] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"312.222893ms","start":"2026-07-23T19:20:15.734473Z","end":"2026-07-23T19:20:16.046696Z","steps":["trace[1207426064] 'process raft request' (duration: 311.999635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:16.04688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:15.734443Z","time spent":"312.361428ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:20:16.046915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.579947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:20:16.046971Z","caller":"traceutil/trace.go:171","msg":"trace[2092312022] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:1897; }","duration":"132.66954ms","start":"2026-07-23T19:20:15.914288Z","end":"2026-07-23T19:20:16.046958Z","steps":["trace[2092312022] 'agreement among raft nodes before linearized reading' (duration: 132.483754ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:16.299465Z","caller":"traceutil/trace.go:171","msg":"trace[1947094840] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"248.969002ms","start":"2026-07-23T19:20:16.050466Z","end":"2026-07-23T19:20:16.299435Z","steps":["trace[1947094840] 'process raft request' (duration: 245.085203ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:16.299817Z","caller":"traceutil/trace.go:171","msg":"trace[316554092] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"248.943722ms","start":"2026-07-23T19:20:16.050855Z","end":"2026-07-23T19:20:16.299799Z","steps":["trace[316554092] 'process raft request' (duration: 248.355281ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:16.299928Z","caller":"traceutil/trace.go:171","msg":"trace[443361617] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1962; }","duration":"152.603607ms","start":"2026-07-23T19:20:16.147305Z","end":"2026-07-23T19:20:16.299909Z","steps":["trace[443361617] 'read index received' (duration: 148.204089ms)","trace[443361617] 'applied index is now lower than readState.Index' (duration: 4.398638ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:16.299983Z","caller":"traceutil/trace.go:171","msg":"trace[601572478] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"248.05686ms","start":"2026-07-23T19:20:16.051894Z","end":"2026-07-23T19:20:16.299951Z","steps":["trace[601572478] 'process raft request' (duration: 247.948916ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:16.30013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.737441ms","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-07-23T19:20:16.300163Z","caller":"traceutil/trace.go:171","msg":"trace[1930800733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1901; }","duration":"185.818034ms","start":"2026-07-23T19:20:16.114336Z","end":"2026-07-23T19:20:16.300154Z","steps":["trace[1930800733] 'agreement among raft nodes before linearized reading' (duration: 185.712551ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:16.501042Z","caller":"traceutil/trace.go:171","msg":"trace[199726931] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1966; }","duration":"103.510922ms","start":"2026-07-23T19:20:16.397506Z","end":"2026-07-23T19:20:16.501017Z","steps":["trace[199726931] 'read index received' (duration: 103.229222ms)","trace[199726931] 'applied index is now lower than readState.Index' (duration: 280.199µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:16.501077Z","caller":"traceutil/trace.go:171","msg":"trace[217728196] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"192.371428ms","start":"2026-07-23T19:20:16.308673Z","end":"2026-07-23T19:20:16.501045Z","steps":["trace[217728196] 'process raft request' (duration: 192.092329ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:16.50117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.654257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:16.501204Z","caller":"traceutil/trace.go:171","msg":"trace[301946204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1903; }","duration":"103.73449ms","start":"2026-07-23T19:20:16.397462Z","end":"2026-07-23T19:20:16.501197Z","steps":["trace[301946204] 'agreement among raft nodes before linearized reading' (duration: 103.658167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:16.936063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.695424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:16.936178Z","caller":"traceutil/trace.go:171","msg":"trace[763005687] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1904; }","duration":"132.885041ms","start":"2026-07-23T19:20:16.803268Z","end":"2026-07-23T19:20:16.936153Z","steps":["trace[763005687] 'count revisions from in-memory index tree' (duration: 132.597741ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:17.780141Z","caller":"traceutil/trace.go:171","msg":"trace[933707482] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"160.725963ms","start":"2026-07-23T19:20:17.619392Z","end":"2026-07-23T19:20:17.780118Z","steps":["trace[933707482] 'process raft request' (duration: 160.579728ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:18.019281Z","caller":"traceutil/trace.go:171","msg":"trace[944979746] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"215.219754ms","start":"2026-07-23T19:20:17.804035Z","end":"2026-07-23T19:20:18.019254Z","steps":["trace[944979746] 'process raft request' (duration: 143.989564ms)","trace[944979746] 'compare' (duration: 70.9698ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:18.231391Z","caller":"traceutil/trace.go:171","msg":"trace[2106939159] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"179.847574ms","start":"2026-07-23T19:20:18.051519Z","end":"2026-07-23T19:20:18.231367Z","steps":["trace[2106939159] 'process raft request' (duration: 179.675417ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:18.231602Z","caller":"traceutil/trace.go:171","msg":"trace[836819360] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"198.545254ms","start":"2026-07-23T19:20:18.033022Z","end":"2026-07-23T19:20:18.231568Z","steps":["trace[836819360] 'process raft request' (duration: 180.720825ms)","trace[836819360] 'compare' (duration: 17.090163ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:20:20.530668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.027511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:20:20.530751Z","caller":"traceutil/trace.go:171","msg":"trace[1478140414] linearizableReadLoop","detail":"{readStateIndex:1988; appliedIndex:1987; }","duration":"284.406321ms","start":"2026-07-23T19:20:20.246332Z","end":"2026-07-23T19:20:20.530738Z","steps":["trace[1478140414] 'read index received' (duration: 125.180653ms)","trace[1478140414] 'applied index is now lower than readState.Index' (duration: 159.224928ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:20.531001Z","caller":"traceutil/trace.go:171","msg":"trace[11989056] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"294.242023ms","start":"2026-07-23T19:20:20.236749Z","end":"2026-07-23T19:20:20.530991Z","steps":["trace[11989056] 'process raft request' (duration: 134.82218ms)","trace[11989056] 'compare' (duration: 158.910415ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:20:20.531216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.880058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-23T19:20:20.53125Z","caller":"traceutil/trace.go:171","msg":"trace[1828095019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1923; }","duration":"284.92261ms","start":"2026-07-23T19:20:20.246315Z","end":"2026-07-23T19:20:20.531238Z","steps":["trace[1828095019] 'agreement among raft nodes before linearized reading' (duration: 284.813125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:20.531452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.437172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:20:20.531487Z","caller":"traceutil/trace.go:171","msg":"trace[2098640944] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:1923; }","duration":"284.479883ms","start":"2026-07-23T19:20:20.246999Z","end":"2026-07-23T19:20:20.531479Z","steps":["trace[2098640944] 'agreement among raft nodes before linearized reading' (duration: 284.38222ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:20.53169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.866766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:20.531721Z","caller":"traceutil/trace.go:171","msg":"trace[649447960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1923; }","duration":"133.898847ms","start":"2026-07-23T19:20:20.397815Z","end":"2026-07-23T19:20:20.531713Z","steps":["trace[649447960] 'agreement among raft nodes before linearized reading' (duration: 133.850566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:20.531995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.655382ms","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-07-23T19:20:20.532031Z","caller":"traceutil/trace.go:171","msg":"trace[1347285451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1923; }","duration":"154.732756ms","start":"2026-07-23T19:20:20.37729Z","end":"2026-07-23T19:20:20.532023Z","steps":["trace[1347285451] 'agreement among raft nodes before linearized reading' (duration: 154.622242ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:20.532015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.576917ms","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-07-23T19:20:20.532081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.988305ms","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-07-23T19:20:20.532098Z","caller":"traceutil/trace.go:171","msg":"trace[1120128851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1923; }","duration":"155.68613ms","start":"2026-07-23T19:20:20.376382Z","end":"2026-07-23T19:20:20.532068Z","steps":["trace[1120128851] 'agreement among raft nodes before linearized reading' (duration: 155.444871ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:20.53212Z","caller":"traceutil/trace.go:171","msg":"trace[1126645496] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1923; }","duration":"155.037327ms","start":"2026-07-23T19:20:20.377072Z","end":"2026-07-23T19:20:20.53211Z","steps":["trace[1126645496] 'agreement among raft nodes before linearized reading' (duration: 154.932713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:20.532099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.302212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-23T19:20:20.532178Z","caller":"traceutil/trace.go:171","msg":"trace[1795076688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1923; }","duration":"134.419587ms","start":"2026-07-23T19:20:20.397738Z","end":"2026-07-23T19:20:20.532158Z","steps":["trace[1795076688] 'agreement among raft nodes before linearized reading' (duration: 134.185348ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:25.411892Z","caller":"traceutil/trace.go:171","msg":"trace[1383130598] linearizableReadLoop","detail":"{readStateIndex:2115; appliedIndex:2114; }","duration":"107.701175ms","start":"2026-07-23T19:20:25.304172Z","end":"2026-07-23T19:20:25.411873Z","steps":["trace[1383130598] 'read index received' (duration: 107.265749ms)","trace[1383130598] 'applied index is now lower than readState.Index' (duration: 434.486µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:25.411946Z","caller":"traceutil/trace.go:171","msg":"trace[1620951000] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"120.094892ms","start":"2026-07-23T19:20:25.291822Z","end":"2026-07-23T19:20:25.411917Z","steps":["trace[1620951000] 'process raft request' (duration: 119.759799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:25.412177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.986195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-coredns-7dd4958666-f9fdg\" ","response":"range_response_count:1 size:5313"} {"level":"info","ts":"2026-07-23T19:20:25.412235Z","caller":"traceutil/trace.go:171","msg":"trace[123644163] range","detail":"{range_begin:/registry/pods/openstack/neutron-coredns-7dd4958666-f9fdg; range_end:; response_count:1; response_revision:2050; }","duration":"108.093818ms","start":"2026-07-23T19:20:25.304128Z","end":"2026-07-23T19:20:25.412222Z","steps":["trace[123644163] 'agreement among raft nodes before linearized reading' (duration: 107.902652ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:26.846493Z","caller":"traceutil/trace.go:171","msg":"trace[2007691583] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2153; }","duration":"129.384211ms","start":"2026-07-23T19:20:26.717086Z","end":"2026-07-23T19:20:26.84647Z","steps":["trace[2007691583] 'read index received' (duration: 129.302308ms)","trace[2007691583] 'applied index is now lower than readState.Index' (duration: 80.433µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:26.846641Z","caller":"traceutil/trace.go:171","msg":"trace[1042930652] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"233.499249ms","start":"2026-07-23T19:20:26.613105Z","end":"2026-07-23T19:20:26.846605Z","steps":["trace[1042930652] 'process raft request' (duration: 233.223879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:26.846804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.680021ms","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-07-23T19:20:26.846883Z","caller":"traceutil/trace.go:171","msg":"trace[50365280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2088; }","duration":"129.824037ms","start":"2026-07-23T19:20:26.717044Z","end":"2026-07-23T19:20:26.846868Z","steps":["trace[50365280] 'agreement among raft nodes before linearized reading' (duration: 129.601048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:26.896889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.702712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:20:26.896939Z","caller":"traceutil/trace.go:171","msg":"trace[1237216321] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:2090; }","duration":"147.778105ms","start":"2026-07-23T19:20:26.749148Z","end":"2026-07-23T19:20:26.896926Z","steps":["trace[1237216321] 'agreement among raft nodes before linearized reading' (duration: 147.64663ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:26.896962Z","caller":"traceutil/trace.go:171","msg":"trace[228283019] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"109.010386ms","start":"2026-07-23T19:20:26.787916Z","end":"2026-07-23T19:20:26.896926Z","steps":["trace[228283019] 'process raft request' (duration: 108.752587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:26.897047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.088368ms","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-07-23T19:20:26.897071Z","caller":"traceutil/trace.go:171","msg":"trace[1314065101] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2090; }","duration":"150.13563ms","start":"2026-07-23T19:20:26.746929Z","end":"2026-07-23T19:20:26.897064Z","steps":["trace[1314065101] 'agreement among raft nodes before linearized reading' (duration: 150.052117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:26.89716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.993368ms","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-07-23T19:20:26.897192Z","caller":"traceutil/trace.go:171","msg":"trace[328971102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2090; }","duration":"149.05092ms","start":"2026-07-23T19:20:26.748131Z","end":"2026-07-23T19:20:26.897182Z","steps":["trace[328971102] 'agreement among raft nodes before linearized reading' (duration: 148.983217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:26.8973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.807178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-23T19:20:26.897335Z","caller":"traceutil/trace.go:171","msg":"trace[132717852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2090; }","duration":"162.890282ms","start":"2026-07-23T19:20:26.734434Z","end":"2026-07-23T19:20:26.897324Z","steps":["trace[132717852] 'agreement among raft nodes before linearized reading' (duration: 162.727065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:26.89741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.734117ms","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-07-23T19:20:26.897664Z","caller":"traceutil/trace.go:171","msg":"trace[1063482135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2090; }","duration":"155.148531ms","start":"2026-07-23T19:20:26.742492Z","end":"2026-07-23T19:20:26.897641Z","steps":["trace[1063482135] 'agreement among raft nodes before linearized reading' (duration: 154.637052ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:33.085941Z","caller":"traceutil/trace.go:171","msg":"trace[106296752] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2229; }","duration":"136.169983ms","start":"2026-07-23T19:20:32.949742Z","end":"2026-07-23T19:20:33.085912Z","steps":["trace[106296752] 'read index received' (duration: 135.945735ms)","trace[106296752] 'applied index is now lower than readState.Index' (duration: 223.308µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:33.086041Z","caller":"traceutil/trace.go:171","msg":"trace[1936583949] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"216.123974ms","start":"2026-07-23T19:20:32.869847Z","end":"2026-07-23T19:20:33.08597Z","steps":["trace[1936583949] 'process raft request' (duration: 215.912526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.086197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.436932ms","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-07-23T19:20:33.08624Z","caller":"traceutil/trace.go:171","msg":"trace[931129768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2162; }","duration":"136.534937ms","start":"2026-07-23T19:20:32.949693Z","end":"2026-07-23T19:20:33.086228Z","steps":["trace[931129768] 'agreement among raft nodes before linearized reading' (duration: 136.359179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.086422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.175855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-23T19:20:33.086405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.376281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-23T19:20:33.08641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.783984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:20:33.086451Z","caller":"traceutil/trace.go:171","msg":"trace[1330060359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2162; }","duration":"130.214807ms","start":"2026-07-23T19:20:32.956225Z","end":"2026-07-23T19:20:33.08644Z","steps":["trace[1330060359] 'agreement among raft nodes before linearized reading' (duration: 130.140764ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.086423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.430945ms","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-07-23T19:20:33.08648Z","caller":"traceutil/trace.go:171","msg":"trace[221712600] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2162; }","duration":"125.516286ms","start":"2026-07-23T19:20:32.960945Z","end":"2026-07-23T19:20:33.086461Z","steps":["trace[221712600] 'agreement among raft nodes before linearized reading' (duration: 125.335749ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:33.086491Z","caller":"traceutil/trace.go:171","msg":"trace[1870546488] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:2162; }","duration":"112.899798ms","start":"2026-07-23T19:20:32.973573Z","end":"2026-07-23T19:20:33.086473Z","steps":["trace[1870546488] 'agreement among raft nodes before linearized reading' (duration: 112.681011ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:33.086535Z","caller":"traceutil/trace.go:171","msg":"trace[512884773] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2162; }","duration":"130.604651ms","start":"2026-07-23T19:20:32.955907Z","end":"2026-07-23T19:20:33.086511Z","steps":["trace[512884773] 'agreement among raft nodes before linearized reading' (duration: 130.281979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.086709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.514686ms","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-07-23T19:20:33.086744Z","caller":"traceutil/trace.go:171","msg":"trace[1436265039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2162; }","duration":"125.570108ms","start":"2026-07-23T19:20:32.961164Z","end":"2026-07-23T19:20:33.086734Z","steps":["trace[1436265039] 'agreement among raft nodes before linearized reading' (duration: 125.027349ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.471789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.398017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:20:33.472012Z","caller":"traceutil/trace.go:171","msg":"trace[2047438051] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2230; }","duration":"381.372818ms","start":"2026-07-23T19:20:33.090626Z","end":"2026-07-23T19:20:33.471999Z","steps":["trace[2047438051] 'read index received' (duration: 96.68319ms)","trace[2047438051] 'applied index is now lower than readState.Index' (duration: 284.688938ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:33.472077Z","caller":"traceutil/trace.go:171","msg":"trace[1258700751] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"381.660028ms","start":"2026-07-23T19:20:33.09041Z","end":"2026-07-23T19:20:33.47207Z","steps":["trace[1258700751] 'process raft request' (duration: 381.531514ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.472114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.090405Z","time spent":"381.689269ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:20:33.472071Z","caller":"traceutil/trace.go:171","msg":"trace[1774710628] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"381.71018ms","start":"2026-07-23T19:20:33.090331Z","end":"2026-07-23T19:20:33.472042Z","steps":["trace[1774710628] 'process raft request' (duration: 381.544745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.47232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.090311Z","time spent":"381.855315ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:20:33.472431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.384761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:33.472459Z","caller":"traceutil/trace.go:171","msg":"trace[95777605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2167; }","duration":"375.428272ms","start":"2026-07-23T19:20:33.097021Z","end":"2026-07-23T19:20:33.472449Z","steps":["trace[95777605] 'agreement among raft nodes before linearized reading' (duration: 375.37908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.472479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.097013Z","time spent":"375.461673ms","remote":"127.0.0.1:37638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-23T19:20:33.472551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.910447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:6 size:42530"} {"level":"info","ts":"2026-07-23T19:20:33.472543Z","caller":"traceutil/trace.go:171","msg":"trace[1008483082] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"382.322012ms","start":"2026-07-23T19:20:33.090205Z","end":"2026-07-23T19:20:33.472527Z","steps":["trace[1008483082] 'process raft request' (duration: 97.105426ms)","trace[1008483082] 'compare' (duration: 284.246441ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:33.472603Z","caller":"traceutil/trace.go:171","msg":"trace[2111672974] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:6; response_revision:2167; }","duration":"381.96978ms","start":"2026-07-23T19:20:33.090621Z","end":"2026-07-23T19:20:33.47259Z","steps":["trace[2111672974] 'agreement among raft nodes before linearized reading' (duration: 381.802513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.472632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.090599Z","time spent":"382.027462ms","remote":"127.0.0.1:40876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":6,"response size":42553,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-07-23T19:20:33.472678Z","caller":"traceutil/trace.go:171","msg":"trace[147650155] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"380.633661ms","start":"2026-07-23T19:20:33.092026Z","end":"2026-07-23T19:20:33.47266Z","steps":["trace[147650155] 'process raft request' (duration: 379.950936ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.472754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.092005Z","time spent":"380.699894ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:20:33.472764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.090167Z","time spent":"382.436457ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:20:33.472275Z","caller":"traceutil/trace.go:171","msg":"trace[1827893740] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"381.4307ms","start":"2026-07-23T19:20:33.090837Z","end":"2026-07-23T19:20:33.472267Z","steps":["trace[1827893740] 'process raft request' (duration: 381.12456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:33.4729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:20:33.09083Z","time spent":"382.050013ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:20:50.030859Z","caller":"traceutil/trace.go:171","msg":"trace[540722332] linearizableReadLoop","detail":"{readStateIndex:2362; appliedIndex:2360; }","duration":"112.679328ms","start":"2026-07-23T19:20:49.918163Z","end":"2026-07-23T19:20:50.030842Z","steps":["trace[540722332] 'read index received' (duration: 24.463158ms)","trace[540722332] 'applied index is now lower than readState.Index' (duration: 88.21564ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:20:50.030892Z","caller":"traceutil/trace.go:171","msg":"trace[1301401605] transaction","detail":"{read_only:false; response_revision:2290; number_of_response:1; }","duration":"111.37293ms","start":"2026-07-23T19:20:49.919496Z","end":"2026-07-23T19:20:50.030869Z","steps":["trace[1301401605] 'process raft request' (duration: 111.245675ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:50.031077Z","caller":"traceutil/trace.go:171","msg":"trace[2125632214] transaction","detail":"{read_only:false; response_revision:2289; number_of_response:1; }","duration":"115.911127ms","start":"2026-07-23T19:20:49.915149Z","end":"2026-07-23T19:20:50.031061Z","steps":["trace[2125632214] 'process raft request' (duration: 55.358914ms)","trace[2125632214] 'compare' (duration: 60.019934ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:20:50.031128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.954187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/exchanges.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:50.032492Z","caller":"traceutil/trace.go:171","msg":"trace[915654324] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/exchanges.rabbitmq.com; range_end:; response_count:0; response_revision:2291; }","duration":"114.344558ms","start":"2026-07-23T19:20:49.918127Z","end":"2026-07-23T19:20:50.032471Z","steps":["trace[915654324] 'agreement among raft nodes before linearized reading' (duration: 112.955837ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:50.06185Z","caller":"traceutil/trace.go:171","msg":"trace[1259014121] transaction","detail":"{read_only:false; response_revision:2292; number_of_response:1; }","duration":"113.855802ms","start":"2026-07-23T19:20:49.947955Z","end":"2026-07-23T19:20:50.061811Z","steps":["trace[1259014121] 'process raft request' (duration: 113.682806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:20:50.061884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.183628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:20:50.061976Z","caller":"traceutil/trace.go:171","msg":"trace[2083979520] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2292; }","duration":"134.327753ms","start":"2026-07-23T19:20:49.927632Z","end":"2026-07-23T19:20:50.06196Z","steps":["trace[2083979520] 'agreement among raft nodes before linearized reading' (duration: 134.178628ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:20:58.553241Z","caller":"traceutil/trace.go:171","msg":"trace[2067397569] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"161.462354ms","start":"2026-07-23T19:20:58.39176Z","end":"2026-07-23T19:20:58.553223Z","steps":["trace[2067397569] 'process raft request' (duration: 161.33891ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:01.357128Z","caller":"traceutil/trace.go:171","msg":"trace[338250125] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"294.328488ms","start":"2026-07-23T19:21:01.062767Z","end":"2026-07-23T19:21:01.357095Z","steps":["trace[338250125] 'process raft request' (duration: 294.13232ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:01.357921Z","caller":"traceutil/trace.go:171","msg":"trace[351788718] linearizableReadLoop","detail":"{readStateIndex:2632; appliedIndex:2632; }","duration":"193.940632ms","start":"2026-07-23T19:21:01.163953Z","end":"2026-07-23T19:21:01.357894Z","steps":["trace[351788718] 'read index received' (duration: 193.931471ms)","trace[351788718] 'applied index is now lower than readState.Index' (duration: 7.56µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:01.358075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.100808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-vnc-ca\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.358142Z","caller":"traceutil/trace.go:171","msg":"trace[1652872950] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-vnc-ca; range_end:; response_count:0; response_revision:2532; }","duration":"194.206552ms","start":"2026-07-23T19:21:01.16392Z","end":"2026-07-23T19:21:01.358126Z","steps":["trace[1652872950] 'agreement among raft nodes before linearized reading' (duration: 194.071697ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:01.544106Z","caller":"traceutil/trace.go:171","msg":"trace[1311335619] linearizableReadLoop","detail":"{readStateIndex:2635; appliedIndex:2632; }","duration":"146.257914ms","start":"2026-07-23T19:21:01.397813Z","end":"2026-07-23T19:21:01.544071Z","steps":["trace[1311335619] 'read index received' (duration: 2.437622ms)","trace[1311335619] 'applied index is now lower than readState.Index' (duration: 143.818782ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:01.544286Z","caller":"traceutil/trace.go:171","msg":"trace[1991210427] transaction","detail":"{read_only:false; response_revision:2535; number_of_response:1; }","duration":"177.182683ms","start":"2026-07-23T19:21:01.367055Z","end":"2026-07-23T19:21:01.544237Z","steps":["trace[1991210427] 'process raft request' (duration: 176.941435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.544371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.519264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.544421Z","caller":"traceutil/trace.go:171","msg":"trace[2006785129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2535; }","duration":"146.627798ms","start":"2026-07-23T19:21:01.39778Z","end":"2026-07-23T19:21:01.544407Z","steps":["trace[2006785129] 'agreement among raft nodes before linearized reading' (duration: 146.491753ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:01.544418Z","caller":"traceutil/trace.go:171","msg":"trace[1139545477] transaction","detail":"{read_only:false; response_revision:2534; number_of_response:1; }","duration":"180.317062ms","start":"2026-07-23T19:21:01.364053Z","end":"2026-07-23T19:21:01.54437Z","steps":["trace[1139545477] 'process raft request' (duration: 179.74137ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:01.82713Z","caller":"traceutil/trace.go:171","msg":"trace[1531873861] linearizableReadLoop","detail":"{readStateIndex:2638; appliedIndex:2635; }","duration":"249.324242ms","start":"2026-07-23T19:21:01.577779Z","end":"2026-07-23T19:21:01.827103Z","steps":["trace[1531873861] 'read index received' (duration: 4.578314ms)","trace[1531873861] 'applied index is now lower than readState.Index' (duration: 244.744448ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:01.82766Z","caller":"traceutil/trace.go:171","msg":"trace[1444206126] transaction","detail":"{read_only:false; response_revision:2537; number_of_response:1; }","duration":"275.792241ms","start":"2026-07-23T19:21:01.55185Z","end":"2026-07-23T19:21:01.827642Z","steps":["trace[1444206126] 'process raft request' (duration: 275.018052ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:01.828075Z","caller":"traceutil/trace.go:171","msg":"trace[607197168] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2537; }","duration":"273.529844ms","start":"2026-07-23T19:21:01.554527Z","end":"2026-07-23T19:21:01.828057Z","steps":["trace[607197168] 'process raft request' (duration: 272.530867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.828419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.603782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T19:21:01.828467Z","caller":"traceutil/trace.go:171","msg":"trace[1524699417] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2537; }","duration":"250.726566ms","start":"2026-07-23T19:21:01.577729Z","end":"2026-07-23T19:21:01.828456Z","steps":["trace[1524699417] 'agreement among raft nodes before linearized reading' (duration: 250.585111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.829971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.918308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/\" range_end:\"/registry/events/openstack0\" limit:500 ","response":"range_response_count:85 size:66679"} {"level":"info","ts":"2026-07-23T19:21:01.830073Z","caller":"traceutil/trace.go:171","msg":"trace[1244814323] range","detail":"{range_begin:/registry/events/openstack/; range_end:/registry/events/openstack0; response_count:85; response_revision:2537; }","duration":"238.019152ms","start":"2026-07-23T19:21:01.591987Z","end":"2026-07-23T19:21:01.830006Z","steps":["trace[1244814323] 'agreement among raft nodes before linearized reading' (duration: 237.307095ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.831477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.544601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.831523Z","caller":"traceutil/trace.go:171","msg":"trace[472567598] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2537; }","duration":"159.637924ms","start":"2026-07-23T19:21:01.671874Z","end":"2026-07-23T19:21:01.831512Z","steps":["trace[472567598] 'agreement among raft nodes before linearized reading' (duration: 159.570772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.831582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.590753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.831658Z","caller":"traceutil/trace.go:171","msg":"trace[551591321] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2537; }","duration":"159.701868ms","start":"2026-07-23T19:21:01.671937Z","end":"2026-07-23T19:21:01.831639Z","steps":["trace[551591321] 'agreement among raft nodes before linearized reading' (duration: 159.5137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.8317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.66466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.831774Z","caller":"traceutil/trace.go:171","msg":"trace[1819943659] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2537; }","duration":"104.793304ms","start":"2026-07-23T19:21:01.726963Z","end":"2026-07-23T19:21:01.831756Z","steps":["trace[1819943659] 'agreement among raft nodes before linearized reading' (duration: 104.576535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.831896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.410908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.83193Z","caller":"traceutil/trace.go:171","msg":"trace[1941372998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2537; }","duration":"105.520592ms","start":"2026-07-23T19:21:01.726402Z","end":"2026-07-23T19:21:01.831922Z","steps":["trace[1941372998] 'agreement among raft nodes before linearized reading' (duration: 105.47149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.832024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.368945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.832056Z","caller":"traceutil/trace.go:171","msg":"trace[1561124178] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2537; }","duration":"132.408807ms","start":"2026-07-23T19:21:01.699638Z","end":"2026-07-23T19:21:01.832047Z","steps":["trace[1561124178] 'agreement among raft nodes before linearized reading' (duration: 132.347705ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.832215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.809382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:01.832241Z","caller":"traceutil/trace.go:171","msg":"trace[53718599] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2537; }","duration":"132.876304ms","start":"2026-07-23T19:21:01.699355Z","end":"2026-07-23T19:21:01.832232Z","steps":["trace[53718599] 'agreement among raft nodes before linearized reading' (duration: 132.836852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.833206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.77689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:21:01.833239Z","caller":"traceutil/trace.go:171","msg":"trace[311873345] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:2537; }","duration":"143.822862ms","start":"2026-07-23T19:21:01.689409Z","end":"2026-07-23T19:21:01.833232Z","steps":["trace[311873345] 'agreement among raft nodes before linearized reading' (duration: 143.638656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:01.833402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.091982ms","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-07-23T19:21:01.833432Z","caller":"traceutil/trace.go:171","msg":"trace[285545741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2537; }","duration":"144.161224ms","start":"2026-07-23T19:21:01.689264Z","end":"2026-07-23T19:21:01.833426Z","steps":["trace[285545741] 'agreement among raft nodes before linearized reading' (duration: 144.081252ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:02.850596Z","caller":"traceutil/trace.go:171","msg":"trace[1443796299] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"127.168948ms","start":"2026-07-23T19:21:02.723403Z","end":"2026-07-23T19:21:02.850572Z","steps":["trace[1443796299] 'process raft request' (duration: 127.068854ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:02.851169Z","caller":"traceutil/trace.go:171","msg":"trace[1327739825] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"129.646501ms","start":"2026-07-23T19:21:02.72147Z","end":"2026-07-23T19:21:02.851116Z","steps":["trace[1327739825] 'process raft request' (duration: 54.808398ms)","trace[1327739825] 'compare' (duration: 71.597279ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:05.522263Z","caller":"traceutil/trace.go:171","msg":"trace[1645171276] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"113.585983ms","start":"2026-07-23T19:21:05.408647Z","end":"2026-07-23T19:21:05.522233Z","steps":["trace[1645171276] 'process raft request' (duration: 19.321138ms)","trace[1645171276] 'compare' (duration: 94.124377ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:05.68114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.87813ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-23T19:21:06.046887Z","caller":"traceutil/trace.go:171","msg":"trace[187379050] linearizableReadLoop","detail":"{readStateIndex:2730; appliedIndex:2729; }","duration":"190.404881ms","start":"2026-07-23T19:21:05.856459Z","end":"2026-07-23T19:21:06.046864Z","steps":["trace[187379050] 'read index received' (duration: 190.346415ms)","trace[187379050] 'applied index is now lower than readState.Index' (duration: 54.535µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:06.046977Z","caller":"traceutil/trace.go:171","msg":"trace[1672351282] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2622; }","duration":"312.430084ms","start":"2026-07-23T19:21:05.734499Z","end":"2026-07-23T19:21:06.046929Z","steps":["trace[1672351282] 'process raft request' (duration: 312.273289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:06.047096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.611972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bxvg7\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-07-23T19:21:06.04713Z","caller":"traceutil/trace.go:171","msg":"trace[1791813504] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bxvg7; range_end:; response_count:1; response_revision:2622; }","duration":"190.68698ms","start":"2026-07-23T19:21:05.856435Z","end":"2026-07-23T19:21:06.047122Z","steps":["trace[1791813504] 'agreement among raft nodes before linearized reading' (duration: 190.533674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:06.047169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:05.734481Z","time spent":"312.596905ms","remote":"127.0.0.1:40806","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T19:21:06.086231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.366674ms","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-07-23T19:21:06.086339Z","caller":"traceutil/trace.go:171","msg":"trace[148773412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2623; }","duration":"211.485206ms","start":"2026-07-23T19:21:05.874808Z","end":"2026-07-23T19:21:06.086293Z","steps":["trace[148773412] 'agreement among raft nodes before linearized reading' (duration: 211.318399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:06.086348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.723262ms","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-07-23T19:21:06.086418Z","caller":"traceutil/trace.go:171","msg":"trace[360768108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2623; }","duration":"229.825852ms","start":"2026-07-23T19:21:05.856576Z","end":"2026-07-23T19:21:06.086402Z","steps":["trace[360768108] 'agreement among raft nodes before linearized reading' (duration: 229.593779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:06.086657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.96399ms","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-07-23T19:21:06.086697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.088609ms","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-07-23T19:21:06.0867Z","caller":"traceutil/trace.go:171","msg":"trace[992064082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2623; }","duration":"221.015026ms","start":"2026-07-23T19:21:05.865673Z","end":"2026-07-23T19:21:06.086688Z","steps":["trace[992064082] 'agreement among raft nodes before linearized reading' (duration: 220.908624ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.086724Z","caller":"traceutil/trace.go:171","msg":"trace[1808253558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2623; }","duration":"230.123513ms","start":"2026-07-23T19:21:05.856595Z","end":"2026-07-23T19:21:06.086718Z","steps":["trace[1808253558] 'agreement among raft nodes before linearized reading' (duration: 230.052285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:06.086928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.236433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-23T19:21:06.087032Z","caller":"traceutil/trace.go:171","msg":"trace[1832314165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2623; }","duration":"218.387459ms","start":"2026-07-23T19:21:05.86862Z","end":"2026-07-23T19:21:06.087007Z","steps":["trace[1832314165] 'agreement among raft nodes before linearized reading' (duration: 218.073897ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.332066Z","caller":"traceutil/trace.go:171","msg":"trace[1321189219] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"240.066184ms","start":"2026-07-23T19:21:06.091984Z","end":"2026-07-23T19:21:06.33205Z","steps":["trace[1321189219] 'process raft request' (duration: 240.011729ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.332241Z","caller":"traceutil/trace.go:171","msg":"trace[337006248] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"240.360164ms","start":"2026-07-23T19:21:06.091875Z","end":"2026-07-23T19:21:06.332235Z","steps":["trace[337006248] 'process raft request' (duration: 143.729223ms)","trace[337006248] 'compare' (duration: 96.170354ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:06.332263Z","caller":"traceutil/trace.go:171","msg":"trace[490047905] transaction","detail":"{read_only:false; response_revision:2627; number_of_response:1; }","duration":"238.996965ms","start":"2026-07-23T19:21:06.093249Z","end":"2026-07-23T19:21:06.332246Z","steps":["trace[490047905] 'process raft request' (duration: 238.777713ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.33244Z","caller":"traceutil/trace.go:171","msg":"trace[1828540570] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"238.195584ms","start":"2026-07-23T19:21:06.094237Z","end":"2026-07-23T19:21:06.332433Z","steps":["trace[1828540570] 'process raft request' (duration: 237.956299ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.519894Z","caller":"traceutil/trace.go:171","msg":"trace[1232194804] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"161.956437ms","start":"2026-07-23T19:21:06.357913Z","end":"2026-07-23T19:21:06.51987Z","steps":["trace[1232194804] 'process raft request' (duration: 161.898112ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.520282Z","caller":"traceutil/trace.go:171","msg":"trace[106326733] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"422.35965ms","start":"2026-07-23T19:21:06.097905Z","end":"2026-07-23T19:21:06.520264Z","steps":["trace[106326733] 'process raft request' (duration: 380.916954ms)","trace[106326733] 'compare' (duration: 40.759456ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:06.520377Z","caller":"traceutil/trace.go:171","msg":"trace[453026183] linearizableReadLoop","detail":"{readStateIndex:2738; appliedIndex:2736; }","duration":"271.321715ms","start":"2026-07-23T19:21:06.249042Z","end":"2026-07-23T19:21:06.520363Z","steps":["trace[453026183] 'read index received' (duration: 229.762897ms)","trace[453026183] 'applied index is now lower than readState.Index' (duration: 41.556738ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:06.521214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:06.097882Z","time spent":"423.245129ms","remote":"127.0.0.1:40780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":841,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T19:21:06.520474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.413344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T19:21:06.521389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.481992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:06.521445Z","caller":"traceutil/trace.go:171","msg":"trace[373877472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2631; }","duration":"123.575381ms","start":"2026-07-23T19:21:06.39785Z","end":"2026-07-23T19:21:06.521426Z","steps":["trace[373877472] 'agreement among raft nodes before linearized reading' (duration: 123.412175ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.521451Z","caller":"traceutil/trace.go:171","msg":"trace[2136186873] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:0; response_revision:2631; }","duration":"272.398813ms","start":"2026-07-23T19:21:06.249007Z","end":"2026-07-23T19:21:06.521406Z","steps":["trace[2136186873] 'agreement among raft nodes before linearized reading' (duration: 271.394692ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:06.520658Z","caller":"traceutil/trace.go:171","msg":"trace[1141390539] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"414.298409ms","start":"2026-07-23T19:21:06.106335Z","end":"2026-07-23T19:21:06.520633Z","steps":["trace[1141390539] 'process raft request' (duration: 413.411409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:06.52173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:06.106327Z","time spent":"415.371119ms","remote":"127.0.0.1:40792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30643,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T19:21:16.308031Z","caller":"traceutil/trace.go:171","msg":"trace[2078945424] linearizableReadLoop","detail":"{readStateIndex:2821; appliedIndex:2820; }","duration":"106.931152ms","start":"2026-07-23T19:21:16.201069Z","end":"2026-07-23T19:21:16.308Z","steps":["trace[2078945424] 'read index received' (duration: 87.681526ms)","trace[2078945424] 'applied index is now lower than readState.Index' (duration: 19.248296ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:16.30808Z","caller":"traceutil/trace.go:171","msg":"trace[1143738571] transaction","detail":"{read_only:false; response_revision:2711; number_of_response:1; }","duration":"108.820751ms","start":"2026-07-23T19:21:16.199236Z","end":"2026-07-23T19:21:16.308057Z","steps":["trace[1143738571] 'process raft request' (duration: 89.610146ms)","trace[1143738571] 'compare' (duration: 18.984308ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:16.308389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.292294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:10 size:79213"} {"level":"info","ts":"2026-07-23T19:21:16.308438Z","caller":"traceutil/trace.go:171","msg":"trace[1880085800] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:10; response_revision:2711; }","duration":"107.378617ms","start":"2026-07-23T19:21:16.201043Z","end":"2026-07-23T19:21:16.308421Z","steps":["trace[1880085800] 'agreement among raft nodes before linearized reading' (duration: 107.076877ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:16.571363Z","caller":"traceutil/trace.go:171","msg":"trace[502746203] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"193.34478ms","start":"2026-07-23T19:21:16.377983Z","end":"2026-07-23T19:21:16.571328Z","steps":["trace[502746203] 'process raft request' (duration: 99.231865ms)","trace[502746203] 'compare' (duration: 93.967931ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:16.864755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.763022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T19:21:16.865029Z","caller":"traceutil/trace.go:171","msg":"trace[190601264] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"252.382059ms","start":"2026-07-23T19:21:16.612628Z","end":"2026-07-23T19:21:16.86501Z","steps":["trace[190601264] 'process raft request' (duration: 252.346718ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:16.865169Z","caller":"traceutil/trace.go:171","msg":"trace[2080475415] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"484.662605ms","start":"2026-07-23T19:21:16.380475Z","end":"2026-07-23T19:21:16.865137Z","steps":["trace[2080475415] 'process raft request' (duration: 484.382597ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:16.865218Z","caller":"traceutil/trace.go:171","msg":"trace[1849223805] linearizableReadLoop","detail":"{readStateIndex:2824; appliedIndex:2821; }","duration":"483.948524ms","start":"2026-07-23T19:21:16.381241Z","end":"2026-07-23T19:21:16.86519Z","steps":["trace[1849223805] 'read index received' (duration: 95.969904ms)","trace[1849223805] 'applied index is now lower than readState.Index' (duration: 387.97603ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:16.86524Z","caller":"traceutil/trace.go:171","msg":"trace[51382736] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"261.699367ms","start":"2026-07-23T19:21:16.603516Z","end":"2026-07-23T19:21:16.865215Z","steps":["trace[51382736] 'process raft request' (duration: 261.415409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:16.865333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:16.380466Z","time spent":"484.773088ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:21:16.865451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.92865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:16.865479Z","caller":"traceutil/trace.go:171","msg":"trace[831084493] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"487.168004ms","start":"2026-07-23T19:21:16.378294Z","end":"2026-07-23T19:21:16.865462Z","steps":["trace[831084493] 'process raft request' (duration: 302.614826ms)","trace[831084493] 'compare' (duration: 183.516745ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:16.865487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.201282ms","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-07-23T19:21:16.865504Z","caller":"traceutil/trace.go:171","msg":"trace[1144663384] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2716; }","duration":"398.019841ms","start":"2026-07-23T19:21:16.467468Z","end":"2026-07-23T19:21:16.865487Z","steps":["trace[1144663384] 'agreement among raft nodes before linearized reading' (duration: 397.925378ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:16.865523Z","caller":"traceutil/trace.go:171","msg":"trace[1995281025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2716; }","duration":"484.292504ms","start":"2026-07-23T19:21:16.381221Z","end":"2026-07-23T19:21:16.865514Z","steps":["trace[1995281025] 'agreement among raft nodes before linearized reading' (duration: 484.101698ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:16.865542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:16.378284Z","time spent":"487.226525ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T19:21:16.865549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:16.46745Z","time spent":"398.085234ms","remote":"127.0.0.1:37698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-07-23T19:21:16.865569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:16.381214Z","time spent":"484.341675ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-23T19:21:18.059142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.086611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:18.059249Z","caller":"traceutil/trace.go:171","msg":"trace[2084974189] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:2718; }","duration":"365.211425ms","start":"2026-07-23T19:21:17.694012Z","end":"2026-07-23T19:21:18.059224Z","steps":["trace[2084974189] 'count revisions from in-memory index tree' (duration: 364.636307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:18.059314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:17.693988Z","time spent":"365.304168ms","remote":"127.0.0.1:44534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "} {"level":"info","ts":"2026-07-23T19:21:18.113679Z","caller":"traceutil/trace.go:171","msg":"trace[8436243] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"309.193248ms","start":"2026-07-23T19:21:17.804463Z","end":"2026-07-23T19:21:18.113656Z","steps":["trace[8436243] 'process raft request' (duration: 309.043804ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:18.113895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T19:21:17.804433Z","time spent":"309.328053ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T19:21:18.600883Z","caller":"traceutil/trace.go:171","msg":"trace[879654132] linearizableReadLoop","detail":"{readStateIndex:2831; appliedIndex:2830; }","duration":"198.639044ms","start":"2026-07-23T19:21:18.402218Z","end":"2026-07-23T19:21:18.600857Z","steps":["trace[879654132] 'read index received' (duration: 198.396336ms)","trace[879654132] 'applied index is now lower than readState.Index' (duration: 241.648µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T19:21:18.600976Z","caller":"traceutil/trace.go:171","msg":"trace[1642872040] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"201.553853ms","start":"2026-07-23T19:21:18.399397Z","end":"2026-07-23T19:21:18.600951Z","steps":["trace[1642872040] 'process raft request' (duration: 201.289816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:18.601333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.102268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:18.601534Z","caller":"traceutil/trace.go:171","msg":"trace[2068423590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2721; }","duration":"199.360906ms","start":"2026-07-23T19:21:18.402159Z","end":"2026-07-23T19:21:18.60152Z","steps":["trace[2068423590] 'agreement among raft nodes before linearized reading' (duration: 198.82647ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:50.337153Z","caller":"traceutil/trace.go:171","msg":"trace[747376052] linearizableReadLoop","detail":"{readStateIndex:3013; appliedIndex:3013; }","duration":"127.48718ms","start":"2026-07-23T19:21:50.209641Z","end":"2026-07-23T19:21:50.337129Z","steps":["trace[747376052] 'read index received' (duration: 127.283123ms)","trace[747376052] 'applied index is now lower than readState.Index' (duration: 202.257µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T19:21:50.337724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.061248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/cert-manager/\" range_end:\"/registry/events/cert-manager0\" limit:500 ","response":"range_response_count:41 size:32947"} {"level":"info","ts":"2026-07-23T19:21:50.337787Z","caller":"traceutil/trace.go:171","msg":"trace[607811443] range","detail":"{range_begin:/registry/events/cert-manager/; range_end:/registry/events/cert-manager0; response_count:41; response_revision:2896; }","duration":"128.167921ms","start":"2026-07-23T19:21:50.209606Z","end":"2026-07-23T19:21:50.337773Z","steps":["trace[607811443] 'agreement among raft nodes before linearized reading' (duration: 127.609724ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T19:21:50.361627Z","caller":"traceutil/trace.go:171","msg":"trace[900375517] transaction","detail":"{read_only:false; response_revision:2897; number_of_response:1; }","duration":"100.423212ms","start":"2026-07-23T19:21:50.261184Z","end":"2026-07-23T19:21:50.361607Z","steps":["trace[900375517] 'process raft request' (duration: 100.268466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:50.361804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.376451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/cert-manager/\" range_end:\"/registry/jobs/cert-manager0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:50.361846Z","caller":"traceutil/trace.go:171","msg":"trace[767073211] range","detail":"{range_begin:/registry/jobs/cert-manager/; range_end:/registry/jobs/cert-manager0; response_count:0; response_revision:2898; }","duration":"101.460983ms","start":"2026-07-23T19:21:50.260372Z","end":"2026-07-23T19:21:50.361833Z","steps":["trace[767073211] 'agreement among raft nodes before linearized reading' (duration: 101.386011ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:50.361853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.582656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/default/\" range_end:\"/registry/jobs/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T19:21:50.361899Z","caller":"traceutil/trace.go:171","msg":"trace[2163014] range","detail":"{range_begin:/registry/jobs/default/; range_end:/registry/jobs/default0; response_count:0; response_revision:2898; }","duration":"141.682669ms","start":"2026-07-23T19:21:50.220207Z","end":"2026-07-23T19:21:50.36189Z","steps":["trace[2163014] 'agreement among raft nodes before linearized reading' (duration: 141.577256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T19:21:50.362039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.153434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/\" range_end:\"/registry/replicasets/cert-manager0\" limit:500 ","response":"range_response_count:3 size:13460"} {"level":"info","ts":"2026-07-23T19:21:50.362106Z","caller":"traceutil/trace.go:171","msg":"trace[1846435185] range","detail":"{range_begin:/registry/replicasets/cert-manager/; range_end:/registry/replicasets/cert-manager0; response_count:3; response_revision:2898; }","duration":"152.246886ms","start":"2026-07-23T19:21:50.209843Z","end":"2026-07-23T19:21:50.36209Z","steps":["trace[1846435185] 'agreement among raft nodes before linearized reading' (duration: 152.0315ms)"],"step_count":1}