{"level":"warn","ts":"2026-10-15T11:11:48.530246Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T11:11:48.530351Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.242:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.242:2380","--initial-cluster=instance=https://162.253.55.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.242:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-15T11:11:48.530428Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T11:11:48.530442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.242:2380"]} {"level":"info","ts":"2026-10-15T11:11:48.530462Z","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-10-15T11:11:48.531149Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.242:2379"]} {"level":"info","ts":"2026-10-15T11:11:48.531231Z","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":16,"max-cpu-available":16,"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://162.253.55.242:2380"],"listen-peer-urls":["https://162.253.55.242:2380"],"advertise-client-urls":["https://162.253.55.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.242:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-15T11:11:48.536658Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.174984ms"} {"level":"info","ts":"2026-10-15T11:11:48.544636Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cc70bec9404419f6","cluster-id":"38671954b404c50e"} {"level":"info","ts":"2026-10-15T11:11:48.544733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T11:11:48.544753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became follower at term 0"} {"level":"info","ts":"2026-10-15T11:11:48.544763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cc70bec9404419f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T11:11:48.544769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became follower at term 1"} {"level":"info","ts":"2026-10-15T11:11:48.544806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 switched to configuration voters=(14731484152704801270)"} {"level":"warn","ts":"2026-10-15T11:11:48.554973Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T11:11:48.557444Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T11:11:48.558899Z","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-10-15T11:11:48.560882Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cc70bec9404419f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T11:11:48.561185Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cc70bec9404419f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T11:11:48.56126Z","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-10-15T11:11:48.561376Z","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-10-15T11:11:48.561395Z","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-10-15T11:11:48.565465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 switched to configuration voters=(14731484152704801270)"} {"level":"info","ts":"2026-10-15T11:11:48.565707Z","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-10-15T11:11:48.565752Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"38671954b404c50e","local-member-id":"cc70bec9404419f6","added-peer-id":"cc70bec9404419f6","added-peer-peer-urls":["https://162.253.55.242:2380"]} {"level":"info","ts":"2026-10-15T11:11:48.565846Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.242:2380"} {"level":"info","ts":"2026-10-15T11:11:48.565881Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.242:2380"} {"level":"info","ts":"2026-10-15T11:11:48.56599Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cc70bec9404419f6","initial-advertise-peer-urls":["https://162.253.55.242:2380"],"listen-peer-urls":["https://162.253.55.242:2380"],"advertise-client-urls":["https://162.253.55.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T11:11:48.566044Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T11:11:49.245125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T11:11:49.245223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T11:11:49.245245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 received MsgPreVoteResp from cc70bec9404419f6 at term 1"} {"level":"info","ts":"2026-10-15T11:11:49.245264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became candidate at term 2"} {"level":"info","ts":"2026-10-15T11:11:49.245274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 received MsgVoteResp from cc70bec9404419f6 at term 2"} {"level":"info","ts":"2026-10-15T11:11:49.245289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became leader at term 2"} {"level":"info","ts":"2026-10-15T11:11:49.245301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cc70bec9404419f6 elected leader cc70bec9404419f6 at term 2"} {"level":"info","ts":"2026-10-15T11:11:49.24696Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cc70bec9404419f6","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.242:2379]}","request-path":"/0/members/cc70bec9404419f6/attributes","cluster-id":"38671954b404c50e","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T11:11:49.246946Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:49.246973Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:11:49.247067Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:11:49.247344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T11:11:49.247506Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T11:11:49.248402Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"38671954b404c50e","local-member-id":"cc70bec9404419f6","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:49.248479Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:49.248502Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:49.250015Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.242:2379"} {"level":"info","ts":"2026-10-15T11:11:49.250958Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T11:12:17.175075Z","caller":"traceutil/trace.go:171","msg":"trace[763212064] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"210.72109ms","start":"2026-10-15T11:12:16.964326Z","end":"2026-10-15T11:12:17.175047Z","steps":["trace[763212064] 'process raft request' (duration: 210.309229ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:40.483714Z","caller":"traceutil/trace.go:171","msg":"trace[1036740229] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"221.46683ms","start":"2026-10-15T11:12:40.262187Z","end":"2026-10-15T11:12:40.483654Z","steps":["trace[1036740229] 'process raft request' (duration: 188.643183ms)","trace[1036740229] 'compare' (duration: 32.662123ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:41.978218Z","caller":"traceutil/trace.go:171","msg":"trace[2085761312] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"137.418107ms","start":"2026-10-15T11:12:41.840774Z","end":"2026-10-15T11:12:41.978192Z","steps":["trace[2085761312] 'read index received' (duration: 137.198301ms)","trace[2085761312] 'applied index is now lower than readState.Index' (duration: 218.796µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:41.97836Z","caller":"traceutil/trace.go:171","msg":"trace[1640140263] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"173.240631ms","start":"2026-10-15T11:12:41.805082Z","end":"2026-10-15T11:12:41.978323Z","steps":["trace[1640140263] 'process raft request' (duration: 172.952504ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:41.978501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.703394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j6sxw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T11:12:41.978592Z","caller":"traceutil/trace.go:171","msg":"trace[200212254] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j6sxw; range_end:; response_count:1; response_revision:612; }","duration":"137.829897ms","start":"2026-10-15T11:12:41.840734Z","end":"2026-10-15T11:12:41.978564Z","steps":["trace[200212254] 'agreement among raft nodes before linearized reading' (duration: 137.579001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:42.53961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.409695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:12:42.539799Z","caller":"traceutil/trace.go:171","msg":"trace[1202781171] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"540.22943ms","start":"2026-10-15T11:12:41.999529Z","end":"2026-10-15T11:12:42.539758Z","steps":["trace[1202781171] 'process raft request' (duration: 175.8786ms)","trace[1202781171] 'compare' (duration: 363.235701ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:42.539887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:41.999504Z","time spent":"540.337653ms","remote":"127.0.0.1:56690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:12:42.588254Z","caller":"traceutil/trace.go:171","msg":"trace[1201274385] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"553.63244ms","start":"2026-10-15T11:12:42.034563Z","end":"2026-10-15T11:12:42.588195Z","steps":["trace[1201274385] 'process raft request' (duration: 553.208189ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:42.588629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:42.034527Z","time spent":"553.905287ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:12:42.589518Z","caller":"traceutil/trace.go:171","msg":"trace[589800370] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:633; }","duration":"510.398941ms","start":"2026-10-15T11:12:42.079077Z","end":"2026-10-15T11:12:42.589475Z","steps":["trace[589800370] 'read index received' (duration: 96.403306ms)","trace[589800370] 'applied index is now lower than readState.Index' (duration: 413.993685ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:42.58973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.601597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:12:42.589786Z","caller":"traceutil/trace.go:171","msg":"trace[2004393279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"510.71158ms","start":"2026-10-15T11:12:42.079057Z","end":"2026-10-15T11:12:42.589769Z","steps":["trace[2004393279] 'agreement among raft nodes before linearized reading' (duration: 510.565666ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:42.589837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:42.078972Z","time spent":"510.852733ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T11:12:42.589841Z","caller":"traceutil/trace.go:171","msg":"trace[420404626] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"536.431611ms","start":"2026-10-15T11:12:42.05338Z","end":"2026-10-15T11:12:42.589812Z","steps":["trace[420404626] 'process raft request' (duration: 534.891831ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:42.590003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:42.053341Z","time spent":"536.559274ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:12:43.431248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.479878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:12:43.431362Z","caller":"traceutil/trace.go:171","msg":"trace[748560184] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"606.589361ms","start":"2026-10-15T11:12:42.824756Z","end":"2026-10-15T11:12:43.431346Z","steps":["trace[748560184] 'read index received' (duration: 496.722333ms)","trace[748560184] 'applied index is now lower than readState.Index' (duration: 109.865428ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:43.431448Z","caller":"traceutil/trace.go:171","msg":"trace[1310598845] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"767.818979ms","start":"2026-10-15T11:12:42.663617Z","end":"2026-10-15T11:12:43.431436Z","steps":["trace[1310598845] 'process raft request' (duration: 657.89908ms)","trace[1310598845] 'compare' (duration: 109.095168ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:43.431732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.218169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T11:12:43.431788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:42.663583Z","time spent":"768.162678ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T11:12:43.431777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.997851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.242\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-10-15T11:12:43.431801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.175801ms","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-10-15T11:12:43.431865Z","caller":"traceutil/trace.go:171","msg":"trace[1849417001] range","detail":"{range_begin:/registry/masterleases/162.253.55.242; range_end:; response_count:1; response_revision:616; }","duration":"607.131945ms","start":"2026-10-15T11:12:42.824704Z","end":"2026-10-15T11:12:43.431836Z","steps":["trace[1849417001] 'agreement among raft nodes before linearized reading' (duration: 606.865778ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:43.431856Z","caller":"traceutil/trace.go:171","msg":"trace[1913334628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"353.427514ms","start":"2026-10-15T11:12:43.078392Z","end":"2026-10-15T11:12:43.431819Z","steps":["trace[1913334628] 'agreement among raft nodes before linearized reading' (duration: 353.156397ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:43.431915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:42.82466Z","time spent":"607.243178ms","remote":"127.0.0.1:56538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.242\" "} {"level":"warn","ts":"2026-10-15T11:12:43.431941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:43.078368Z","time spent":"353.554818ms","remote":"127.0.0.1:56490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T11:12:43.431879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.845999ms","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-10-15T11:12:43.432086Z","caller":"traceutil/trace.go:171","msg":"trace[1641770768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"125.122935ms","start":"2026-10-15T11:12:43.306919Z","end":"2026-10-15T11:12:43.432042Z","steps":["trace[1641770768] 'agreement among raft nodes before linearized reading' (duration: 124.706994ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:43.431895Z","caller":"traceutil/trace.go:171","msg":"trace[1850061913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"101.301524ms","start":"2026-10-15T11:12:43.330571Z","end":"2026-10-15T11:12:43.431873Z","steps":["trace[1850061913] 'agreement among raft nodes before linearized reading' (duration: 100.990126ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:59.329543Z","caller":"traceutil/trace.go:171","msg":"trace[985359220] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"251.777682ms","start":"2026-10-15T11:12:59.077744Z","end":"2026-10-15T11:12:59.329521Z","steps":["trace[985359220] 'read index received' (duration: 251.589687ms)","trace[985359220] 'applied index is now lower than readState.Index' (duration: 187.175µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:59.329614Z","caller":"traceutil/trace.go:171","msg":"trace[1183119876] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"370.653974ms","start":"2026-10-15T11:12:58.958934Z","end":"2026-10-15T11:12:59.329588Z","steps":["trace[1183119876] 'process raft request' (duration: 370.448709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:59.329657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.908315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:12:59.329708Z","caller":"traceutil/trace.go:171","msg":"trace[535993209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"252.029038ms","start":"2026-10-15T11:12:59.07767Z","end":"2026-10-15T11:12:59.329699Z","steps":["trace[535993209] 'agreement among raft nodes before linearized reading' (duration: 251.945296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:59.329777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:58.958907Z","time spent":"370.762896ms","remote":"127.0.0.1:56690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:14:16.092299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.714544Z","time spent":"377.746801ms","remote":"127.0.0.1:60518","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-15T11:14:16.092758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.994778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:14:16.092834Z","caller":"traceutil/trace.go:171","msg":"trace[1033078866] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1912; }","duration":"754.047206ms","start":"2026-10-15T11:14:15.338772Z","end":"2026-10-15T11:14:16.092819Z","steps":["trace[1033078866] 'read index received' (duration: 88.879614ms)","trace[1033078866] 'applied index is now lower than readState.Index' (duration: 665.166272ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:14:16.092918Z","caller":"traceutil/trace.go:171","msg":"trace[1396554228] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"824.329915ms","start":"2026-10-15T11:14:15.268578Z","end":"2026-10-15T11:14:16.092908Z","steps":["trace[1396554228] 'process raft request' (duration: 159.082681ms)","trace[1396554228] 'compare' (duration: 664.669149ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:14:16.092964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.268547Z","time spent":"824.391016ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:14:16.093103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.643381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2b3c574-fc13-4cf0-aa1d-d27f7f8376db\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-15T11:14:16.093138Z","caller":"traceutil/trace.go:171","msg":"trace[1229288304] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2b3c574-fc13-4cf0-aa1d-d27f7f8376db; range_end:; response_count:1; response_revision:1843; }","duration":"135.709402ms","start":"2026-10-15T11:14:15.957419Z","end":"2026-10-15T11:14:16.093128Z","steps":["trace[1229288304] 'agreement among raft nodes before linearized reading' (duration: 135.612929ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.093289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.242306ms","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-10-15T11:14:16.093362Z","caller":"traceutil/trace.go:171","msg":"trace[37770505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1843; }","duration":"106.344048ms","start":"2026-10-15T11:14:15.986994Z","end":"2026-10-15T11:14:16.093338Z","steps":["trace[37770505] 'agreement among raft nodes before linearized reading' (duration: 106.097812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.093403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.725062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:14:16.093519Z","caller":"traceutil/trace.go:171","msg":"trace[656235770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1843; }","duration":"198.901116ms","start":"2026-10-15T11:14:15.894588Z","end":"2026-10-15T11:14:16.093489Z","steps":["trace[656235770] 'agreement among raft nodes before linearized reading' (duration: 198.611159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.093579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.786075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2b3c574-fc13-4cf0-aa1d-d27f7f8376db\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-15T11:14:16.09365Z","caller":"traceutil/trace.go:171","msg":"trace[163452878] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2b3c574-fc13-4cf0-aa1d-d27f7f8376db; range_end:; response_count:1; response_revision:1843; }","duration":"754.924168ms","start":"2026-10-15T11:14:15.338699Z","end":"2026-10-15T11:14:16.093624Z","steps":["trace[163452878] 'agreement among raft nodes before linearized reading' (duration: 754.604229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.093682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.338677Z","time spent":"754.9957ms","remote":"127.0.0.1:56690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2b3c574-fc13-4cf0-aa1d-d27f7f8376db\" "} {"level":"warn","ts":"2026-10-15T11:14:16.094315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.075307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T11:14:16.094376Z","caller":"traceutil/trace.go:171","msg":"trace[1671854263] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1843; }","duration":"205.235341ms","start":"2026-10-15T11:14:15.889121Z","end":"2026-10-15T11:14:16.094357Z","steps":["trace[1671854263] 'agreement among raft nodes before linearized reading' (duration: 203.824504ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.307982Z","caller":"traceutil/trace.go:171","msg":"trace[194113511] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"208.62345ms","start":"2026-10-15T11:14:16.09933Z","end":"2026-10-15T11:14:16.307954Z","steps":["trace[194113511] 'process raft request' (duration: 181.662969ms)","trace[194113511] 'compare' (duration: 26.677004ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:14:16.308007Z","caller":"traceutil/trace.go:171","msg":"trace[1768218821] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"208.195029ms","start":"2026-10-15T11:14:16.099778Z","end":"2026-10-15T11:14:16.307973Z","steps":["trace[1768218821] 'process raft request' (duration: 208.064295ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.308074Z","caller":"traceutil/trace.go:171","msg":"trace[1263482713] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1914; }","duration":"144.07944ms","start":"2026-10-15T11:14:16.163963Z","end":"2026-10-15T11:14:16.308043Z","steps":["trace[1263482713] 'read index received' (duration: 117.088778ms)","trace[1263482713] 'applied index is now lower than readState.Index' (duration: 26.989192ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:14:16.308438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.46561ms","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-10-15T11:14:16.308483Z","caller":"traceutil/trace.go:171","msg":"trace[1881247889] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1847; }","duration":"144.579583ms","start":"2026-10-15T11:14:16.163892Z","end":"2026-10-15T11:14:16.308472Z","steps":["trace[1881247889] 'agreement among raft nodes before linearized reading' (duration: 144.243504ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.308249Z","caller":"traceutil/trace.go:171","msg":"trace[1067859467] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"205.522389ms","start":"2026-10-15T11:14:16.1027Z","end":"2026-10-15T11:14:16.308223Z","steps":["trace[1067859467] 'process raft request' (duration: 205.18694ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.606822Z","caller":"traceutil/trace.go:171","msg":"trace[2134313896] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"233.853437ms","start":"2026-10-15T11:14:16.372928Z","end":"2026-10-15T11:14:16.606782Z","steps":["trace[2134313896] 'process raft request' (duration: 233.086487ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.60786Z","caller":"traceutil/trace.go:171","msg":"trace[1483803715] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1918; }","duration":"133.545576ms","start":"2026-10-15T11:14:16.474294Z","end":"2026-10-15T11:14:16.607839Z","steps":["trace[1483803715] 'read index received' (duration: 131.737129ms)","trace[1483803715] 'applied index is now lower than readState.Index' (duration: 1.807607ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:14:16.607924Z","caller":"traceutil/trace.go:171","msg":"trace[424372972] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"148.809153ms","start":"2026-10-15T11:14:16.459096Z","end":"2026-10-15T11:14:16.607905Z","steps":["trace[424372972] 'process raft request' (duration: 148.570077ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.608047Z","caller":"traceutil/trace.go:171","msg":"trace[1649266507] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"145.172428ms","start":"2026-10-15T11:14:16.462841Z","end":"2026-10-15T11:14:16.608014Z","steps":["trace[1649266507] 'process raft request' (duration: 144.955223ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.608219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.918556ms","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-10-15T11:14:16.608276Z","caller":"traceutil/trace.go:171","msg":"trace[653282149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1851; }","duration":"134.024859ms","start":"2026-10-15T11:14:16.474236Z","end":"2026-10-15T11:14:16.608261Z","steps":["trace[653282149] 'agreement among raft nodes before linearized reading' (duration: 133.70514ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:01.512924Z","caller":"traceutil/trace.go:171","msg":"trace[1938058723] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2227; }","duration":"110.094701ms","start":"2026-10-15T11:15:01.402788Z","end":"2026-10-15T11:15:01.512882Z","steps":["trace[1938058723] 'read index received' (duration: 56.632672ms)","trace[1938058723] 'applied index is now lower than readState.Index' (duration: 53.460399ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:01.512961Z","caller":"traceutil/trace.go:171","msg":"trace[203877981] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"360.269411ms","start":"2026-10-15T11:15:01.152641Z","end":"2026-10-15T11:15:01.51291Z","steps":["trace[203877981] 'process raft request' (duration: 306.76758ms)","trace[203877981] 'compare' (duration: 53.278115ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:15:01.5132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:01.152617Z","time spent":"360.449396ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:01.513209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.417389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T11:15:01.51329Z","caller":"traceutil/trace.go:171","msg":"trace[907202257] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2149; }","duration":"110.561943ms","start":"2026-10-15T11:15:01.402706Z","end":"2026-10-15T11:15:01.513268Z","steps":["trace[907202257] 'agreement among raft nodes before linearized reading' (duration: 110.293116ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:02.526476Z","caller":"traceutil/trace.go:171","msg":"trace[322236718] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"113.372084ms","start":"2026-10-15T11:15:02.41306Z","end":"2026-10-15T11:15:02.526432Z","steps":["trace[322236718] 'process raft request' (duration: 113.108537ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.724087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.813969ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:02.724245Z","caller":"traceutil/trace.go:171","msg":"trace[1582149342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2150; }","duration":"176.012824ms","start":"2026-10-15T11:15:02.548211Z","end":"2026-10-15T11:15:02.724224Z","steps":["trace[1582149342] 'range keys from in-memory index tree' (duration: 175.798888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.724324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.863057ms","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-10-15T11:15:02.724432Z","caller":"traceutil/trace.go:171","msg":"trace[1207482270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2150; }","duration":"102.034132ms","start":"2026-10-15T11:15:02.622371Z","end":"2026-10-15T11:15:02.724405Z","steps":["trace[1207482270] 'range keys from in-memory index tree' (duration: 101.605841ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.724457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.48835ms","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":"info","ts":"2026-10-15T11:15:02.724603Z","caller":"traceutil/trace.go:171","msg":"trace[494104151] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2150; }","duration":"160.702845ms","start":"2026-10-15T11:15:02.563854Z","end":"2026-10-15T11:15:02.724557Z","steps":["trace[494104151] 'count revisions from in-memory index tree' (duration: 160.358727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.724812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.615489ms","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-10-15T11:15:02.72492Z","caller":"traceutil/trace.go:171","msg":"trace[655726629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2150; }","duration":"136.761883ms","start":"2026-10-15T11:15:02.588134Z","end":"2026-10-15T11:15:02.724896Z","steps":["trace[655726629] 'range keys from in-memory index tree' (duration: 135.951682ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:02.957589Z","caller":"traceutil/trace.go:171","msg":"trace[281026577] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"107.938875ms","start":"2026-10-15T11:15:02.849626Z","end":"2026-10-15T11:15:02.957565Z","steps":["trace[281026577] 'process raft request' (duration: 107.75293ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.859243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1870859988295700981,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T11:15:09.062501Z","caller":"traceutil/trace.go:171","msg":"trace[711499362] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"793.96786ms","start":"2026-10-15T11:15:08.268507Z","end":"2026-10-15T11:15:09.062475Z","steps":["trace[711499362] 'process raft request' (duration: 793.806666ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.062665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.268481Z","time spent":"794.096313ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:15:09.122342Z","caller":"traceutil/trace.go:171","msg":"trace[253790108] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"291.960726ms","start":"2026-10-15T11:15:08.83035Z","end":"2026-10-15T11:15:09.122311Z","steps":["trace[253790108] 'process raft request' (duration: 291.780271ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.122479Z","caller":"traceutil/trace.go:171","msg":"trace[1530690289] linearizableReadLoop","detail":"{readStateIndex:2265; appliedIndex:2262; }","duration":"764.32394ms","start":"2026-10-15T11:15:08.358145Z","end":"2026-10-15T11:15:09.122469Z","steps":["trace[1530690289] 'read index received' (duration: 704.177447ms)","trace[1530690289] 'applied index is now lower than readState.Index' (duration: 60.145483ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:09.12258Z","caller":"traceutil/trace.go:171","msg":"trace[417599444] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"255.883578ms","start":"2026-10-15T11:15:08.866687Z","end":"2026-10-15T11:15:09.122571Z","steps":["trace[417599444] 'process raft request' (duration: 255.594611ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.122343Z","caller":"traceutil/trace.go:171","msg":"trace[381355887] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"256.282729ms","start":"2026-10-15T11:15:08.866038Z","end":"2026-10-15T11:15:09.12232Z","steps":["trace[381355887] 'process raft request' (duration: 256.206787ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.12282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.661428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18deafb3c3d85344\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-10-15T11:15:09.122897Z","caller":"traceutil/trace.go:171","msg":"trace[1888233096] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18deafb3c3d85344; range_end:; response_count:1; response_revision:2186; }","duration":"764.777861ms","start":"2026-10-15T11:15:08.358094Z","end":"2026-10-15T11:15:09.122872Z","steps":["trace[1888233096] 'agreement among raft nodes before linearized reading' (duration: 764.559856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.122923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.381724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-15T11:15:09.122943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.358074Z","time spent":"764.855484ms","remote":"127.0.0.1:56584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18deafb3c3d85344\" "} {"level":"warn","ts":"2026-10-15T11:15:09.122922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.184489ms","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-10-15T11:15:09.123Z","caller":"traceutil/trace.go:171","msg":"trace[2084934233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2186; }","duration":"569.456736ms","start":"2026-10-15T11:15:08.553512Z","end":"2026-10-15T11:15:09.122968Z","steps":["trace[2084934233] 'agreement among raft nodes before linearized reading' (duration: 569.24346ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.123006Z","caller":"traceutil/trace.go:171","msg":"trace[1630702329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2186; }","duration":"325.315762ms","start":"2026-10-15T11:15:08.797669Z","end":"2026-10-15T11:15:09.122985Z","steps":["trace[1630702329] 'agreement among raft nodes before linearized reading' (duration: 325.109277ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.123042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.797647Z","time spent":"325.386975ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-15T11:15:09.123042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.553456Z","time spent":"569.574489ms","remote":"127.0.0.1:56796","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-10-15T11:15:09.123048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.095374ms","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-10-15T11:15:09.123106Z","caller":"traceutil/trace.go:171","msg":"trace[434061356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2186; }","duration":"323.180147ms","start":"2026-10-15T11:15:08.799913Z","end":"2026-10-15T11:15:09.123093Z","steps":["trace[434061356] 'agreement among raft nodes before linearized reading' (duration: 323.031983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.12314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.251563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-10-15T11:15:09.123206Z","caller":"traceutil/trace.go:171","msg":"trace[1690123357] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2186; }","duration":"449.362526ms","start":"2026-10-15T11:15:08.673827Z","end":"2026-10-15T11:15:09.123189Z","steps":["trace[1690123357] 'agreement among raft nodes before linearized reading' (duration: 449.175281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.123247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.367872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-10-15T11:15:09.123281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.673804Z","time spent":"449.438298ms","remote":"127.0.0.1:56690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12408,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-15T11:15:09.123151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.799901Z","time spent":"323.238788ms","remote":"127.0.0.1:56796","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-10-15T11:15:09.123323Z","caller":"traceutil/trace.go:171","msg":"trace[963351761] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2186; }","duration":"552.469504ms","start":"2026-10-15T11:15:08.57083Z","end":"2026-10-15T11:15:09.123299Z","steps":["trace[963351761] 'agreement among raft nodes before linearized reading' (duration: 552.30785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.123371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.57081Z","time spent":"552.550097ms","remote":"127.0.0.1:53072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-15T11:15:09.123384Z","caller":"traceutil/trace.go:171","msg":"trace[138850996] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"102.105813ms","start":"2026-10-15T11:15:09.021254Z","end":"2026-10-15T11:15:09.12336Z","steps":["trace[138850996] 'process raft request' (duration: 101.173479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.123228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.465218ms","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-10-15T11:15:09.12349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.318205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-15T11:15:09.123502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.146956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:15:09.123547Z","caller":"traceutil/trace.go:171","msg":"trace[2119557222] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2186; }","duration":"552.214299ms","start":"2026-10-15T11:15:08.571321Z","end":"2026-10-15T11:15:09.123536Z","steps":["trace[2119557222] 'agreement among raft nodes before linearized reading' (duration: 551.796618ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.123553Z","caller":"traceutil/trace.go:171","msg":"trace[1560319078] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2186; }","duration":"362.433297ms","start":"2026-10-15T11:15:08.761099Z","end":"2026-10-15T11:15:09.123533Z","steps":["trace[1560319078] 'agreement among raft nodes before linearized reading' (duration: 361.970535ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.123579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.571311Z","time spent":"552.257289ms","remote":"127.0.0.1:56700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":15,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-10-15T11:15:09.123502Z","caller":"traceutil/trace.go:171","msg":"trace[1439761929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2186; }","duration":"143.899079ms","start":"2026-10-15T11:15:08.979583Z","end":"2026-10-15T11:15:09.123482Z","steps":["trace[1439761929] 'agreement among raft nodes before linearized reading' (duration: 143.225782ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.123585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.761077Z","time spent":"362.500139ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-15T11:15:09.27286Z","caller":"traceutil/trace.go:171","msg":"trace[1047040399] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"146.755693ms","start":"2026-10-15T11:15:09.126078Z","end":"2026-10-15T11:15:09.272834Z","steps":["trace[1047040399] 'process raft request' (duration: 145.702516ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.276077Z","caller":"traceutil/trace.go:171","msg":"trace[1859177659] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"148.258543ms","start":"2026-10-15T11:15:09.127802Z","end":"2026-10-15T11:15:09.276061Z","steps":["trace[1859177659] 'process raft request' (duration: 148.127529ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.276254Z","caller":"traceutil/trace.go:171","msg":"trace[1891243339] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"147.559935ms","start":"2026-10-15T11:15:09.128684Z","end":"2026-10-15T11:15:09.276244Z","steps":["trace[1891243339] 'process raft request' (duration: 147.339399ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.276584Z","caller":"traceutil/trace.go:171","msg":"trace[1680756364] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"147.878132ms","start":"2026-10-15T11:15:09.128692Z","end":"2026-10-15T11:15:09.27657Z","steps":["trace[1680756364] 'process raft request' (duration: 147.516003ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.27665Z","caller":"traceutil/trace.go:171","msg":"trace[221062651] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"147.78549ms","start":"2026-10-15T11:15:09.128831Z","end":"2026-10-15T11:15:09.276616Z","steps":["trace[221062651] 'process raft request' (duration: 147.724269ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.276714Z","caller":"traceutil/trace.go:171","msg":"trace[1424865342] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"148.016526ms","start":"2026-10-15T11:15:09.128676Z","end":"2026-10-15T11:15:09.276693Z","steps":["trace[1424865342] 'process raft request' (duration: 147.803461ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:09.276795Z","caller":"traceutil/trace.go:171","msg":"trace[1122099651] linearizableReadLoop","detail":"{readStateIndex:2275; appliedIndex:2268; }","duration":"142.495162ms","start":"2026-10-15T11:15:09.134279Z","end":"2026-10-15T11:15:09.276774Z","steps":["trace[1122099651] 'read index received' (duration: 137.500832ms)","trace[1122099651] 'applied index is now lower than readState.Index' (duration: 4.99329ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:09.276963Z","caller":"traceutil/trace.go:171","msg":"trace[414894951] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"147.592015ms","start":"2026-10-15T11:15:09.12935Z","end":"2026-10-15T11:15:09.276942Z","steps":["trace[414894951] 'process raft request' (duration: 147.238415ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.276994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.706208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:09.27709Z","caller":"traceutil/trace.go:171","msg":"trace[308375701] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2193; }","duration":"142.842731ms","start":"2026-10-15T11:15:09.134235Z","end":"2026-10-15T11:15:09.277077Z","steps":["trace[308375701] 'agreement among raft nodes before linearized reading' (duration: 142.710858ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:09.277265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.37773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:09.277401Z","caller":"traceutil/trace.go:171","msg":"trace[1786136745] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2193; }","duration":"117.542284ms","start":"2026-10-15T11:15:09.159832Z","end":"2026-10-15T11:15:09.277374Z","steps":["trace[1786136745] 'agreement among raft nodes before linearized reading' (duration: 117.361449ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:59.75912Z","caller":"traceutil/trace.go:171","msg":"trace[496468254] linearizableReadLoop","detail":"{readStateIndex:2728; appliedIndex:2727; }","duration":"137.657178ms","start":"2026-10-15T11:15:59.62144Z","end":"2026-10-15T11:15:59.759097Z","steps":["trace[496468254] 'read index received' (duration: 137.469723ms)","trace[496468254] 'applied index is now lower than readState.Index' (duration: 186.465µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:59.759189Z","caller":"traceutil/trace.go:171","msg":"trace[1785790913] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"162.950297ms","start":"2026-10-15T11:15:59.596209Z","end":"2026-10-15T11:15:59.759159Z","steps":["trace[1785790913] 'process raft request' (duration: 162.732891ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:59.759356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.025688ms","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-10-15T11:15:59.75939Z","caller":"traceutil/trace.go:171","msg":"trace[1710449056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2630; }","duration":"105.115329ms","start":"2026-10-15T11:15:59.654266Z","end":"2026-10-15T11:15:59.759382Z","steps":["trace[1710449056] 'agreement among raft nodes before linearized reading' (duration: 104.973365ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:59.759386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.683613ms","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-10-15T11:15:59.75937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.900435ms","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-10-15T11:15:59.759441Z","caller":"traceutil/trace.go:171","msg":"trace[1723466760] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2630; }","duration":"103.753594ms","start":"2026-10-15T11:15:59.655671Z","end":"2026-10-15T11:15:59.759425Z","steps":["trace[1723466760] 'agreement among raft nodes before linearized reading' (duration: 103.632351ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:59.759473Z","caller":"traceutil/trace.go:171","msg":"trace[1384957404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2630; }","duration":"138.030577ms","start":"2026-10-15T11:15:59.621405Z","end":"2026-10-15T11:15:59.759436Z","steps":["trace[1384957404] 'agreement among raft nodes before linearized reading' (duration: 137.782461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:59.759469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.146534ms","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-10-15T11:15:59.759568Z","caller":"traceutil/trace.go:171","msg":"trace[1435764026] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2630; }","duration":"104.279947ms","start":"2026-10-15T11:15:59.655267Z","end":"2026-10-15T11:15:59.759547Z","steps":["trace[1435764026] 'agreement among raft nodes before linearized reading' (duration: 104.01742ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:59.759627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.614067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-15T11:15:59.759682Z","caller":"traceutil/trace.go:171","msg":"trace[1312599519] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2630; }","duration":"104.715309ms","start":"2026-10-15T11:15:59.65495Z","end":"2026-10-15T11:15:59.759665Z","steps":["trace[1312599519] 'agreement among raft nodes before linearized reading' (duration: 104.536365ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:16:05.458906Z","caller":"traceutil/trace.go:171","msg":"trace[1787157441] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"121.080167ms","start":"2026-10-15T11:16:05.337797Z","end":"2026-10-15T11:16:05.458877Z","steps":["trace[1787157441] 'process raft request' (duration: 120.912322ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:16:05.462938Z","caller":"traceutil/trace.go:171","msg":"trace[1072191230] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"121.877838ms","start":"2026-10-15T11:16:05.341044Z","end":"2026-10-15T11:16:05.462921Z","steps":["trace[1072191230] 'process raft request' (duration: 121.765995ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:16:05.463083Z","caller":"traceutil/trace.go:171","msg":"trace[85557521] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"117.573016ms","start":"2026-10-15T11:16:05.34549Z","end":"2026-10-15T11:16:05.463063Z","steps":["trace[85557521] 'process raft request' (duration: 117.398531ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:16:33.197899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.373846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:16:33.198016Z","caller":"traceutil/trace.go:171","msg":"trace[1324129322] linearizableReadLoop","detail":"{readStateIndex:2939; appliedIndex:2938; }","duration":"148.917952ms","start":"2026-10-15T11:16:33.049072Z","end":"2026-10-15T11:16:33.19799Z","steps":["trace[1324129322] 'read index received' (duration: 2.269249ms)","trace[1324129322] 'applied index is now lower than readState.Index' (duration: 146.645823ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:16:33.19815Z","caller":"traceutil/trace.go:171","msg":"trace[1284088909] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"281.428977ms","start":"2026-10-15T11:16:32.916708Z","end":"2026-10-15T11:16:33.198137Z","steps":["trace[1284088909] 'process raft request' (duration: 134.680391ms)","trace[1284088909] 'compare' (duration: 146.13809ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:16:33.198515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.423565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-10-15T11:16:33.198605Z","caller":"traceutil/trace.go:171","msg":"trace[1382086332] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2833; }","duration":"149.555379ms","start":"2026-10-15T11:16:33.049031Z","end":"2026-10-15T11:16:33.198587Z","steps":["trace[1382086332] 'agreement among raft nodes before linearized reading' (duration: 149.283392ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:16:33.198502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.258191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:16:33.19884Z","caller":"traceutil/trace.go:171","msg":"trace[1813888724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2833; }","duration":"121.691723ms","start":"2026-10-15T11:16:33.077136Z","end":"2026-10-15T11:16:33.198827Z","steps":["trace[1813888724] 'agreement among raft nodes before linearized reading' (duration: 121.156269ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:19:27.507938Z","caller":"traceutil/trace.go:171","msg":"trace[3475973] transaction","detail":"{read_only:false; response_revision:3897; number_of_response:1; }","duration":"116.220749ms","start":"2026-10-15T11:19:27.391685Z","end":"2026-10-15T11:19:27.507905Z","steps":["trace[3475973] 'process raft request' (duration: 105.847059ms)","trace[3475973] 'compare' (duration: 10.226336ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:19:27.508348Z","caller":"traceutil/trace.go:171","msg":"trace[1601385513] transaction","detail":"{read_only:false; response_revision:3898; number_of_response:1; }","duration":"113.181989ms","start":"2026-10-15T11:19:27.395129Z","end":"2026-10-15T11:19:27.508311Z","steps":["trace[1601385513] 'process raft request' (duration: 113.050466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:32.371259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.172174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:21:32.371317Z","caller":"traceutil/trace.go:171","msg":"trace[1780114662] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:5339; }","duration":"512.274277ms","start":"2026-10-15T11:21:31.859029Z","end":"2026-10-15T11:21:32.371304Z","steps":["trace[1780114662] 'count revisions from in-memory index tree' (duration: 512.101142ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:32.371346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:21:31.859013Z","time spent":"512.324978ms","remote":"127.0.0.1:56812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":43,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:21:32.371224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.330982ms","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":"warn","ts":"2026-10-15T11:21:32.371409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.948129ms","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":"info","ts":"2026-10-15T11:21:32.371508Z","caller":"traceutil/trace.go:171","msg":"trace[600598167] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5339; }","duration":"448.100352ms","start":"2026-10-15T11:21:31.923385Z","end":"2026-10-15T11:21:32.371485Z","steps":["trace[600598167] 'count revisions from in-memory index tree' (duration: 447.872796ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:32.371563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:21:31.923371Z","time spent":"448.180295ms","remote":"127.0.0.1:37356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:21:32.371706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.189424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b9b90669-0092-4c60-9ad6-04f0784788b2\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T11:21:32.371778Z","caller":"traceutil/trace.go:171","msg":"trace[1741909648] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b9b90669-0092-4c60-9ad6-04f0784788b2; range_end:; response_count:1; response_revision:5339; }","duration":"485.298357ms","start":"2026-10-15T11:21:31.886461Z","end":"2026-10-15T11:21:32.371759Z","steps":["trace[1741909648] 'range keys from in-memory index tree' (duration: 485.00773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:32.371845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:21:31.886439Z","time spent":"485.369369ms","remote":"127.0.0.1:56690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b9b90669-0092-4c60-9ad6-04f0784788b2\" "} {"level":"warn","ts":"2026-10-15T11:21:32.371868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.673477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:21:32.371956Z","caller":"traceutil/trace.go:171","msg":"trace[1182656079] linearizableReadLoop","detail":"{readStateIndex:5540; appliedIndex:5539; }","duration":"294.615912ms","start":"2026-10-15T11:21:32.077327Z","end":"2026-10-15T11:21:32.371943Z","steps":["trace[1182656079] 'read index received' (duration: 155.788951ms)","trace[1182656079] 'applied index is now lower than readState.Index' (duration: 138.825091ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:32.371997Z","caller":"traceutil/trace.go:171","msg":"trace[275988936] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"337.605517ms","start":"2026-10-15T11:21:32.034365Z","end":"2026-10-15T11:21:32.371971Z","steps":["trace[275988936] 'process raft request' (duration: 198.730444ms)","trace[275988936] 'compare' (duration: 138.123013ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:21:32.372136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:21:32.03434Z","time spent":"337.71986ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:21:32.372022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.705664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:21:32.372287Z","caller":"traceutil/trace.go:171","msg":"trace[1448199400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5340; }","duration":"294.989431ms","start":"2026-10-15T11:21:32.077266Z","end":"2026-10-15T11:21:32.372256Z","steps":["trace[1448199400] 'agreement among raft nodes before linearized reading' (duration: 294.718574ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:32.37162Z","caller":"traceutil/trace.go:171","msg":"trace[832000033] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:5339; }","duration":"356.62618ms","start":"2026-10-15T11:21:32.014781Z","end":"2026-10-15T11:21:32.371407Z","steps":["trace[832000033] 'count revisions from in-memory index tree' (duration: 356.224819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:32.372384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:21:32.014757Z","time spent":"357.603026ms","remote":"127.0.0.1:47826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:21:32.372642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.288619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786928"} {"level":"info","ts":"2026-10-15T11:21:32.372702Z","caller":"traceutil/trace.go:171","msg":"trace[813162339] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5339; }","duration":"497.36881ms","start":"2026-10-15T11:21:31.87532Z","end":"2026-10-15T11:21:32.372689Z","steps":["trace[813162339] 'range keys from in-memory index tree' (duration: 496.348143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:32.372767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:21:31.875312Z","time spent":"497.413211ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":786951,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-10-15T11:21:32.863064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.261662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:21:32.863161Z","caller":"traceutil/trace.go:171","msg":"trace[731070046] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5341; }","duration":"230.657353ms","start":"2026-10-15T11:21:32.632479Z","end":"2026-10-15T11:21:32.863136Z","steps":["trace[731070046] 'count revisions from in-memory index tree' (duration: 230.143849ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:32.925692Z","caller":"traceutil/trace.go:171","msg":"trace[469297815] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"202.973674ms","start":"2026-10-15T11:21:32.722696Z","end":"2026-10-15T11:21:32.92567Z","steps":["trace[469297815] 'process raft request' (duration: 202.356458ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:32.932509Z","caller":"traceutil/trace.go:171","msg":"trace[426899409] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"181.672002ms","start":"2026-10-15T11:21:32.750798Z","end":"2026-10-15T11:21:32.93247Z","steps":["trace[426899409] 'process raft request' (duration: 181.465367ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:43.78619Z","caller":"traceutil/trace.go:171","msg":"trace[134422042] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"146.769267ms","start":"2026-10-15T11:21:43.639394Z","end":"2026-10-15T11:21:43.786163Z","steps":["trace[134422042] 'process raft request' (duration: 79.468931ms)","trace[134422042] 'compare' (duration: 67.012888ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:49.280114Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2921} {"level":"info","ts":"2026-10-15T11:21:49.355379Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2921,"took":"73.966959ms","hash":1502901575,"current-db-size-bytes":54251520,"current-db-size":"54 MB","current-db-size-in-use-bytes":31019008,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T11:21:49.355449Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1502901575,"revision":2921,"compact-revision":-1} {"level":"info","ts":"2026-10-15T11:21:50.9225Z","caller":"traceutil/trace.go:171","msg":"trace[1109667452] transaction","detail":"{read_only:false; response_revision:5627; number_of_response:1; }","duration":"187.470223ms","start":"2026-10-15T11:21:50.735004Z","end":"2026-10-15T11:21:50.922474Z","steps":["trace[1109667452] 'process raft request' (duration: 187.390591ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:50.922565Z","caller":"traceutil/trace.go:171","msg":"trace[59446171] transaction","detail":"{read_only:false; response_revision:5626; number_of_response:1; }","duration":"190.526232ms","start":"2026-10-15T11:21:50.732009Z","end":"2026-10-15T11:21:50.922535Z","steps":["trace[59446171] 'process raft request' (duration: 117.710773ms)","trace[59446171] 'compare' (duration: 72.519892ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:21:53.017469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.938749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1042ca80-56d6-46c0-ab2a-945314f2a9f4\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-10-15T11:21:53.017485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.152455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-15T11:21:53.017553Z","caller":"traceutil/trace.go:171","msg":"trace[1152495384] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1042ca80-56d6-46c0-ab2a-945314f2a9f4; range_end:; response_count:1; response_revision:5710; }","duration":"145.074893ms","start":"2026-10-15T11:21:52.872458Z","end":"2026-10-15T11:21:53.017533Z","steps":["trace[1152495384] 'range keys from in-memory index tree' (duration: 144.797456ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:53.017577Z","caller":"traceutil/trace.go:171","msg":"trace[1584389377] range","detail":"{range_begin:/registry/masterleases/162.253.55.242; range_end:; response_count:1; response_revision:5710; }","duration":"162.292629ms","start":"2026-10-15T11:21:52.855262Z","end":"2026-10-15T11:21:53.017555Z","steps":["trace[1584389377] 'range keys from in-memory index tree' (duration: 161.93867ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:53.284008Z","caller":"traceutil/trace.go:171","msg":"trace[520827368] linearizableReadLoop","detail":"{readStateIndex:5926; appliedIndex:5922; }","duration":"206.549297ms","start":"2026-10-15T11:21:53.077431Z","end":"2026-10-15T11:21:53.28398Z","steps":["trace[520827368] 'read index received' (duration: 8.4591ms)","trace[520827368] 'applied index is now lower than readState.Index' (duration: 198.089117ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:21:53.284148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.687551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:21:53.284133Z","caller":"traceutil/trace.go:171","msg":"trace[718329535] transaction","detail":"{read_only:false; response_revision:5713; number_of_response:1; }","duration":"215.206992ms","start":"2026-10-15T11:21:53.068889Z","end":"2026-10-15T11:21:53.284096Z","steps":["trace[718329535] 'process raft request' (duration: 214.988517ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:53.284237Z","caller":"traceutil/trace.go:171","msg":"trace[1022100680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5714; }","duration":"206.779774ms","start":"2026-10-15T11:21:53.0774Z","end":"2026-10-15T11:21:53.284179Z","steps":["trace[1022100680] 'agreement among raft nodes before linearized reading' (duration: 206.687301ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:53.284248Z","caller":"traceutil/trace.go:171","msg":"trace[1132823507] transaction","detail":"{read_only:false; response_revision:5714; number_of_response:1; }","duration":"212.219165ms","start":"2026-10-15T11:21:53.072Z","end":"2026-10-15T11:21:53.28422Z","steps":["trace[1132823507] 'process raft request' (duration: 211.934397ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:53.284264Z","caller":"traceutil/trace.go:171","msg":"trace[292969039] transaction","detail":"{read_only:false; response_revision:5712; number_of_response:1; }","duration":"236.658699ms","start":"2026-10-15T11:21:53.047526Z","end":"2026-10-15T11:21:53.284185Z","steps":["trace[292969039] 'process raft request' (duration: 236.145105ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:07.652426Z","caller":"traceutil/trace.go:171","msg":"trace[1376815937] transaction","detail":"{read_only:false; response_revision:5911; number_of_response:1; }","duration":"315.623628ms","start":"2026-10-15T11:22:07.336785Z","end":"2026-10-15T11:22:07.652409Z","steps":["trace[1376815937] 'process raft request' (duration: 315.510985ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:07.652549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:07.33676Z","time spent":"315.731401ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:22:07.699001Z","caller":"traceutil/trace.go:171","msg":"trace[924492005] transaction","detail":"{read_only:false; response_revision:5912; number_of_response:1; }","duration":"330.863635ms","start":"2026-10-15T11:22:07.368112Z","end":"2026-10-15T11:22:07.698976Z","steps":["trace[924492005] 'process raft request' (duration: 324.430247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:07.699161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:07.368098Z","time spent":"330.977217ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:22:07.69934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.009664ms","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-10-15T11:22:07.699395Z","caller":"traceutil/trace.go:171","msg":"trace[593464916] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5913; }","duration":"192.113596ms","start":"2026-10-15T11:22:07.507269Z","end":"2026-10-15T11:22:07.699383Z","steps":["trace[593464916] 'agreement among raft nodes before linearized reading' (duration: 191.942032ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:07.69915Z","caller":"traceutil/trace.go:171","msg":"trace[918670328] linearizableReadLoop","detail":"{readStateIndex:6129; appliedIndex:6126; }","duration":"191.799967ms","start":"2026-10-15T11:22:07.507324Z","end":"2026-10-15T11:22:07.699124Z","steps":["trace[918670328] 'read index received' (duration: 144.99476ms)","trace[918670328] 'applied index is now lower than readState.Index' (duration: 46.803757ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:22:07.699184Z","caller":"traceutil/trace.go:171","msg":"trace[1217995929] transaction","detail":"{read_only:false; response_revision:5913; number_of_response:1; }","duration":"301.697976ms","start":"2026-10-15T11:22:07.397457Z","end":"2026-10-15T11:22:07.699155Z","steps":["trace[1217995929] 'process raft request' (duration: 301.45584ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:07.69956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:07.397427Z","time spent":"302.065665ms","remote":"127.0.0.1:56796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:22:54.339513Z","caller":"traceutil/trace.go:171","msg":"trace[875568575] linearizableReadLoop","detail":"{readStateIndex:6531; appliedIndex:6530; }","duration":"152.804084ms","start":"2026-10-15T11:22:54.186679Z","end":"2026-10-15T11:22:54.339483Z","steps":["trace[875568575] 'read index received' (duration: 152.496376ms)","trace[875568575] 'applied index is now lower than readState.Index' (duration: 306.678µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:22:54.339592Z","caller":"traceutil/trace.go:171","msg":"trace[57145222] transaction","detail":"{read_only:false; response_revision:6302; number_of_response:1; }","duration":"177.940188ms","start":"2026-10-15T11:22:54.161622Z","end":"2026-10-15T11:22:54.339562Z","steps":["trace[57145222] 'process raft request' (duration: 177.687871ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:54.339949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.810155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T11:22:54.339951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.200834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-10-15T11:22:54.340002Z","caller":"traceutil/trace.go:171","msg":"trace[1231280956] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:6302; }","duration":"119.895018ms","start":"2026-10-15T11:22:54.220092Z","end":"2026-10-15T11:22:54.339987Z","steps":["trace[1231280956] 'agreement among raft nodes before linearized reading' (duration: 119.811976ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:54.340017Z","caller":"traceutil/trace.go:171","msg":"trace[141393688] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:6302; }","duration":"153.362398ms","start":"2026-10-15T11:22:54.186632Z","end":"2026-10-15T11:22:54.339995Z","steps":["trace[141393688] 'agreement among raft nodes before linearized reading' (duration: 153.079111ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:54.665142Z","caller":"traceutil/trace.go:171","msg":"trace[1682938692] transaction","detail":"{read_only:false; response_revision:6307; number_of_response:1; }","duration":"129.616211ms","start":"2026-10-15T11:22:54.535494Z","end":"2026-10-15T11:22:54.66511Z","steps":["trace[1682938692] 'process raft request' (duration: 68.913482ms)","trace[1682938692] 'compare' (duration: 60.586296ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:26:49.288139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5613} {"level":"info","ts":"2026-10-15T11:26:49.384107Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5613,"took":"94.253098ms","hash":3317992948,"current-db-size-bytes":54251520,"current-db-size":"54 MB","current-db-size-in-use-bytes":26849280,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-15T11:26:49.384204Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3317992948,"revision":5613,"compact-revision":2921}