{"level":"warn","ts":"2026-06-30T17:01:58.331745Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T17:01:58.331836Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-06-30T17:01:58.331909Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T17:01:58.331927Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-06-30T17:01:58.33195Z","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-06-30T17:01:58.332792Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-06-30T17:01:58.332888Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-06-30T17:01:58.338551Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.398283ms"} {"level":"info","ts":"2026-06-30T17:01:58.348441Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-06-30T17:01:58.348525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T17:01:58.348554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-06-30T17:01:58.348572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T17:01:58.348617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-06-30T17:01:58.348679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-06-30T17:01:58.354754Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T17:01:58.356319Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T17:01:58.357516Z","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-06-30T17:01:58.360673Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T17:01:58.361495Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T17:01:58.361683Z","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-06-30T17:01:58.361787Z","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-06-30T17:01:58.361935Z","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-06-30T17:01:58.364095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-06-30T17:01:58.364193Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-06-30T17:01:58.365263Z","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-06-30T17:01:58.365949Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T17:01:58.365983Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T17:01:58.366134Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-06-30T17:01:58.366154Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-06-30T17:01:58.948892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T17:01:58.948943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T17:01:58.948961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-06-30T17:01:58.948976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-06-30T17:01:58.948984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-06-30T17:01:58.948995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-06-30T17:01:58.949004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-06-30T17:01:58.949906Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T17:01:58.949946Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:01:58.949915Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:01:58.950172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:01:58.950457Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T17:01:58.950554Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T17:01:58.953404Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-06-30T17:01:58.953693Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T17:01:58.958542Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:01:58.958627Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:01:58.958659Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-30T17:02:01.783929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.021715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:02:01.784133Z","caller":"traceutil/trace.go:171","msg":"trace[881968255] transaction","detail":"{read_only:false; response_revision:148; number_of_response:1; }","duration":"241.42191ms","start":"2026-06-30T17:02:01.542693Z","end":"2026-06-30T17:02:01.784114Z","steps":["trace[881968255] 'process raft request' (duration: 69.629059ms)","trace[881968255] 'compare' (duration: 170.889374ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:02:34.372789Z","caller":"traceutil/trace.go:171","msg":"trace[456254815] transaction","detail":"{read_only:false; number_of_response:0; response_revision:503; }","duration":"600.288897ms","start":"2026-06-30T17:02:33.772474Z","end":"2026-06-30T17:02:34.372762Z","steps":["trace[456254815] 'process raft request' (duration: 534.769878ms)","trace[456254815] 'compare' (duration: 65.475928ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:02:34.372934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:33.772461Z","time spent":"600.40925ms","remote":"127.0.0.1:55504","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:02:34.373406Z","caller":"traceutil/trace.go:171","msg":"trace[145074195] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"594.804818ms","start":"2026-06-30T17:02:33.778574Z","end":"2026-06-30T17:02:34.373379Z","steps":["trace[145074195] 'process raft request' (duration: 594.597282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:34.37379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:33.778564Z","time spent":"594.927121ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:02:34.373789Z","caller":"traceutil/trace.go:171","msg":"trace[266835856] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"591.384007ms","start":"2026-06-30T17:02:33.782342Z","end":"2026-06-30T17:02:34.373726Z","steps":["trace[266835856] 'process raft request' (duration: 590.979005ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:02:34.374126Z","caller":"traceutil/trace.go:171","msg":"trace[889719174] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"588.413781ms","start":"2026-06-30T17:02:33.785666Z","end":"2026-06-30T17:02:34.37408Z","steps":["trace[889719174] 'process raft request' (duration: 588.019019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:34.374306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:33.78566Z","time spent":"588.549215ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:02:34.374333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:33.782335Z","time spent":"591.560363ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:02:34.376725Z","caller":"traceutil/trace.go:171","msg":"trace[270448805] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"578.691507ms","start":"2026-06-30T17:02:33.797994Z","end":"2026-06-30T17:02:34.376686Z","steps":["trace[270448805] 'process raft request' (duration: 576.512113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:34.376951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:33.797969Z","time spent":"578.835181ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:02:34.37982Z","caller":"traceutil/trace.go:171","msg":"trace[1708293265] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"519.287613ms","start":"2026-06-30T17:02:33.860508Z","end":"2026-06-30T17:02:34.379795Z","steps":["trace[1708293265] 'process raft request' (duration: 515.500114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:34.37996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:33.860495Z","time spent":"519.416487ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:02:34.380091Z","caller":"traceutil/trace.go:171","msg":"trace[1920072649] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"161.405725ms","start":"2026-06-30T17:02:34.218623Z","end":"2026-06-30T17:02:34.380028Z","steps":["trace[1920072649] 'process raft request' (duration: 160.976753ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:02:40.521269Z","caller":"traceutil/trace.go:171","msg":"trace[927395842] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"140.320298ms","start":"2026-06-30T17:02:40.380916Z","end":"2026-06-30T17:02:40.521237Z","steps":["trace[927395842] 'process raft request' (duration: 137.916293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:40.873984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.843056ms","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-06-30T17:02:40.874109Z","caller":"traceutil/trace.go:171","msg":"trace[2027078844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"293.103133ms","start":"2026-06-30T17:02:40.580976Z","end":"2026-06-30T17:02:40.874079Z","steps":["trace[2027078844] 'range keys from in-memory index tree' (duration: 292.721723ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:02:40.892139Z","caller":"traceutil/trace.go:171","msg":"trace[1401959009] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"268.99043ms","start":"2026-06-30T17:02:40.623124Z","end":"2026-06-30T17:02:40.892114Z","steps":["trace[1401959009] 'read index received' (duration: 268.915758ms)","trace[1401959009] 'applied index is now lower than readState.Index' (duration: 73.642µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:02:40.892205Z","caller":"traceutil/trace.go:171","msg":"trace[74004434] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"310.876775ms","start":"2026-06-30T17:02:40.5813Z","end":"2026-06-30T17:02:40.892177Z","steps":["trace[74004434] 'process raft request' (duration: 310.655259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:40.89234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.204366ms","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-06-30T17:02:40.892381Z","caller":"traceutil/trace.go:171","msg":"trace[1729731078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"269.289979ms","start":"2026-06-30T17:02:40.623079Z","end":"2026-06-30T17:02:40.892369Z","steps":["trace[1729731078] 'agreement among raft nodes before linearized reading' (duration: 269.171536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:40.892354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:40.581289Z","time spent":"310.975947ms","remote":"127.0.0.1:55206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:02:40.903046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.14297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fr6nx\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-30T17:02:40.903162Z","caller":"traceutil/trace.go:171","msg":"trace[1622348944] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fr6nx; range_end:; response_count:1; response_revision:592; }","duration":"264.308165ms","start":"2026-06-30T17:02:40.638828Z","end":"2026-06-30T17:02:40.903136Z","steps":["trace[1622348944] 'agreement among raft nodes before linearized reading' (duration: 263.980916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:41.22885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.732504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:02:41.229009Z","caller":"traceutil/trace.go:171","msg":"trace[1544059350] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"270.297884ms","start":"2026-06-30T17:02:40.958684Z","end":"2026-06-30T17:02:41.228982Z","steps":["trace[1544059350] 'process raft request' (duration: 155.323683ms)","trace[1544059350] 'compare' (duration: 114.520108ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:02:41.35486Z","caller":"traceutil/trace.go:171","msg":"trace[1423250892] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"118.515634ms","start":"2026-06-30T17:02:41.236318Z","end":"2026-06-30T17:02:41.354833Z","steps":["trace[1423250892] 'process raft request' (duration: 101.443516ms)","trace[1423250892] 'compare' (duration: 16.892913ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:02:41.355335Z","caller":"traceutil/trace.go:171","msg":"trace[1808317561] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"118.773882ms","start":"2026-06-30T17:02:41.236504Z","end":"2026-06-30T17:02:41.355277Z","steps":["trace[1808317561] 'process raft request' (duration: 118.281528ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:02:41.355381Z","caller":"traceutil/trace.go:171","msg":"trace[770459167] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"117.441396ms","start":"2026-06-30T17:02:41.237911Z","end":"2026-06-30T17:02:41.355353Z","steps":["trace[770459167] 'process raft request' (duration: 117.291792ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:02:44.100329Z","caller":"traceutil/trace.go:171","msg":"trace[956152253] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"153.264705ms","start":"2026-06-30T17:02:43.94704Z","end":"2026-06-30T17:02:44.100304Z","steps":["trace[956152253] 'read index received' (duration: 153.198123ms)","trace[956152253] 'applied index is now lower than readState.Index' (duration: 65.442µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:02:44.100513Z","caller":"traceutil/trace.go:171","msg":"trace[604293088] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"308.113698ms","start":"2026-06-30T17:02:43.792317Z","end":"2026-06-30T17:02:44.100431Z","steps":["trace[604293088] 'process raft request' (duration: 307.857842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:44.100602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.545792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:02:44.100661Z","caller":"traceutil/trace.go:171","msg":"trace[1409386978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"153.661865ms","start":"2026-06-30T17:02:43.946981Z","end":"2026-06-30T17:02:44.100643Z","steps":["trace[1409386978] 'agreement among raft nodes before linearized reading' (duration: 153.48676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:44.100696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:43.792291Z","time spent":"308.341274ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:02:44.103319Z","caller":"traceutil/trace.go:171","msg":"trace[1656071853] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"111.997421ms","start":"2026-06-30T17:02:43.991301Z","end":"2026-06-30T17:02:44.103298Z","steps":["trace[1656071853] 'process raft request' (duration: 111.843017ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:02:57.025624Z","caller":"traceutil/trace.go:171","msg":"trace[346703525] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"385.705456ms","start":"2026-06-30T17:02:56.639893Z","end":"2026-06-30T17:02:57.025598Z","steps":["trace[346703525] 'process raft request' (duration: 385.473771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:57.025837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:56.639855Z","time spent":"385.87368ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:02:57.05318Z","caller":"traceutil/trace.go:171","msg":"trace[661793821] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:778; }","duration":"322.767457ms","start":"2026-06-30T17:02:56.730383Z","end":"2026-06-30T17:02:57.053151Z","steps":["trace[661793821] 'read index received' (duration: 294.976572ms)","trace[661793821] 'applied index is now lower than readState.Index' (duration: 27.789475ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:02:57.053317Z","caller":"traceutil/trace.go:171","msg":"trace[1365701761] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"412.678562ms","start":"2026-06-30T17:02:56.640627Z","end":"2026-06-30T17:02:57.053306Z","steps":["trace[1365701761] 'process raft request' (duration: 412.353354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:57.053444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.549719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:02:57.053478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:56.640603Z","time spent":"412.753133ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:02:57.053504Z","caller":"traceutil/trace.go:171","msg":"trace[520822402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"106.653982ms","start":"2026-06-30T17:02:56.946836Z","end":"2026-06-30T17:02:57.05349Z","steps":["trace[520822402] 'agreement among raft nodes before linearized reading' (duration: 106.55492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:57.053551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.154856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9v6rb\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-30T17:02:57.053641Z","caller":"traceutil/trace.go:171","msg":"trace[661601769] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9v6rb; range_end:; response_count:1; response_revision:754; }","duration":"323.30309ms","start":"2026-06-30T17:02:56.730316Z","end":"2026-06-30T17:02:57.05362Z","steps":["trace[661601769] 'agreement among raft nodes before linearized reading' (duration: 323.072804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:02:57.053705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:02:56.730289Z","time spent":"323.393692ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9v6rb\" "} {"level":"warn","ts":"2026-06-30T17:03:35.443275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.774001ms","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-06-30T17:03:35.44331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.76895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T17:03:35.443367Z","caller":"traceutil/trace.go:171","msg":"trace[629510703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1182; }","duration":"112.921713ms","start":"2026-06-30T17:03:35.330427Z","end":"2026-06-30T17:03:35.443349Z","steps":["trace[629510703] 'range keys from in-memory index tree' (duration: 112.600218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:03:35.443596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.006634ms","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-06-30T17:03:35.443683Z","caller":"traceutil/trace.go:171","msg":"trace[983757105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1182; }","duration":"210.123797ms","start":"2026-06-30T17:03:35.233537Z","end":"2026-06-30T17:03:35.443661Z","steps":["trace[983757105] 'range keys from in-memory index tree' (duration: 209.771019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:03:35.443762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.566975ms","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-06-30T17:03:35.443835Z","caller":"traceutil/trace.go:171","msg":"trace[929313444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1182; }","duration":"111.109385ms","start":"2026-06-30T17:03:35.332711Z","end":"2026-06-30T17:03:35.44382Z","steps":["trace[929313444] 'range keys from in-memory index tree' (duration: 110.402082ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:03:35.443378Z","caller":"traceutil/trace.go:171","msg":"trace[1952721252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1182; }","duration":"242.920683ms","start":"2026-06-30T17:03:35.200441Z","end":"2026-06-30T17:03:35.443362Z","steps":["trace[1952721252] 'range keys from in-memory index tree' (duration: 242.630398ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:03:50.052586Z","caller":"traceutil/trace.go:171","msg":"trace[1213022532] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"100.033545ms","start":"2026-06-30T17:03:49.952525Z","end":"2026-06-30T17:03:50.052558Z","steps":["trace[1213022532] 'process raft request' (duration: 66.818874ms)","trace[1213022532] 'compare' (duration: 32.990127ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:03:58.432466Z","caller":"traceutil/trace.go:171","msg":"trace[1053881122] linearizableReadLoop","detail":"{readStateIndex:1495; appliedIndex:1494; }","duration":"154.438544ms","start":"2026-06-30T17:03:58.278003Z","end":"2026-06-30T17:03:58.432442Z","steps":["trace[1053881122] 'read index received' (duration: 145.16058ms)","trace[1053881122] 'applied index is now lower than readState.Index' (duration: 9.276714ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:03:58.432618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.610087ms","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-06-30T17:03:58.43265Z","caller":"traceutil/trace.go:171","msg":"trace[757059062] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1447; }","duration":"154.661197ms","start":"2026-06-30T17:03:58.277979Z","end":"2026-06-30T17:03:58.432641Z","steps":["trace[757059062] 'agreement among raft nodes before linearized reading' (duration: 154.557056ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:03:58.432874Z","caller":"traceutil/trace.go:171","msg":"trace[135226230] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"352.433604ms","start":"2026-06-30T17:03:58.080387Z","end":"2026-06-30T17:03:58.432821Z","steps":["trace[135226230] 'process raft request' (duration: 342.844496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:03:58.433218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:03:58.080364Z","time spent":"352.637637ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:22.227269Z","caller":"traceutil/trace.go:171","msg":"trace[1399490397] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1930; }","duration":"456.798055ms","start":"2026-06-30T17:04:21.770444Z","end":"2026-06-30T17:04:22.227242Z","steps":["trace[1399490397] 'read index received' (duration: 456.539542ms)","trace[1399490397] 'applied index is now lower than readState.Index' (duration: 257.363µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:04:22.227422Z","caller":"traceutil/trace.go:171","msg":"trace[52391104] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"459.656891ms","start":"2026-06-30T17:04:21.767664Z","end":"2026-06-30T17:04:22.22732Z","steps":["trace[52391104] 'process raft request' (duration: 459.414468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.227708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.333963ms","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-06-30T17:04:22.227751Z","caller":"traceutil/trace.go:171","msg":"trace[1029999777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1857; }","duration":"450.385063ms","start":"2026-06-30T17:04:21.777354Z","end":"2026-06-30T17:04:22.227739Z","steps":["trace[1029999777] 'agreement among raft nodes before linearized reading' (duration: 450.306392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.227558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.967142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-30T17:04:22.227795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:21.777346Z","time spent":"450.440614ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:04:22.227785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.428726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:04:22.227842Z","caller":"traceutil/trace.go:171","msg":"trace[794397790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1857; }","duration":"451.277505ms","start":"2026-06-30T17:04:21.776545Z","end":"2026-06-30T17:04:22.227823Z","steps":["trace[794397790] 'agreement among raft nodes before linearized reading' (duration: 450.848739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.227888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:21.776532Z","time spent":"451.343576ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T17:04:22.227884Z","caller":"traceutil/trace.go:171","msg":"trace[908983947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"283.585648ms","start":"2026-06-30T17:04:21.944274Z","end":"2026-06-30T17:04:22.22786Z","steps":["trace[908983947] 'agreement among raft nodes before linearized reading' (duration: 283.398085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.227578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.298358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.95\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-30T17:04:22.227986Z","caller":"traceutil/trace.go:171","msg":"trace[519694497] range","detail":"{range_begin:/registry/masterleases/199.204.45.95; range_end:; response_count:1; response_revision:1857; }","duration":"136.753713ms","start":"2026-06-30T17:04:22.09122Z","end":"2026-06-30T17:04:22.227974Z","steps":["trace[519694497] 'agreement among raft nodes before linearized reading' (duration: 136.216295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.227642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.396811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:04:22.228171Z","caller":"traceutil/trace.go:171","msg":"trace[1813548911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"166.921318ms","start":"2026-06-30T17:04:22.061197Z","end":"2026-06-30T17:04:22.228119Z","steps":["trace[1813548911] 'agreement among raft nodes before linearized reading' (duration: 166.389121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.228199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:21.767646Z","time spent":"460.160038ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:04:22.228378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.92768ms","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-06-30T17:04:22.228524Z","caller":"traceutil/trace.go:171","msg":"trace[1987681154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1857; }","duration":"458.081331ms","start":"2026-06-30T17:04:21.770427Z","end":"2026-06-30T17:04:22.228508Z","steps":["trace[1987681154] 'agreement among raft nodes before linearized reading' (duration: 456.946767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:22.228584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:21.77042Z","time spent":"458.135922ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:04:22.587603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.229136Z","time spent":"358.442168ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-30T17:04:23.075109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.047253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:04:23.075281Z","caller":"traceutil/trace.go:171","msg":"trace[1247387264] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"843.060551ms","start":"2026-06-30T17:04:22.232201Z","end":"2026-06-30T17:04:23.075262Z","steps":["trace[1247387264] 'process raft request' (duration: 530.775465ms)","trace[1247387264] 'compare' (duration: 311.81135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:04:23.075416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.232185Z","time spent":"843.139032ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:23.075527Z","caller":"traceutil/trace.go:171","msg":"trace[990082231] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"843.00551ms","start":"2026-06-30T17:04:22.232506Z","end":"2026-06-30T17:04:23.075511Z","steps":["trace[990082231] 'process raft request' (duration: 842.693686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.075614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.232482Z","time spent":"843.090882ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:23.07574Z","caller":"traceutil/trace.go:171","msg":"trace[163642223] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"842.000297ms","start":"2026-06-30T17:04:22.233716Z","end":"2026-06-30T17:04:23.075716Z","steps":["trace[163642223] 'process raft request' (duration: 841.745564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.075892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.233704Z","time spent":"842.111389ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:23.075934Z","caller":"traceutil/trace.go:171","msg":"trace[676340200] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"842.035978ms","start":"2026-06-30T17:04:22.233857Z","end":"2026-06-30T17:04:23.075893Z","steps":["trace[676340200] 'process raft request' (duration: 841.782755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.076024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.233825Z","time spent":"842.151611ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:23.076041Z","caller":"traceutil/trace.go:171","msg":"trace[308004180] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"840.240656ms","start":"2026-06-30T17:04:22.235789Z","end":"2026-06-30T17:04:23.07603Z","steps":["trace[308004180] 'process raft request' (duration: 839.995692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.076098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.235767Z","time spent":"840.298627ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:04:23.076938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.930154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:04:23.076989Z","caller":"traceutil/trace.go:171","msg":"trace[1110076689] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1862; }","duration":"761.019186ms","start":"2026-06-30T17:04:22.31596Z","end":"2026-06-30T17:04:23.07698Z","steps":["trace[1110076689] 'agreement among raft nodes before linearized reading' (duration: 760.939775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.077013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.315944Z","time spent":"761.063106ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-30T17:04:23.075924Z","caller":"traceutil/trace.go:171","msg":"trace[1775003666] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1931; }","duration":"759.898881ms","start":"2026-06-30T17:04:22.316013Z","end":"2026-06-30T17:04:23.075912Z","steps":["trace[1775003666] 'read index received' (duration: 208.390937ms)","trace[1775003666] 'applied index is now lower than readState.Index' (duration: 551.506954ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:04:23.100777Z","caller":"traceutil/trace.go:171","msg":"trace[1668789652] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"511.856419ms","start":"2026-06-30T17:04:22.588905Z","end":"2026-06-30T17:04:23.100761Z","steps":["trace[1668789652] 'process raft request' (duration: 511.802808ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:23.100871Z","caller":"traceutil/trace.go:171","msg":"trace[116942422] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"574.83358ms","start":"2026-06-30T17:04:22.525997Z","end":"2026-06-30T17:04:23.100831Z","steps":["trace[116942422] 'process raft request' (duration: 574.642518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.101217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.525969Z","time spent":"575.175135ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:04:23.101113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.588883Z","time spent":"512.167352ms","remote":"127.0.0.1:54978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:23.12824Z","caller":"traceutil/trace.go:171","msg":"trace[1363548084] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"207.714902ms","start":"2026-06-30T17:04:22.920454Z","end":"2026-06-30T17:04:23.128169Z","steps":["trace[1363548084] 'process raft request' (duration: 207.54102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.128562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.413873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:04:23.128574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.419898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:04:23.128582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.147388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f64dbe75-4e24-4774-b7ad-f8e9c8d95e07\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-06-30T17:04:23.128627Z","caller":"traceutil/trace.go:171","msg":"trace[710459794] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1866; }","duration":"297.488114ms","start":"2026-06-30T17:04:22.831124Z","end":"2026-06-30T17:04:23.128612Z","steps":["trace[710459794] 'agreement among raft nodes before linearized reading' (duration: 297.323162ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:23.128642Z","caller":"traceutil/trace.go:171","msg":"trace[1037323356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1866; }","duration":"182.523039ms","start":"2026-06-30T17:04:22.946101Z","end":"2026-06-30T17:04:23.128624Z","steps":["trace[1037323356] 'agreement among raft nodes before linearized reading' (duration: 182.333947ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:23.128663Z","caller":"traceutil/trace.go:171","msg":"trace[1935527904] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f64dbe75-4e24-4774-b7ad-f8e9c8d95e07; range_end:; response_count:1; response_revision:1866; }","duration":"522.268029ms","start":"2026-06-30T17:04:22.606372Z","end":"2026-06-30T17:04:23.12864Z","steps":["trace[1935527904] 'agreement among raft nodes before linearized reading' (duration: 522.093257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.128727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.606359Z","time spent":"522.352011ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3767,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f64dbe75-4e24-4774-b7ad-f8e9c8d95e07\" "} {"level":"warn","ts":"2026-06-30T17:04:23.128592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.642937ms","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-06-30T17:04:23.128891Z","caller":"traceutil/trace.go:171","msg":"trace[1386471856] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1866; }","duration":"264.99186ms","start":"2026-06-30T17:04:22.863884Z","end":"2026-06-30T17:04:23.128876Z","steps":["trace[1386471856] 'agreement among raft nodes before linearized reading' (duration: 264.645776ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:23.128924Z","caller":"traceutil/trace.go:171","msg":"trace[1406328135] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"189.65956ms","start":"2026-06-30T17:04:22.939253Z","end":"2026-06-30T17:04:23.128912Z","steps":["trace[1406328135] 'process raft request' (duration: 188.87437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.129056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.290173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T17:04:23.129094Z","caller":"traceutil/trace.go:171","msg":"trace[1011273181] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"811.357414ms","start":"2026-06-30T17:04:22.317724Z","end":"2026-06-30T17:04:23.129081Z","steps":["trace[1011273181] 'agreement among raft nodes before linearized reading' (duration: 811.213712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:23.129136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:22.317705Z","time spent":"811.424025ms","remote":"127.0.0.1:55578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-30T17:04:35.483362Z","caller":"traceutil/trace.go:171","msg":"trace[674252772] linearizableReadLoop","detail":"{readStateIndex:2039; appliedIndex:2038; }","duration":"353.824475ms","start":"2026-06-30T17:04:35.129514Z","end":"2026-06-30T17:04:35.483339Z","steps":["trace[674252772] 'read index received' (duration: 353.696933ms)","trace[674252772] 'applied index is now lower than readState.Index' (duration: 126.462µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:04:35.483442Z","caller":"traceutil/trace.go:171","msg":"trace[695764905] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"404.82461ms","start":"2026-06-30T17:04:35.078561Z","end":"2026-06-30T17:04:35.483385Z","steps":["trace[695764905] 'process raft request' (duration: 404.629878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.483612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.078548Z","time spent":"404.963271ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:04:35.483609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.074657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T17:04:35.483684Z","caller":"traceutil/trace.go:171","msg":"trace[1673607638] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1962; }","duration":"354.207189ms","start":"2026-06-30T17:04:35.12946Z","end":"2026-06-30T17:04:35.483667Z","steps":["trace[1673607638] 'agreement among raft nodes before linearized reading' (duration: 353.966817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.483741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.129442Z","time spent":"354.28891ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T17:04:35.491314Z","caller":"traceutil/trace.go:171","msg":"trace[897503122] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"356.160913ms","start":"2026-06-30T17:04:35.135138Z","end":"2026-06-30T17:04:35.491299Z","steps":["trace[897503122] 'process raft request' (duration: 356.054882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.491446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.135123Z","time spent":"356.242213ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:04:35.491554Z","caller":"traceutil/trace.go:171","msg":"trace[1491924340] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"332.171472ms","start":"2026-06-30T17:04:35.159366Z","end":"2026-06-30T17:04:35.491537Z","steps":["trace[1491924340] 'process raft request' (duration: 331.898449ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:35.491644Z","caller":"traceutil/trace.go:171","msg":"trace[1362974466] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"325.141617ms","start":"2026-06-30T17:04:35.16648Z","end":"2026-06-30T17:04:35.491622Z","steps":["trace[1362974466] 'process raft request' (duration: 324.980806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.491799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.166457Z","time spent":"325.252538ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:04:35.491859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.361095ms","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-06-30T17:04:35.491911Z","caller":"traceutil/trace.go:171","msg":"trace[2077908317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1966; }","duration":"351.452746ms","start":"2026-06-30T17:04:35.140445Z","end":"2026-06-30T17:04:35.491898Z","steps":["trace[2077908317] 'agreement among raft nodes before linearized reading' (duration: 351.305264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.491887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.159348Z","time spent":"332.342704ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:04:35.491952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.140425Z","time spent":"351.517876ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:04:35.491968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.970418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11981"} {"level":"warn","ts":"2026-06-30T17:04:35.491989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.555404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T17:04:35.492026Z","caller":"traceutil/trace.go:171","msg":"trace[107244476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1966; }","duration":"340.626625ms","start":"2026-06-30T17:04:35.15139Z","end":"2026-06-30T17:04:35.492017Z","steps":["trace[107244476] 'agreement among raft nodes before linearized reading' (duration: 340.512504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.49205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.15137Z","time spent":"340.675235ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:04:35.492077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.845877ms","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-06-30T17:04:35.492084Z","caller":"traceutil/trace.go:171","msg":"trace[36662535] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"265.997853ms","start":"2026-06-30T17:04:35.226077Z","end":"2026-06-30T17:04:35.492075Z","steps":["trace[36662535] 'process raft request' (duration: 265.490077ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:35.492111Z","caller":"traceutil/trace.go:171","msg":"trace[1477533180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1966; }","duration":"340.899678ms","start":"2026-06-30T17:04:35.151203Z","end":"2026-06-30T17:04:35.492103Z","steps":["trace[1477533180] 'agreement among raft nodes before linearized reading' (duration: 340.818937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.492138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.359296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T17:04:35.492021Z","caller":"traceutil/trace.go:171","msg":"trace[838348100] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1966; }","duration":"120.0546ms","start":"2026-06-30T17:04:35.371943Z","end":"2026-06-30T17:04:35.491998Z","steps":["trace[838348100] 'agreement among raft nodes before linearized reading' (duration: 119.913618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:35.492143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:35.151193Z","time spent":"340.944998ms","remote":"127.0.0.1:55230","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-06-30T17:04:35.492159Z","caller":"traceutil/trace.go:171","msg":"trace[573178070] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1966; }","duration":"280.405737ms","start":"2026-06-30T17:04:35.211747Z","end":"2026-06-30T17:04:35.492152Z","steps":["trace[573178070] 'agreement among raft nodes before linearized reading' (duration: 280.349467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:38.887169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.743203ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:04:38.887213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.208884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:04:38.887246Z","caller":"traceutil/trace.go:171","msg":"trace[1015270061] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1994; }","duration":"439.830214ms","start":"2026-06-30T17:04:38.447404Z","end":"2026-06-30T17:04:38.887234Z","steps":["trace[1015270061] 'range keys from in-memory index tree' (duration: 439.730013ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:04:38.887268Z","caller":"traceutil/trace.go:171","msg":"trace[397231167] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1994; }","duration":"186.314276ms","start":"2026-06-30T17:04:38.70094Z","end":"2026-06-30T17:04:38.887254Z","steps":["trace[397231167] 'count revisions from in-memory index tree' (duration: 186.128643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:38.887394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.798343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-30T17:04:38.887424Z","caller":"traceutil/trace.go:171","msg":"trace[90089549] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1994; }","duration":"331.861055ms","start":"2026-06-30T17:04:38.555546Z","end":"2026-06-30T17:04:38.887407Z","steps":["trace[90089549] 'range keys from in-memory index tree' (duration: 331.404279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:38.887376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.200455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-30T17:04:38.887444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:38.555523Z","time spent":"331.916975ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-30T17:04:38.887484Z","caller":"traceutil/trace.go:171","msg":"trace[9922139] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1994; }","duration":"377.332887ms","start":"2026-06-30T17:04:38.510116Z","end":"2026-06-30T17:04:38.887448Z","steps":["trace[9922139] 'range keys from in-memory index tree' (duration: 376.74332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:38.887528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:38.510097Z","time spent":"377.421338ms","remote":"127.0.0.1:55578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-30T17:04:56.777178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.607037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:04:56.777271Z","caller":"traceutil/trace.go:171","msg":"trace[964395276] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2097; }","duration":"303.714838ms","start":"2026-06-30T17:04:56.473535Z","end":"2026-06-30T17:04:56.77725Z","steps":["trace[964395276] 'count revisions from in-memory index tree' (duration: 303.527837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:04:56.777315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:04:56.473515Z","time spent":"303.789479ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:05:02.436145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.776864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:05:02.436419Z","caller":"traceutil/trace.go:171","msg":"trace[660371212] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"219.974014ms","start":"2026-06-30T17:05:02.216413Z","end":"2026-06-30T17:05:02.436387Z","steps":["trace[660371212] 'process raft request' (duration: 81.885946ms)","trace[660371212] 'compare' (duration: 137.677123ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:05:02.436846Z","caller":"traceutil/trace.go:171","msg":"trace[778519654] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"204.835617ms","start":"2026-06-30T17:05:02.232003Z","end":"2026-06-30T17:05:02.436838Z","steps":["trace[778519654] 'process raft request' (duration: 204.254881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.180571Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316902529883448,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T17:05:04.360073Z","caller":"traceutil/trace.go:171","msg":"trace[41336572] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"779.627033ms","start":"2026-06-30T17:05:03.580424Z","end":"2026-06-30T17:05:04.360051Z","steps":["trace[41336572] 'process raft request' (duration: 779.477151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.360315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.580395Z","time spent":"779.746534ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:05:04.831948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.503055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:05:04.832148Z","caller":"traceutil/trace.go:171","msg":"trace[1874964740] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"1.242643929s","start":"2026-06-30T17:05:03.589452Z","end":"2026-06-30T17:05:04.832096Z","steps":["trace[1874964740] 'process raft request' (duration: 963.920072ms)","trace[1874964740] 'compare' (duration: 278.314682ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:05:04.832599Z","caller":"traceutil/trace.go:171","msg":"trace[1882590037] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"1.241951471s","start":"2026-06-30T17:05:03.590639Z","end":"2026-06-30T17:05:04.83259Z","steps":["trace[1882590037] 'process raft request' (duration: 1.241440146s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.832696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.590629Z","time spent":"1.242029962s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:04.832903Z","caller":"traceutil/trace.go:171","msg":"trace[1677619817] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"974.748752ms","start":"2026-06-30T17:05:03.858131Z","end":"2026-06-30T17:05:04.83288Z","steps":["trace[1677619817] 'process raft request' (duration: 974.055505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.833023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.858106Z","time spent":"974.867433ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:04.832275Z","caller":"traceutil/trace.go:171","msg":"trace[867086676] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2211; }","duration":"1.151726276s","start":"2026-06-30T17:05:03.680529Z","end":"2026-06-30T17:05:04.832255Z","steps":["trace[867086676] 'read index received' (duration: 679.432477ms)","trace[867086676] 'applied index is now lower than readState.Index' (duration: 472.292429ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:05:04.832501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.151940898s","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-06-30T17:05:04.833143Z","caller":"traceutil/trace.go:171","msg":"trace[1733005402] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2133; }","duration":"1.152644405s","start":"2026-06-30T17:05:03.680486Z","end":"2026-06-30T17:05:04.833131Z","steps":["trace[1733005402] 'agreement among raft nodes before linearized reading' (duration: 1.151845457s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.833221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.680467Z","time spent":"1.152742047s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:05:04.833362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152684217s","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-06-30T17:05:04.833445Z","caller":"traceutil/trace.go:171","msg":"trace[417289319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2133; }","duration":"1.152788078s","start":"2026-06-30T17:05:03.680644Z","end":"2026-06-30T17:05:04.833432Z","steps":["trace[417289319] 'agreement among raft nodes before linearized reading' (duration: 1.152525754s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.833431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.450189ms","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-06-30T17:05:04.833514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.914525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T17:05:04.833544Z","caller":"traceutil/trace.go:171","msg":"trace[2014221382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2133; }","duration":"381.60435ms","start":"2026-06-30T17:05:04.451922Z","end":"2026-06-30T17:05:04.833527Z","steps":["trace[2014221382] 'agreement among raft nodes before linearized reading' (duration: 381.313117ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:05:04.833552Z","caller":"traceutil/trace.go:171","msg":"trace[332986197] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2133; }","duration":"770.944555ms","start":"2026-06-30T17:05:04.062592Z","end":"2026-06-30T17:05:04.833537Z","steps":["trace[332986197] 'agreement among raft nodes before linearized reading' (duration: 770.825704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.833589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.062466Z","time spent":"771.116716ms","remote":"127.0.0.1:55578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-30T17:05:04.833518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.680638Z","time spent":"1.152868479s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T17:05:04.833775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.149087796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-30T17:05:04.833825Z","caller":"traceutil/trace.go:171","msg":"trace[777350903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2133; }","duration":"1.149170928s","start":"2026-06-30T17:05:03.684641Z","end":"2026-06-30T17:05:04.833812Z","steps":["trace[777350903] 'agreement among raft nodes before linearized reading' (duration: 1.149034336s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.83386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.684626Z","time spent":"1.149227278s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:05:04.833883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.021202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:05:04.833592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.4519Z","time spent":"381.68093ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:05:04.833986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.422499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:05:04.834026Z","caller":"traceutil/trace.go:171","msg":"trace[1635307040] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2133; }","duration":"343.465999ms","start":"2026-06-30T17:05:04.490553Z","end":"2026-06-30T17:05:04.834019Z","steps":["trace[1635307040] 'agreement among raft nodes before linearized reading' (duration: 343.395298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.834055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.490492Z","time spent":"343.555ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":22,"response size":31,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-06-30T17:05:04.834062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.589429Z","time spent":"1.243266675s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:04.832543Z","caller":"traceutil/trace.go:171","msg":"trace[675043323] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"1.242534437s","start":"2026-06-30T17:05:03.589997Z","end":"2026-06-30T17:05:04.832532Z","steps":["trace[675043323] 'process raft request' (duration: 1.242034802s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.833396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148637261s","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-06-30T17:05:04.834317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.589971Z","time spent":"1.244280976s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:04.833928Z","caller":"traceutil/trace.go:171","msg":"trace[520170728] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2133; }","duration":"132.111934ms","start":"2026-06-30T17:05:04.701805Z","end":"2026-06-30T17:05:04.833917Z","steps":["trace[520170728] 'agreement among raft nodes before linearized reading' (duration: 132.029703ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:05:04.834666Z","caller":"traceutil/trace.go:171","msg":"trace[1545346712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2133; }","duration":"1.149920836s","start":"2026-06-30T17:05:03.684709Z","end":"2026-06-30T17:05:04.834385Z","steps":["trace[1545346712] 'agreement among raft nodes before linearized reading' (duration: 1.148599362s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:04.83496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:03.684686Z","time spent":"1.150239519s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T17:05:05.301401Z","caller":"traceutil/trace.go:171","msg":"trace[1673511220] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"464.065499ms","start":"2026-06-30T17:05:04.837315Z","end":"2026-06-30T17:05:05.301381Z","steps":["trace[1673511220] 'process raft request' (duration: 427.63753ms)","trace[1673511220] 'compare' (duration: 36.349249ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:05:05.301517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.8373Z","time spent":"464.15269ms","remote":"127.0.0.1:55022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:05.3056Z","caller":"traceutil/trace.go:171","msg":"trace[1553627596] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"465.468965ms","start":"2026-06-30T17:05:04.840107Z","end":"2026-06-30T17:05:05.305576Z","steps":["trace[1553627596] 'process raft request' (duration: 465.302503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.305765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.840043Z","time spent":"465.643827ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:05.3058Z","caller":"traceutil/trace.go:171","msg":"trace[1346324509] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"465.135381ms","start":"2026-06-30T17:05:04.840648Z","end":"2026-06-30T17:05:05.305783Z","steps":["trace[1346324509] 'process raft request' (duration: 464.887578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.305893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.840628Z","time spent":"465.215891ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:05.306157Z","caller":"traceutil/trace.go:171","msg":"trace[894810079] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"464.987758ms","start":"2026-06-30T17:05:04.841159Z","end":"2026-06-30T17:05:05.306147Z","steps":["trace[894810079] 'process raft request' (duration: 464.559384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.306212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.841139Z","time spent":"465.0485ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:05:05.30624Z","caller":"traceutil/trace.go:171","msg":"trace[530213097] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2216; }","duration":"359.828272ms","start":"2026-06-30T17:05:04.946382Z","end":"2026-06-30T17:05:05.30621Z","steps":["trace[530213097] 'read index received' (duration: 318.514699ms)","trace[530213097] 'applied index is now lower than readState.Index' (duration: 41.312433ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:05:05.306279Z","caller":"traceutil/trace.go:171","msg":"trace[1468534222] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"464.457873ms","start":"2026-06-30T17:05:04.841812Z","end":"2026-06-30T17:05:05.30627Z","steps":["trace[1468534222] 'process raft request' (duration: 464.353152ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:05:05.306271Z","caller":"traceutil/trace.go:171","msg":"trace[1918460998] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"464.573393ms","start":"2026-06-30T17:05:04.841683Z","end":"2026-06-30T17:05:05.306256Z","steps":["trace[1918460998] 'process raft request' (duration: 464.377331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.306317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.841806Z","time spent":"464.494363ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:05:05.306346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.841675Z","time spent":"464.634824ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:05:05.306427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.356354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:05:05.306473Z","caller":"traceutil/trace.go:171","msg":"trace[1558901106] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2139; }","duration":"358.406835ms","start":"2026-06-30T17:05:04.948055Z","end":"2026-06-30T17:05:05.306462Z","steps":["trace[1558901106] 'agreement among raft nodes before linearized reading' (duration: 358.312334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.306477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.016371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:05:05.306509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.948001Z","time spent":"358.499848ms","remote":"127.0.0.1:55138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-06-30T17:05:05.306517Z","caller":"traceutil/trace.go:171","msg":"trace[700790198] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2139; }","duration":"175.113663ms","start":"2026-06-30T17:05:05.131392Z","end":"2026-06-30T17:05:05.306506Z","steps":["trace[700790198] 'agreement among raft nodes before linearized reading' (duration: 174.981081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.307011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.625271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:05:05.307052Z","caller":"traceutil/trace.go:171","msg":"trace[392222653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2139; }","duration":"360.707252ms","start":"2026-06-30T17:05:04.946335Z","end":"2026-06-30T17:05:05.307042Z","steps":["trace[392222653] 'agreement among raft nodes before linearized reading' (duration: 360.002943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:05:05.30708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:05:04.946281Z","time spent":"360.793013ms","remote":"127.0.0.1:54948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:06:29.275203Z","caller":"traceutil/trace.go:171","msg":"trace[1376562727] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"115.727044ms","start":"2026-06-30T17:06:29.159447Z","end":"2026-06-30T17:06:29.275174Z","steps":["trace[1376562727] 'process raft request' (duration: 115.584373ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:06:29.286005Z","caller":"traceutil/trace.go:171","msg":"trace[1223459024] linearizableReadLoop","detail":"{readStateIndex:2803; appliedIndex:2801; }","duration":"123.305948ms","start":"2026-06-30T17:06:29.162671Z","end":"2026-06-30T17:06:29.285977Z","steps":["trace[1223459024] 'read index received' (duration: 112.694705ms)","trace[1223459024] 'applied index is now lower than readState.Index' (duration: 10.610293ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:06:29.286061Z","caller":"traceutil/trace.go:171","msg":"trace[69150277] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"123.999634ms","start":"2026-06-30T17:06:29.162034Z","end":"2026-06-30T17:06:29.286034Z","steps":["trace[69150277] 'process raft request' (duration: 123.782143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:06:29.286256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.55426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-30T17:06:29.286297Z","caller":"traceutil/trace.go:171","msg":"trace[1819494896] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2700; }","duration":"123.631501ms","start":"2026-06-30T17:06:29.162652Z","end":"2026-06-30T17:06:29.286283Z","steps":["trace[1819494896] 'agreement among raft nodes before linearized reading' (duration: 123.427029ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:06:29.286553Z","caller":"traceutil/trace.go:171","msg":"trace[703452548] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"124.451719ms","start":"2026-06-30T17:06:29.16209Z","end":"2026-06-30T17:06:29.286542Z","steps":["trace[703452548] 'process raft request' (duration: 123.848704ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:06:29.853323Z","caller":"traceutil/trace.go:171","msg":"trace[119204360] linearizableReadLoop","detail":"{readStateIndex:2804; appliedIndex:2803; }","duration":"119.443911ms","start":"2026-06-30T17:06:29.733861Z","end":"2026-06-30T17:06:29.853305Z","steps":["trace[119204360] 'read index received' (duration: 119.269079ms)","trace[119204360] 'applied index is now lower than readState.Index' (duration: 174.182µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:06:29.853602Z","caller":"traceutil/trace.go:171","msg":"trace[2146073120] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"141.20424ms","start":"2026-06-30T17:06:29.712389Z","end":"2026-06-30T17:06:29.853594Z","steps":["trace[2146073120] 'process raft request' (duration: 140.796387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:06:29.8538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.926365ms","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-06-30T17:06:29.853829Z","caller":"traceutil/trace.go:171","msg":"trace[484242580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2701; }","duration":"119.988145ms","start":"2026-06-30T17:06:29.733834Z","end":"2026-06-30T17:06:29.853822Z","steps":["trace[484242580] 'agreement among raft nodes before linearized reading' (duration: 119.892844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:06:29.853949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.017135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T17:06:29.853978Z","caller":"traceutil/trace.go:171","msg":"trace[1176318694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2701; }","duration":"120.085327ms","start":"2026-06-30T17:06:29.733887Z","end":"2026-06-30T17:06:29.853972Z","steps":["trace[1176318694] 'agreement among raft nodes before linearized reading' (duration: 120.020186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:06:29.854514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.787844ms","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-06-30T17:06:29.854548Z","caller":"traceutil/trace.go:171","msg":"trace[20749925] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2701; }","duration":"119.870886ms","start":"2026-06-30T17:06:29.734669Z","end":"2026-06-30T17:06:29.85454Z","steps":["trace[20749925] 'agreement among raft nodes before linearized reading' (duration: 119.417601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:06:29.854546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.972996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-30T17:06:29.854624Z","caller":"traceutil/trace.go:171","msg":"trace[2004785845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2701; }","duration":"120.100047ms","start":"2026-06-30T17:06:29.734505Z","end":"2026-06-30T17:06:29.854605Z","steps":["trace[2004785845] 'agreement among raft nodes before linearized reading' (duration: 119.872535ms)"],"step_count":1}