{"level":"warn","ts":"2026-06-23T04:38:13.202359Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T04:38:13.202497Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-23T04:38:13.202623Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T04:38:13.202638Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-06-23T04:38:13.202662Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T04:38:13.203513Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-06-23T04:38:13.203634Z","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://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-23T04:38:13.206388Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.376183ms"} {"level":"info","ts":"2026-06-23T04:38:13.213058Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-06-23T04:38:13.213141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T04:38:13.213167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-06-23T04:38:13.213179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T04:38:13.213195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-06-23T04:38:13.213232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-06-23T04:38:13.220602Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T04:38:13.222356Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T04:38:13.223894Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-23T04:38:13.226279Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T04:38:13.226746Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T04:38:13.226824Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T04:38:13.22699Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T04:38:13.227008Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T04:38:13.229008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-06-23T04:38:13.229172Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-06-23T04:38:13.233461Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T04:38:13.233647Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-06-23T04:38:13.233716Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-06-23T04:38:13.233879Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T04:38:13.23392Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T04:38:13.614068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T04:38:13.614162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T04:38:13.614198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-06-23T04:38:13.614215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-06-23T04:38:13.614224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-06-23T04:38:13.61424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-06-23T04:38:13.614278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-06-23T04:38:13.615211Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:38:13.616258Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T04:38:13.616251Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T04:38:13.616608Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:38:13.616593Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T04:38:13.616711Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:38:13.616736Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:38:13.61676Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T04:38:13.616771Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T04:38:13.620936Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T04:38:13.625633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"warn","ts":"2026-06-23T04:38:49.196006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.218174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:38:49.196121Z","caller":"traceutil/trace.go:171","msg":"trace[272343402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"263.356257ms","start":"2026-06-23T04:38:48.932749Z","end":"2026-06-23T04:38:49.196105Z","steps":["trace[272343402] 'range keys from in-memory index tree' (duration: 263.125163ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.281765Z","caller":"traceutil/trace.go:171","msg":"trace[1998392793] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"227.595475ms","start":"2026-06-23T04:38:49.054142Z","end":"2026-06-23T04:38:49.281737Z","steps":["trace[1998392793] 'process raft request' (duration: 227.457362ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.392656Z","caller":"traceutil/trace.go:171","msg":"trace[637041920] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"333.927823ms","start":"2026-06-23T04:38:49.058656Z","end":"2026-06-23T04:38:49.392583Z","steps":["trace[637041920] 'process raft request' (duration: 333.454974ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.3927Z","caller":"traceutil/trace.go:171","msg":"trace[856681681] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"333.984224ms","start":"2026-06-23T04:38:49.058676Z","end":"2026-06-23T04:38:49.39266Z","steps":["trace[856681681] 'process raft request' (duration: 333.691288ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393021Z","caller":"traceutil/trace.go:171","msg":"trace[387553006] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"289.919183ms","start":"2026-06-23T04:38:49.103078Z","end":"2026-06-23T04:38:49.392997Z","steps":["trace[387553006] 'process raft request' (duration: 289.631127ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393046Z","caller":"traceutil/trace.go:171","msg":"trace[901456903] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"292.819373ms","start":"2026-06-23T04:38:49.100213Z","end":"2026-06-23T04:38:49.393032Z","steps":["trace[901456903] 'process raft request' (duration: 292.438305ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393029Z","caller":"traceutil/trace.go:171","msg":"trace[37610264] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"297.5158ms","start":"2026-06-23T04:38:49.095475Z","end":"2026-06-23T04:38:49.392991Z","steps":["trace[37610264] 'process raft request' (duration: 296.957108ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393179Z","caller":"traceutil/trace.go:171","msg":"trace[151780299] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"288.34429ms","start":"2026-06-23T04:38:49.104815Z","end":"2026-06-23T04:38:49.39316Z","steps":["trace[151780299] 'process raft request' (duration: 287.958612ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393245Z","caller":"traceutil/trace.go:171","msg":"trace[2026106430] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"272.066514ms","start":"2026-06-23T04:38:49.121173Z","end":"2026-06-23T04:38:49.39324Z","steps":["trace[2026106430] 'process raft request' (duration: 271.826309ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393203Z","caller":"traceutil/trace.go:171","msg":"trace[1074248299] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"279.090809ms","start":"2026-06-23T04:38:49.114103Z","end":"2026-06-23T04:38:49.393193Z","steps":["trace[1074248299] 'process raft request' (duration: 278.764022ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393025Z","caller":"traceutil/trace.go:171","msg":"trace[2069866595] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"296.370386ms","start":"2026-06-23T04:38:49.096546Z","end":"2026-06-23T04:38:49.392916Z","steps":["trace[2069866595] 'process raft request' (duration: 295.952578ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393403Z","caller":"traceutil/trace.go:171","msg":"trace[1294106] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"250.365035ms","start":"2026-06-23T04:38:49.143026Z","end":"2026-06-23T04:38:49.393391Z","steps":["trace[1294106] 'process raft request' (duration: 250.12978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:49.39337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:49.058631Z","time spent":"334.129567ms","remote":"127.0.0.1:35538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T04:38:49.393449Z","caller":"traceutil/trace.go:171","msg":"trace[156462512] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"150.079123ms","start":"2026-06-23T04:38:49.24335Z","end":"2026-06-23T04:38:49.393429Z","steps":["trace[156462512] 'process raft request' (duration: 149.906339ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.393471Z","caller":"traceutil/trace.go:171","msg":"trace[1119965445] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"132.007359ms","start":"2026-06-23T04:38:49.261433Z","end":"2026-06-23T04:38:49.39344Z","steps":["trace[1119965445] 'process raft request' (duration: 131.909317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:49.393661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:49.058658Z","time spent":"334.142847ms","remote":"127.0.0.1:35538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T04:38:49.397167Z","caller":"traceutil/trace.go:171","msg":"trace[650540921] transaction","detail":"{read_only:false; number_of_response:1; response_revision:497; }","duration":"105.172014ms","start":"2026-06-23T04:38:49.291975Z","end":"2026-06-23T04:38:49.397147Z","steps":["trace[650540921] 'process raft request' (duration: 105.134293ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.397202Z","caller":"traceutil/trace.go:171","msg":"trace[482522911] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"106.384019ms","start":"2026-06-23T04:38:49.2908Z","end":"2026-06-23T04:38:49.397184Z","steps":["trace[482522911] 'process raft request' (duration: 106.252427ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:49.397203Z","caller":"traceutil/trace.go:171","msg":"trace[762295643] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"109.042384ms","start":"2026-06-23T04:38:49.288132Z","end":"2026-06-23T04:38:49.397174Z","steps":["trace[762295643] 'process raft request' (duration: 108.786799ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:55.449697Z","caller":"traceutil/trace.go:171","msg":"trace[663286681] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"156.915233ms","start":"2026-06-23T04:38:55.292751Z","end":"2026-06-23T04:38:55.449666Z","steps":["trace[663286681] 'process raft request' (duration: 156.325541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:56.047058Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203138019877417,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T04:38:56.385136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.440193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:38:56.385275Z","caller":"traceutil/trace.go:171","msg":"trace[879755599] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"865.727367ms","start":"2026-06-23T04:38:55.519514Z","end":"2026-06-23T04:38:56.385241Z","steps":["trace[879755599] 'process raft request' (duration: 532.986059ms)","trace[879755599] 'compare' (duration: 332.32406ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:38:56.385302Z","caller":"traceutil/trace.go:171","msg":"trace[952770224] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"105.201693ms","start":"2026-06-23T04:38:56.280089Z","end":"2026-06-23T04:38:56.38529Z","steps":["trace[952770224] 'process raft request' (duration: 105.140822ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:38:56.385323Z","caller":"traceutil/trace.go:171","msg":"trace[1049096085] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"839.094703ms","start":"2026-06-23T04:38:55.546198Z","end":"2026-06-23T04:38:56.385293Z","steps":["trace[1049096085] 'read index received' (duration: 506.207402ms)","trace[1049096085] 'applied index is now lower than readState.Index' (duration: 332.884831ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:38:56.38538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:55.519484Z","time spent":"865.847239ms","remote":"127.0.0.1:35978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T04:38:56.385691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.672946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T04:38:56.386236Z","caller":"traceutil/trace.go:171","msg":"trace[858778728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"696.240787ms","start":"2026-06-23T04:38:55.689972Z","end":"2026-06-23T04:38:56.386213Z","steps":["trace[858778728] 'agreement among raft nodes before linearized reading' (duration: 695.541703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:56.386285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:55.68996Z","time spent":"696.312128ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T04:38:56.385748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.195766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:38:56.386488Z","caller":"traceutil/trace.go:171","msg":"trace[345445391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"455.973912ms","start":"2026-06-23T04:38:55.930479Z","end":"2026-06-23T04:38:56.386453Z","steps":["trace[345445391] 'agreement among raft nodes before linearized reading' (duration: 455.201746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:56.386575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:55.930455Z","time spent":"456.103315ms","remote":"127.0.0.1:35500","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-06-23T04:38:56.3858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.421378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-djbmq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-23T04:38:56.386668Z","caller":"traceutil/trace.go:171","msg":"trace[1579701628] range","detail":"{range_begin:/registry/pods/kube-system/cilium-djbmq; range_end:; response_count:1; response_revision:590; }","duration":"570.307926ms","start":"2026-06-23T04:38:55.816343Z","end":"2026-06-23T04:38:56.386651Z","steps":["trace[1579701628] 'agreement among raft nodes before linearized reading' (duration: 569.396207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:56.38581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.600703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-23T04:38:56.386717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:55.816324Z","time spent":"570.374897ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-djbmq\" "} {"level":"info","ts":"2026-06-23T04:38:56.386753Z","caller":"traceutil/trace.go:171","msg":"trace[1704910567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"840.588184ms","start":"2026-06-23T04:38:55.546149Z","end":"2026-06-23T04:38:56.386737Z","steps":["trace[1704910567] 'agreement among raft nodes before linearized reading' (duration: 839.298277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:38:56.386795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:38:55.546129Z","time spent":"840.646745ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T04:39:04.438079Z","caller":"traceutil/trace.go:171","msg":"trace[145582989] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"110.372942ms","start":"2026-06-23T04:39:04.327678Z","end":"2026-06-23T04:39:04.438051Z","steps":["trace[145582989] 'read index received' (duration: 109.76963ms)","trace[145582989] 'applied index is now lower than readState.Index' (duration: 602.342µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:39:04.438297Z","caller":"traceutil/trace.go:171","msg":"trace[900491304] transaction","detail":"{read_only:false; number_of_response:0; response_revision:694; }","duration":"137.16581ms","start":"2026-06-23T04:39:04.301112Z","end":"2026-06-23T04:39:04.438278Z","steps":["trace[900491304] 'process raft request' (duration: 136.339453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:39:04.438418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.71733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1493"} {"level":"info","ts":"2026-06-23T04:39:04.438506Z","caller":"traceutil/trace.go:171","msg":"trace[1176880440] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:694; }","duration":"110.835142ms","start":"2026-06-23T04:39:04.327653Z","end":"2026-06-23T04:39:04.438488Z","steps":["trace[1176880440] 'agreement among raft nodes before linearized reading' (duration: 110.688799ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:39:04.449326Z","caller":"traceutil/trace.go:171","msg":"trace[722485924] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"117.154709ms","start":"2026-06-23T04:39:04.332131Z","end":"2026-06-23T04:39:04.449286Z","steps":["trace[722485924] 'process raft request' (duration: 116.972255ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:39:23.06544Z","caller":"traceutil/trace.go:171","msg":"trace[1868594975] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"110.275357ms","start":"2026-06-23T04:39:22.955121Z","end":"2026-06-23T04:39:23.065397Z","steps":["trace[1868594975] 'process raft request' (duration: 110.002072ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:39:52.589055Z","caller":"traceutil/trace.go:171","msg":"trace[2138340319] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"360.649229ms","start":"2026-06-23T04:39:52.22838Z","end":"2026-06-23T04:39:52.589029Z","steps":["trace[2138340319] 'process raft request' (duration: 360.474255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:39:52.589418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:39:52.228353Z","time spent":"360.784431ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:17.037125Z","caller":"traceutil/trace.go:171","msg":"trace[2044660582] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1401; }","duration":"106.504186ms","start":"2026-06-23T04:40:16.930601Z","end":"2026-06-23T04:40:17.037105Z","steps":["trace[2044660582] 'read index received' (duration: 76.710463ms)","trace[2044660582] 'applied index is now lower than readState.Index' (duration: 29.792823ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:17.037253Z","caller":"traceutil/trace.go:171","msg":"trace[912425874] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"129.494547ms","start":"2026-06-23T04:40:16.907742Z","end":"2026-06-23T04:40:17.037237Z","steps":["trace[912425874] 'process raft request' (duration: 99.537032ms)","trace[912425874] 'compare' (duration: 29.704511ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:17.037377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.75592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:17.037452Z","caller":"traceutil/trace.go:171","msg":"trace[964926032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1355; }","duration":"106.872623ms","start":"2026-06-23T04:40:16.93056Z","end":"2026-06-23T04:40:17.037433Z","steps":["trace[964926032] 'agreement among raft nodes before linearized reading' (duration: 106.746051ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:31.129048Z","caller":"traceutil/trace.go:171","msg":"trace[1437824834] transaction","detail":"{read_only:false; response_revision:1581; number_of_response:1; }","duration":"105.124909ms","start":"2026-06-23T04:40:31.023889Z","end":"2026-06-23T04:40:31.129014Z","steps":["trace[1437824834] 'process raft request' (duration: 93.373203ms)","trace[1437824834] 'compare' (duration: 11.491992ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:31.270263Z","caller":"traceutil/trace.go:171","msg":"trace[1051602150] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"134.390774ms","start":"2026-06-23T04:40:31.135833Z","end":"2026-06-23T04:40:31.270224Z","steps":["trace[1051602150] 'process raft request' (duration: 122.956973ms)","trace[1051602150] 'compare' (duration: 11.133786ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:31.270322Z","caller":"traceutil/trace.go:171","msg":"trace[1985816530] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"126.454134ms","start":"2026-06-23T04:40:31.143836Z","end":"2026-06-23T04:40:31.27029Z","steps":["trace[1985816530] 'process raft request' (duration: 126.302042ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:31.270283Z","caller":"traceutil/trace.go:171","msg":"trace[1278876791] linearizableReadLoop","detail":"{readStateIndex:1649; appliedIndex:1645; }","duration":"117.016378ms","start":"2026-06-23T04:40:31.153243Z","end":"2026-06-23T04:40:31.270259Z","steps":["trace[1278876791] 'read index received' (duration: 45.566411ms)","trace[1278876791] 'applied index is now lower than readState.Index' (duration: 71.448767ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:31.27046Z","caller":"traceutil/trace.go:171","msg":"trace[450087385] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"126.562616ms","start":"2026-06-23T04:40:31.143869Z","end":"2026-06-23T04:40:31.270432Z","steps":["trace[450087385] 'process raft request' (duration: 126.348962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.270514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.256063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T04:40:31.270592Z","caller":"traceutil/trace.go:171","msg":"trace[1834571127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1585; }","duration":"117.388184ms","start":"2026-06-23T04:40:31.153193Z","end":"2026-06-23T04:40:31.270581Z","steps":["trace[1834571127] 'agreement among raft nodes before linearized reading' (duration: 117.15444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.270622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.930668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:31.270688Z","caller":"traceutil/trace.go:171","msg":"trace[93837637] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1585; }","duration":"108.03616ms","start":"2026-06-23T04:40:31.162635Z","end":"2026-06-23T04:40:31.270671Z","steps":["trace[93837637] 'agreement among raft nodes before linearized reading' (duration: 107.922148ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:39.815486Z","caller":"traceutil/trace.go:171","msg":"trace[991919810] transaction","detail":"{read_only:false; response_revision:1766; number_of_response:1; }","duration":"181.974463ms","start":"2026-06-23T04:40:39.633486Z","end":"2026-06-23T04:40:39.81546Z","steps":["trace[991919810] 'process raft request' (duration: 181.764219ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:39.920758Z","caller":"traceutil/trace.go:171","msg":"trace[860410135] transaction","detail":"{read_only:false; response_revision:1767; number_of_response:1; }","duration":"100.431391ms","start":"2026-06-23T04:40:39.820305Z","end":"2026-06-23T04:40:39.920736Z","steps":["trace[860410135] 'process raft request' (duration: 91.435924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:47.847612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.758398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:40:47.847725Z","caller":"traceutil/trace.go:171","msg":"trace[1152319168] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"418.421346ms","start":"2026-06-23T04:40:47.429287Z","end":"2026-06-23T04:40:47.847709Z","steps":["trace[1152319168] 'read index received' (duration: 57.359672ms)","trace[1152319168] 'applied index is now lower than readState.Index' (duration: 361.060534ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:47.84777Z","caller":"traceutil/trace.go:171","msg":"trace[480877625] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"439.759924ms","start":"2026-06-23T04:40:47.407985Z","end":"2026-06-23T04:40:47.847745Z","steps":["trace[480877625] 'process raft request' (duration: 78.747952ms)","trace[480877625] 'compare' (duration: 360.489943ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:47.84789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.407974Z","time spent":"439.858996ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:47.847904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.611979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-23T04:40:47.847936Z","caller":"traceutil/trace.go:171","msg":"trace[450001389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1883; }","duration":"418.644499ms","start":"2026-06-23T04:40:47.429281Z","end":"2026-06-23T04:40:47.847926Z","steps":["trace[450001389] 'agreement among raft nodes before linearized reading' (duration: 418.499217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:47.847968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.429237Z","time spent":"418.724811ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T04:40:48.781897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.361862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:40:48.781984Z","caller":"traceutil/trace.go:171","msg":"trace[1550801254] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"934.217013ms","start":"2026-06-23T04:40:47.847751Z","end":"2026-06-23T04:40:48.781968Z","steps":["trace[1550801254] 'read index received' (duration: 351.73592ms)","trace[1550801254] 'applied index is now lower than readState.Index' (duration: 582.480093ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:48.782048Z","caller":"traceutil/trace.go:171","msg":"trace[19224779] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"938.346495ms","start":"2026-06-23T04:40:47.843691Z","end":"2026-06-23T04:40:48.782038Z","steps":["trace[19224779] 'process raft request' (duration: 355.777479ms)","trace[19224779] 'compare' (duration: 582.26723ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:48.782096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.843663Z","time spent":"938.407825ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:48.782348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099275107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-23T04:40:48.78238Z","caller":"traceutil/trace.go:171","msg":"trace[163058960] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1884; }","duration":"1.099341867s","start":"2026-06-23T04:40:47.683026Z","end":"2026-06-23T04:40:48.782368Z","steps":["trace[163058960] 'agreement among raft nodes before linearized reading' (duration: 1.099237565s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:48.782403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.683005Z","time spent":"1.099392049s","remote":"127.0.0.1:36568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-23T04:40:48.782497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.353108926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T04:40:48.782605Z","caller":"traceutil/trace.go:171","msg":"trace[1840050195] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1884; }","duration":"1.353250849s","start":"2026-06-23T04:40:47.429329Z","end":"2026-06-23T04:40:48.78258Z","steps":["trace[1840050195] 'agreement among raft nodes before linearized reading' (duration: 1.353010965s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:48.782682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.429305Z","time spent":"1.3533607s","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T04:40:49.576523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.287742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:40:49.576967Z","caller":"traceutil/trace.go:171","msg":"trace[183605664] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"1.719533441s","start":"2026-06-23T04:40:47.857411Z","end":"2026-06-23T04:40:49.576944Z","steps":["trace[183605664] 'process raft request' (duration: 1.71947585s)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.577135Z","caller":"traceutil/trace.go:171","msg":"trace[1815721550] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"1.721377912s","start":"2026-06-23T04:40:47.855696Z","end":"2026-06-23T04:40:49.577074Z","steps":["trace[1815721550] 'process raft request' (duration: 1.721073657s)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.577134Z","caller":"traceutil/trace.go:171","msg":"trace[1796297674] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"1.721345731s","start":"2026-06-23T04:40:47.855746Z","end":"2026-06-23T04:40:49.577092Z","steps":["trace[1796297674] 'process raft request' (duration: 1.721089297s)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.577171Z","caller":"traceutil/trace.go:171","msg":"trace[2091912611] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"1.724022058s","start":"2026-06-23T04:40:47.853109Z","end":"2026-06-23T04:40:49.577131Z","steps":["trace[2091912611] 'process raft request' (duration: 1.061046524s)","trace[2091912611] 'compare' (duration: 662.126379ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:49.577355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.855718Z","time spent":"1.721523515s","remote":"127.0.0.1:35652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:49.577369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.853074Z","time spent":"1.724208362s","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:49.577149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.85739Z","time spent":"1.719683073s","remote":"127.0.0.1:35746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:49.577359Z","caller":"traceutil/trace.go:171","msg":"trace[2041677777] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"1.722190216s","start":"2026-06-23T04:40:47.854787Z","end":"2026-06-23T04:40:49.576977Z","steps":["trace[2041677777] 'process raft request' (duration: 1.721862431s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.57767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.854774Z","time spent":"1.722813807s","remote":"127.0.0.1:35652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:49.577653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.855683Z","time spent":"1.721542425s","remote":"127.0.0.1:35746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:49.589214Z","caller":"traceutil/trace.go:171","msg":"trace[1262443250] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"943.382238ms","start":"2026-06-23T04:40:48.645806Z","end":"2026-06-23T04:40:49.589189Z","steps":["trace[1262443250] 'process raft request' (duration: 943.230035ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.589248Z","caller":"traceutil/trace.go:171","msg":"trace[722052532] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"802.184429ms","start":"2026-06-23T04:40:48.787049Z","end":"2026-06-23T04:40:49.589234Z","steps":["trace[722052532] 'process raft request' (duration: 802.106447ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.589247Z","caller":"traceutil/trace.go:171","msg":"trace[118745175] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"892.631652ms","start":"2026-06-23T04:40:48.696588Z","end":"2026-06-23T04:40:49.58922Z","steps":["trace[118745175] 'process raft request' (duration: 892.53809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.58934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.787028Z","time spent":"802.26795ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:49.589353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.64578Z","time spent":"943.507181ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:49.589377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.69657Z","time spent":"892.738953ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:49.589581Z","caller":"traceutil/trace.go:171","msg":"trace[1212201896] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1959; }","duration":"807.565422ms","start":"2026-06-23T04:40:48.782007Z","end":"2026-06-23T04:40:49.589572Z","steps":["trace[1212201896] 'read index received' (duration: 132.161473ms)","trace[1212201896] 'applied index is now lower than readState.Index' (duration: 675.402579ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:49.589617Z","caller":"traceutil/trace.go:171","msg":"trace[2091645730] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"789.747504ms","start":"2026-06-23T04:40:48.799862Z","end":"2026-06-23T04:40:49.589609Z","steps":["trace[2091645730] 'process raft request' (duration: 789.321527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.589662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.799854Z","time spent":"789.784305ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:49.589722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.365910348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-88b725a1-88a8-4c81-9238-13b582fa1bf3\" ","response":"range_response_count:1 size:3747"} {"level":"warn","ts":"2026-06-23T04:40:49.589729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.656753134s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:49.589748Z","caller":"traceutil/trace.go:171","msg":"trace[1247911005] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-88b725a1-88a8-4c81-9238-13b582fa1bf3; range_end:; response_count:1; response_revision:1893; }","duration":"1.36597303s","start":"2026-06-23T04:40:48.223766Z","end":"2026-06-23T04:40:49.589739Z","steps":["trace[1247911005] 'agreement among raft nodes before linearized reading' (duration: 1.365859038s)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.589757Z","caller":"traceutil/trace.go:171","msg":"trace[1660074463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1893; }","duration":"1.656826046s","start":"2026-06-23T04:40:47.932922Z","end":"2026-06-23T04:40:49.589749Z","steps":["trace[1660074463] 'agreement among raft nodes before linearized reading' (duration: 1.656774965s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.589743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324286189s","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":"warn","ts":"2026-06-23T04:40:49.58977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.223745Z","time spent":"1.36602081s","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-88b725a1-88a8-4c81-9238-13b582fa1bf3\" "} {"level":"warn","ts":"2026-06-23T04:40:49.589775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.932888Z","time spent":"1.656883806s","remote":"127.0.0.1:35500","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-06-23T04:40:49.589745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.353759688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:49.589792Z","caller":"traceutil/trace.go:171","msg":"trace[2102253556] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1893; }","duration":"1.32436974s","start":"2026-06-23T04:40:48.265412Z","end":"2026-06-23T04:40:49.589782Z","steps":["trace[2102253556] 'agreement among raft nodes before linearized reading' (duration: 1.324208607s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.589812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.639095729s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-23T04:40:49.58983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.265399Z","time spent":"1.324426581s","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-23T04:40:49.58985Z","caller":"traceutil/trace.go:171","msg":"trace[562689523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1893; }","duration":"1.63917884s","start":"2026-06-23T04:40:47.950662Z","end":"2026-06-23T04:40:49.58984Z","steps":["trace[562689523] 'agreement among raft nodes before linearized reading' (duration: 1.639045728s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.589873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:47.950635Z","time spent":"1.639234081s","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-23T04:40:49.589842Z","caller":"traceutil/trace.go:171","msg":"trace[1082989661] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1893; }","duration":"1.353920531s","start":"2026-06-23T04:40:48.235893Z","end":"2026-06-23T04:40:49.589813Z","steps":["trace[1082989661] 'agreement among raft nodes before linearized reading' (duration: 1.353705577s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.589932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:48.235876Z","time spent":"1.354040323s","remote":"127.0.0.1:38868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-23T04:40:49.610633Z","caller":"traceutil/trace.go:171","msg":"trace[590673294] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"318.832513ms","start":"2026-06-23T04:40:49.291782Z","end":"2026-06-23T04:40:49.610615Z","steps":["trace[590673294] 'process raft request' (duration: 318.67257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.61078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:49.291758Z","time spent":"318.930044ms","remote":"127.0.0.1:35738","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-06-23T04:40:49.61092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.325089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-23T04:40:49.610953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.105412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T04:40:49.610982Z","caller":"traceutil/trace.go:171","msg":"trace[1709659964] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1895; }","duration":"455.462821ms","start":"2026-06-23T04:40:49.155506Z","end":"2026-06-23T04:40:49.610969Z","steps":["trace[1709659964] 'agreement among raft nodes before linearized reading' (duration: 455.364709ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:49.611003Z","caller":"traceutil/trace.go:171","msg":"trace[1431155273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1895; }","duration":"248.195973ms","start":"2026-06-23T04:40:49.362794Z","end":"2026-06-23T04:40:49.61099Z","steps":["trace[1431155273] 'agreement among raft nodes before linearized reading' (duration: 248.040131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:49.611018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:49.155484Z","time spent":"455.526262ms","remote":"127.0.0.1:35952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-06-23T04:41:03.02939Z","caller":"traceutil/trace.go:171","msg":"trace[1711672432] linearizableReadLoop","detail":"{readStateIndex:2091; appliedIndex:2090; }","duration":"110.268739ms","start":"2026-06-23T04:41:02.919104Z","end":"2026-06-23T04:41:03.029372Z","steps":["trace[1711672432] 'read index received' (duration: 110.077126ms)","trace[1711672432] 'applied index is now lower than readState.Index' (duration: 191.103µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:41:03.029478Z","caller":"traceutil/trace.go:171","msg":"trace[744962371] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"122.302625ms","start":"2026-06-23T04:41:02.907167Z","end":"2026-06-23T04:41:03.02947Z","steps":["trace[744962371] 'process raft request' (duration: 122.071971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:03.029684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.567504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-23T04:41:03.029751Z","caller":"traceutil/trace.go:171","msg":"trace[1436292354] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2013; }","duration":"110.666576ms","start":"2026-06-23T04:41:02.919073Z","end":"2026-06-23T04:41:03.02974Z","steps":["trace[1436292354] 'agreement among raft nodes before linearized reading' (duration: 110.528164ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:35.98128Z","caller":"traceutil/trace.go:171","msg":"trace[1218563828] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"104.008646ms","start":"2026-06-23T04:41:35.877242Z","end":"2026-06-23T04:41:35.981251Z","steps":["trace[1218563828] 'process raft request' (duration: 103.821093ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:35.990241Z","caller":"traceutil/trace.go:171","msg":"trace[103604073] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"112.955155ms","start":"2026-06-23T04:41:35.877265Z","end":"2026-06-23T04:41:35.99022Z","steps":["trace[103604073] 'process raft request' (duration: 112.785772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:36.199366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.339936ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:41:36.200311Z","caller":"traceutil/trace.go:171","msg":"trace[342832929] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"205.524989ms","start":"2026-06-23T04:41:35.994753Z","end":"2026-06-23T04:41:36.200278Z","steps":["trace[342832929] 'process raft request' (duration: 93.193556ms)","trace[342832929] 'compare' (duration: 111.221275ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:41:36.201005Z","caller":"traceutil/trace.go:171","msg":"trace[500209453] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"204.38891ms","start":"2026-06-23T04:41:35.996572Z","end":"2026-06-23T04:41:36.200961Z","steps":["trace[500209453] 'process raft request' (duration: 204.272718ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:36.201047Z","caller":"traceutil/trace.go:171","msg":"trace[549370134] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"205.840925ms","start":"2026-06-23T04:41:35.995139Z","end":"2026-06-23T04:41:36.20098Z","steps":["trace[549370134] 'process raft request' (duration: 204.565873ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:36.201368Z","caller":"traceutil/trace.go:171","msg":"trace[41385425] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"203.82215ms","start":"2026-06-23T04:41:35.997509Z","end":"2026-06-23T04:41:36.201331Z","steps":["trace[41385425] 'process raft request' (duration: 203.735629ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:36.201597Z","caller":"traceutil/trace.go:171","msg":"trace[767909274] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"204.686255ms","start":"2026-06-23T04:41:35.996802Z","end":"2026-06-23T04:41:36.201488Z","steps":["trace[767909274] 'process raft request' (duration: 204.111905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:37.08894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.062601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:41:37.089059Z","caller":"traceutil/trace.go:171","msg":"trace[1203103872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2199; }","duration":"158.225543ms","start":"2026-06-23T04:41:36.930807Z","end":"2026-06-23T04:41:37.089032Z","steps":["trace[1203103872] 'range keys from in-memory index tree' (duration: 157.98886ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:43.36336Z","caller":"traceutil/trace.go:171","msg":"trace[416724243] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"275.182752ms","start":"2026-06-23T04:41:43.088153Z","end":"2026-06-23T04:41:43.363336Z","steps":["trace[416724243] 'process raft request' (duration: 275.0213ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:43.745663Z","caller":"traceutil/trace.go:171","msg":"trace[460965440] linearizableReadLoop","detail":"{readStateIndex:2318; appliedIndex:2316; }","duration":"443.282637ms","start":"2026-06-23T04:41:43.302353Z","end":"2026-06-23T04:41:43.745635Z","steps":["trace[460965440] 'read index received' (duration: 60.880526ms)","trace[460965440] 'applied index is now lower than readState.Index' (duration: 382.400601ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:41:43.745718Z","caller":"traceutil/trace.go:171","msg":"trace[886878743] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"413.701828ms","start":"2026-06-23T04:41:43.331985Z","end":"2026-06-23T04:41:43.745687Z","steps":["trace[886878743] 'process raft request' (duration: 413.527745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:43.745935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:43.331964Z","time spent":"413.845551ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:41:43.745962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.583632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-23T04:41:43.745718Z","caller":"traceutil/trace.go:171","msg":"trace[1395173842] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"458.058101ms","start":"2026-06-23T04:41:43.287612Z","end":"2026-06-23T04:41:43.74567Z","steps":["trace[1395173842] 'process raft request' (duration: 456.653087ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:43.746047Z","caller":"traceutil/trace.go:171","msg":"trace[290926518] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2232; }","duration":"443.705363ms","start":"2026-06-23T04:41:43.302301Z","end":"2026-06-23T04:41:43.746006Z","steps":["trace[290926518] 'agreement among raft nodes before linearized reading' (duration: 443.447399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:43.746272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:43.287579Z","time spent":"458.463877ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:41:43.746309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:43.302282Z","time spent":"443.805146ms","remote":"127.0.0.1:36568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-23T04:41:44.118505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.196079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:41:44.118623Z","caller":"traceutil/trace.go:171","msg":"trace[463682571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2232; }","duration":"187.384242ms","start":"2026-06-23T04:41:43.931218Z","end":"2026-06-23T04:41:44.118603Z","steps":["trace[463682571] 'range keys from in-memory index tree' (duration: 186.982925ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:44.118927Z","caller":"traceutil/trace.go:171","msg":"trace[221422008] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"109.218531ms","start":"2026-06-23T04:41:44.009666Z","end":"2026-06-23T04:41:44.118884Z","steps":["trace[221422008] 'process raft request' (duration: 88.352977ms)","trace[221422008] 'compare' (duration: 20.403577ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:41:44.426713Z","caller":"traceutil/trace.go:171","msg":"trace[782580377] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"408.963806ms","start":"2026-06-23T04:41:44.017722Z","end":"2026-06-23T04:41:44.426686Z","steps":["trace[782580377] 'process raft request' (duration: 378.055036ms)","trace[782580377] 'compare' (duration: 30.267189ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:41:44.427005Z","caller":"traceutil/trace.go:171","msg":"trace[1659170310] linearizableReadLoop","detail":"{readStateIndex:2322; appliedIndex:2320; }","duration":"306.297183ms","start":"2026-06-23T04:41:44.120677Z","end":"2026-06-23T04:41:44.426975Z","steps":["trace[1659170310] 'read index received' (duration: 274.971926ms)","trace[1659170310] 'applied index is now lower than readState.Index' (duration: 31.322627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:41:44.427071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.017685Z","time spent":"409.299432ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:41:44.427132Z","caller":"traceutil/trace.go:171","msg":"trace[1467244542] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"408.00472ms","start":"2026-06-23T04:41:44.019114Z","end":"2026-06-23T04:41:44.427118Z","steps":["trace[1467244542] 'process raft request' (duration: 407.467751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:44.427273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.019091Z","time spent":"408.070772ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:41:44.427312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.599028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T04:41:44.427403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.725517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T04:41:44.42741Z","caller":"traceutil/trace.go:171","msg":"trace[116005998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2235; }","duration":"306.758421ms","start":"2026-06-23T04:41:44.12063Z","end":"2026-06-23T04:41:44.427388Z","steps":["trace[116005998] 'agreement among raft nodes before linearized reading' (duration: 306.546227ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:44.427452Z","caller":"traceutil/trace.go:171","msg":"trace[1655514888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2235; }","duration":"190.797747ms","start":"2026-06-23T04:41:44.236642Z","end":"2026-06-23T04:41:44.42744Z","steps":["trace[1655514888] 'agreement among raft nodes before linearized reading' (duration: 190.652935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:44.427402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.912816ms","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-06-23T04:41:44.427467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.120613Z","time spent":"306.845792ms","remote":"127.0.0.1:35502","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-06-23T04:41:44.427435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.2943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-23T04:41:44.427518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.268715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-23T04:41:44.427566Z","caller":"traceutil/trace.go:171","msg":"trace[899518314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2235; }","duration":"187.438412ms","start":"2026-06-23T04:41:44.240077Z","end":"2026-06-23T04:41:44.427516Z","steps":["trace[899518314] 'agreement among raft nodes before linearized reading' (duration: 187.131727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:44.427515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.468696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-23T04:41:44.427563Z","caller":"traceutil/trace.go:171","msg":"trace[93146856] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2235; }","duration":"192.095498ms","start":"2026-06-23T04:41:44.235402Z","end":"2026-06-23T04:41:44.427498Z","steps":["trace[93146856] 'agreement among raft nodes before linearized reading' (duration: 191.775713ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:44.427616Z","caller":"traceutil/trace.go:171","msg":"trace[1372693879] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2235; }","duration":"191.397347ms","start":"2026-06-23T04:41:44.236195Z","end":"2026-06-23T04:41:44.427592Z","steps":["trace[1372693879] 'agreement among raft nodes before linearized reading' (duration: 191.148393ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:44.427632Z","caller":"traceutil/trace.go:171","msg":"trace[321360824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2235; }","duration":"186.611128ms","start":"2026-06-23T04:41:44.241002Z","end":"2026-06-23T04:41:44.427613Z","steps":["trace[321360824] 'agreement among raft nodes before linearized reading' (duration: 186.276313ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:44.793871Z","caller":"traceutil/trace.go:171","msg":"trace[1440781875] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"361.458952ms","start":"2026-06-23T04:41:44.432387Z","end":"2026-06-23T04:41:44.793846Z","steps":["trace[1440781875] 'process raft request' (duration: 359.442629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:44.79405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.432373Z","time spent":"361.575614ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:41:44.794257Z","caller":"traceutil/trace.go:171","msg":"trace[928920672] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"361.477313ms","start":"2026-06-23T04:41:44.432759Z","end":"2026-06-23T04:41:44.794236Z","steps":["trace[928920672] 'process raft request' (duration: 361.002335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:44.794382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.432736Z","time spent":"361.574274ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:41:44.794957Z","caller":"traceutil/trace.go:171","msg":"trace[2141369951] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"360.642928ms","start":"2026-06-23T04:41:44.434294Z","end":"2026-06-23T04:41:44.794937Z","steps":["trace[2141369951] 'process raft request' (duration: 360.489246ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:44.795Z","caller":"traceutil/trace.go:171","msg":"trace[1510569125] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"361.30257ms","start":"2026-06-23T04:41:44.433671Z","end":"2026-06-23T04:41:44.794973Z","steps":["trace[1510569125] 'process raft request' (duration: 361.012575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:41:44.795077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.434266Z","time spent":"360.766641ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:41:44.795155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:41:44.433657Z","time spent":"361.410231ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:41:44.795369Z","caller":"traceutil/trace.go:171","msg":"trace[2134432794] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"212.954093ms","start":"2026-06-23T04:41:44.582391Z","end":"2026-06-23T04:41:44.795345Z","steps":["trace[2134432794] 'process raft request' (duration: 212.492805ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:42:09.037733Z","caller":"traceutil/trace.go:171","msg":"trace[1844290994] linearizableReadLoop","detail":"{readStateIndex:2483; appliedIndex:2482; }","duration":"100.687636ms","start":"2026-06-23T04:42:08.937023Z","end":"2026-06-23T04:42:09.037711Z","steps":["trace[1844290994] 'read index received' (duration: 93.894856ms)","trace[1844290994] 'applied index is now lower than readState.Index' (duration: 6.79208ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:42:09.037793Z","caller":"traceutil/trace.go:171","msg":"trace[1468049729] transaction","detail":"{read_only:false; response_revision:2391; number_of_response:1; }","duration":"102.19685ms","start":"2026-06-23T04:42:08.935569Z","end":"2026-06-23T04:42:09.037765Z","steps":["trace[1468049729] 'process raft request' (duration: 95.342189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:42:09.037922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.874849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-23T04:42:09.03795Z","caller":"traceutil/trace.go:171","msg":"trace[1208992458] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2391; }","duration":"100.93541ms","start":"2026-06-23T04:42:08.937007Z","end":"2026-06-23T04:42:09.037942Z","steps":["trace[1208992458] 'agreement among raft nodes before linearized reading' (duration: 100.794828ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:42:10.755051Z","caller":"traceutil/trace.go:171","msg":"trace[640185464] linearizableReadLoop","detail":"{readStateIndex:2523; appliedIndex:2521; }","duration":"119.401008ms","start":"2026-06-23T04:42:10.635626Z","end":"2026-06-23T04:42:10.755027Z","steps":["trace[640185464] 'read index received' (duration: 93.944145ms)","trace[640185464] 'applied index is now lower than readState.Index' (duration: 25.455703ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:42:10.755161Z","caller":"traceutil/trace.go:171","msg":"trace[1466961178] transaction","detail":"{read_only:false; response_revision:2428; number_of_response:1; }","duration":"151.821044ms","start":"2026-06-23T04:42:10.603308Z","end":"2026-06-23T04:42:10.755129Z","steps":["trace[1466961178] 'process raft request' (duration: 126.249289ms)","trace[1466961178] 'compare' (duration: 25.219449ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:42:10.755228Z","caller":"traceutil/trace.go:171","msg":"trace[9821818] transaction","detail":"{read_only:false; response_revision:2429; number_of_response:1; }","duration":"138.189343ms","start":"2026-06-23T04:42:10.617014Z","end":"2026-06-23T04:42:10.755203Z","steps":["trace[9821818] 'process raft request' (duration: 137.96165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:42:10.755265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.618342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T04:42:10.7553Z","caller":"traceutil/trace.go:171","msg":"trace[906525043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2429; }","duration":"119.708353ms","start":"2026-06-23T04:42:10.635582Z","end":"2026-06-23T04:42:10.75529Z","steps":["trace[906525043] 'agreement among raft nodes before linearized reading' (duration: 119.5434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:42:25.383833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.596475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-23T04:42:25.383932Z","caller":"traceutil/trace.go:171","msg":"trace[1719491745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2633; }","duration":"204.753228ms","start":"2026-06-23T04:42:25.179157Z","end":"2026-06-23T04:42:25.38391Z","steps":["trace[1719491745] 'range keys from in-memory index tree' (duration: 204.397482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:42:25.383956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.640624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-23T04:42:25.384048Z","caller":"traceutil/trace.go:171","msg":"trace[1939995208] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2633; }","duration":"202.758605ms","start":"2026-06-23T04:42:25.181269Z","end":"2026-06-23T04:42:25.384028Z","steps":["trace[1939995208] 'range keys from in-memory index tree' (duration: 202.45574ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:42:26.23514Z","caller":"traceutil/trace.go:171","msg":"trace[763429072] linearizableReadLoop","detail":"{readStateIndex:2737; appliedIndex:2736; }","duration":"108.685359ms","start":"2026-06-23T04:42:26.126429Z","end":"2026-06-23T04:42:26.235115Z","steps":["trace[763429072] 'read index received' (duration: 108.527647ms)","trace[763429072] 'applied index is now lower than readState.Index' (duration: 156.922µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:42:26.235231Z","caller":"traceutil/trace.go:171","msg":"trace[303468177] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"294.786196ms","start":"2026-06-23T04:42:25.940436Z","end":"2026-06-23T04:42:26.235222Z","steps":["trace[303468177] 'process raft request' (duration: 294.565582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:42:26.235389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.955154ms","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-06-23T04:42:26.235416Z","caller":"traceutil/trace.go:171","msg":"trace[659221346] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2636; }","duration":"109.026035ms","start":"2026-06-23T04:42:26.126378Z","end":"2026-06-23T04:42:26.235405Z","steps":["trace[659221346] 'agreement among raft nodes before linearized reading' (duration: 108.937743ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:42:34.829618Z","caller":"traceutil/trace.go:171","msg":"trace[891909943] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"110.316339ms","start":"2026-06-23T04:42:34.719274Z","end":"2026-06-23T04:42:34.829591Z","steps":["trace[891909943] 'process raft request' (duration: 108.131104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.38881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.184239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:43:02.388921Z","caller":"traceutil/trace.go:171","msg":"trace[1785249476] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2852; }","duration":"685.374202ms","start":"2026-06-23T04:43:01.703523Z","end":"2026-06-23T04:43:02.388897Z","steps":["trace[1785249476] 'count revisions from in-memory index tree' (duration: 685.082458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.388917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.17699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T04:43:02.388969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:01.703504Z","time spent":"685.454403ms","remote":"127.0.0.1:35880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-06-23T04:43:02.389001Z","caller":"traceutil/trace.go:171","msg":"trace[118390872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2852; }","duration":"458.313723ms","start":"2026-06-23T04:43:01.930667Z","end":"2026-06-23T04:43:02.388981Z","steps":["trace[118390872] 'range keys from in-memory index tree' (duration: 458.098279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.389041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:01.930646Z","time spent":"458.386333ms","remote":"127.0.0.1:35500","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-06-23T04:43:02.774508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.186504ms","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-06-23T04:43:02.774741Z","caller":"traceutil/trace.go:171","msg":"trace[1740423100] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2852; }","duration":"137.429828ms","start":"2026-06-23T04:43:02.637289Z","end":"2026-06-23T04:43:02.774719Z","steps":["trace[1740423100] 'range keys from in-memory index tree' (duration: 137.166464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.775591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.863207ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-23T04:43:02.776557Z","caller":"traceutil/trace.go:171","msg":"trace[1793424223] transaction","detail":"{read_only:false; response_revision:2854; number_of_response:1; }","duration":"323.459725ms","start":"2026-06-23T04:43:02.453048Z","end":"2026-06-23T04:43:02.776508Z","steps":["trace[1793424223] 'process raft request' (duration: 323.265242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.776706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:02.453016Z","time spent":"323.579218ms","remote":"127.0.0.1:35738","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-06-23T04:43:02.777035Z","caller":"traceutil/trace.go:171","msg":"trace[1944060310] linearizableReadLoop","detail":"{readStateIndex:2962; appliedIndex:2961; }","duration":"649.842277ms","start":"2026-06-23T04:43:02.127154Z","end":"2026-06-23T04:43:02.776997Z","steps":["trace[1944060310] 'read index received' (duration: 215.167649ms)","trace[1944060310] 'applied index is now lower than readState.Index' (duration: 434.673368ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:43:02.777048Z","caller":"traceutil/trace.go:171","msg":"trace[1032322084] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"404.896455ms","start":"2026-06-23T04:43:02.37213Z","end":"2026-06-23T04:43:02.777027Z","steps":["trace[1032322084] 'process raft request' (duration: 403.858589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.77721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:02.372083Z","time spent":"405.019878ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:43:02.778343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.150468ms","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-06-23T04:43:02.778524Z","caller":"traceutil/trace.go:171","msg":"trace[1097332641] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2854; }","duration":"651.360961ms","start":"2026-06-23T04:43:02.127107Z","end":"2026-06-23T04:43:02.778468Z","steps":["trace[1097332641] 'agreement among raft nodes before linearized reading' (duration: 650.366175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:02.778609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:02.127084Z","time spent":"651.509503ms","remote":"127.0.0.1:35674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-06-23T04:43:03.047789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.515881ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:43:03.048073Z","caller":"traceutil/trace.go:171","msg":"trace[84243037] linearizableReadLoop","detail":"{readStateIndex:2967; appliedIndex:2964; }","duration":"270.990994ms","start":"2026-06-23T04:43:02.777061Z","end":"2026-06-23T04:43:03.048052Z","steps":["trace[84243037] 'read index received' (duration: 136.132297ms)","trace[84243037] 'applied index is now lower than readState.Index' (duration: 134.857387ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:43:03.048086Z","caller":"traceutil/trace.go:171","msg":"trace[1872994564] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"271.739616ms","start":"2026-06-23T04:43:02.776323Z","end":"2026-06-23T04:43:03.048063Z","steps":["trace[1872994564] 'process raft request' (duration: 271.674845ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:43:03.048112Z","caller":"traceutil/trace.go:171","msg":"trace[198753230] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"506.15839ms","start":"2026-06-23T04:43:02.541891Z","end":"2026-06-23T04:43:03.048049Z","steps":["trace[198753230] 'process raft request' (duration: 371.281663ms)","trace[198753230] 'compare' (duration: 134.302327ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:43:03.048112Z","caller":"traceutil/trace.go:171","msg":"trace[600081615] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"278.411171ms","start":"2026-06-23T04:43:02.769658Z","end":"2026-06-23T04:43:03.048069Z","steps":["trace[600081615] 'process raft request' (duration: 278.260879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:03.048364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.742655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1447"} {"level":"info","ts":"2026-06-23T04:43:03.048453Z","caller":"traceutil/trace.go:171","msg":"trace[714293514] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2857; }","duration":"264.856387ms","start":"2026-06-23T04:43:02.783576Z","end":"2026-06-23T04:43:03.048432Z","steps":["trace[714293514] 'agreement among raft nodes before linearized reading' (duration: 264.608813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:03.048379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:02.541865Z","time spent":"506.348003ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:43:03.048721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.298721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:43:03.048886Z","caller":"traceutil/trace.go:171","msg":"trace[1041909353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2857; }","duration":"658.418853ms","start":"2026-06-23T04:43:02.390358Z","end":"2026-06-23T04:43:03.048777Z","steps":["trace[1041909353] 'agreement among raft nodes before linearized reading' (duration: 657.760543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:43:03.049048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:43:02.390337Z","time spent":"658.695847ms","remote":"127.0.0.1:35502","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-06-23T04:45:33.518177Z","caller":"traceutil/trace.go:171","msg":"trace[912408348] transaction","detail":"{read_only:false; response_revision:3844; number_of_response:1; }","duration":"180.050115ms","start":"2026-06-23T04:45:33.338097Z","end":"2026-06-23T04:45:33.518147Z","steps":["trace[912408348] 'process raft request' (duration: 179.870978ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:45:33.519016Z","caller":"traceutil/trace.go:171","msg":"trace[1567658329] transaction","detail":"{read_only:false; response_revision:3845; number_of_response:1; }","duration":"180.538573ms","start":"2026-06-23T04:45:33.338447Z","end":"2026-06-23T04:45:33.518985Z","steps":["trace[1567658329] 'process raft request' (duration: 180.399548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:53.622465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.21489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:46:53.622561Z","caller":"traceutil/trace.go:171","msg":"trace[1698653756] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4875; }","duration":"103.323564ms","start":"2026-06-23T04:46:53.519201Z","end":"2026-06-23T04:46:53.622525Z","steps":["trace[1698653756] 'count revisions from in-memory index tree' (duration: 103.130848ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.902673Z","caller":"traceutil/trace.go:171","msg":"trace[1855693893] linearizableReadLoop","detail":"{readStateIndex:5064; appliedIndex:5063; }","duration":"251.005795ms","start":"2026-06-23T04:46:53.651643Z","end":"2026-06-23T04:46:53.902649Z","steps":["trace[1855693893] 'read index received' (duration: 250.947294ms)","trace[1855693893] 'applied index is now lower than readState.Index' (duration: 57.481µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:46:53.90279Z","caller":"traceutil/trace.go:171","msg":"trace[1656057202] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"251.304515ms","start":"2026-06-23T04:46:53.651474Z","end":"2026-06-23T04:46:53.902778Z","steps":["trace[1656057202] 'process raft request' (duration: 250.994015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:53.902906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.233923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/loki-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:46:53.90304Z","caller":"traceutil/trace.go:171","msg":"trace[623909099] range","detail":"{range_begin:/registry/deployments/monitoring/loki-gateway; range_end:; response_count:0; response_revision:4876; }","duration":"251.369167ms","start":"2026-06-23T04:46:53.651626Z","end":"2026-06-23T04:46:53.902995Z","steps":["trace[623909099] 'agreement among raft nodes before linearized reading' (duration: 251.16294ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.949585Z","caller":"traceutil/trace.go:171","msg":"trace[910238630] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"149.426467ms","start":"2026-06-23T04:46:53.800142Z","end":"2026-06-23T04:46:53.949568Z","steps":["trace[910238630] 'process raft request' (duration: 149.262602ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.949941Z","caller":"traceutil/trace.go:171","msg":"trace[1073640509] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"149.374306ms","start":"2026-06-23T04:46:53.800548Z","end":"2026-06-23T04:46:53.949923Z","steps":["trace[1073640509] 'process raft request' (duration: 148.958222ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.949972Z","caller":"traceutil/trace.go:171","msg":"trace[1540319869] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"137.288847ms","start":"2026-06-23T04:46:53.812656Z","end":"2026-06-23T04:46:53.949945Z","steps":["trace[1540319869] 'process raft request' (duration: 137.133202ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.950037Z","caller":"traceutil/trace.go:171","msg":"trace[436238188] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"131.503991ms","start":"2026-06-23T04:46:53.818521Z","end":"2026-06-23T04:46:53.950025Z","steps":["trace[436238188] 'process raft request' (duration: 131.382587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:53.950174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.254759ms","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-06-23T04:46:53.95018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.703468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:46:53.95022Z","caller":"traceutil/trace.go:171","msg":"trace[1092045674] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:4880; }","duration":"125.385474ms","start":"2026-06-23T04:46:53.82482Z","end":"2026-06-23T04:46:53.950206Z","steps":["trace[1092045674] 'agreement among raft nodes before linearized reading' (duration: 125.228739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:53.950246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.208828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T04:46:53.950274Z","caller":"traceutil/trace.go:171","msg":"trace[180064446] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:4880; }","duration":"228.865793ms","start":"2026-06-23T04:46:53.721383Z","end":"2026-06-23T04:46:53.950249Z","steps":["trace[180064446] 'agreement among raft nodes before linearized reading' (duration: 228.685117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:53.950296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.087527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-23T04:46:53.950304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.606112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:46:53.95033Z","caller":"traceutil/trace.go:171","msg":"trace[2069483252] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4880; }","duration":"246.151379ms","start":"2026-06-23T04:46:53.70417Z","end":"2026-06-23T04:46:53.950321Z","steps":["trace[2069483252] 'agreement among raft nodes before linearized reading' (duration: 246.019165ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.950325Z","caller":"traceutil/trace.go:171","msg":"trace[1342954569] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:4880; }","duration":"217.410975ms","start":"2026-06-23T04:46:53.732895Z","end":"2026-06-23T04:46:53.950306Z","steps":["trace[1342954569] 'agreement among raft nodes before linearized reading' (duration: 217.150476ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:53.950352Z","caller":"traceutil/trace.go:171","msg":"trace[1687574052] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4880; }","duration":"291.688424ms","start":"2026-06-23T04:46:53.658651Z","end":"2026-06-23T04:46:53.950339Z","steps":["trace[1687574052] 'agreement among raft nodes before linearized reading' (duration: 291.581ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:46:57.019667Z","caller":"traceutil/trace.go:171","msg":"trace[414253020] linearizableReadLoop","detail":"{readStateIndex:5213; appliedIndex:5212; }","duration":"306.557642ms","start":"2026-06-23T04:46:56.713081Z","end":"2026-06-23T04:46:57.019639Z","steps":["trace[414253020] 'read index received' (duration: 306.280553ms)","trace[414253020] 'applied index is now lower than readState.Index' (duration: 276.099µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:46:57.019803Z","caller":"traceutil/trace.go:171","msg":"trace[218722363] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"329.293919ms","start":"2026-06-23T04:46:56.690495Z","end":"2026-06-23T04:46:57.019789Z","steps":["trace[218722363] 'process raft request' (duration: 328.945338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.019937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:46:56.690479Z","time spent":"329.358622ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:46:57.020041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.577899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T04:46:57.020126Z","caller":"traceutil/trace.go:171","msg":"trace[712238976] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:5022; }","duration":"284.675102ms","start":"2026-06-23T04:46:56.735433Z","end":"2026-06-23T04:46:57.020108Z","steps":["trace[712238976] 'agreement among raft nodes before linearized reading' (duration: 284.455325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.020441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.322977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d0319d6c-e537-41a6-b3e5-8ebc3b320da5\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-06-23T04:46:57.020489Z","caller":"traceutil/trace.go:171","msg":"trace[653974344] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d0319d6c-e537-41a6-b3e5-8ebc3b320da5; range_end:; response_count:1; response_revision:5022; }","duration":"307.42696ms","start":"2026-06-23T04:46:56.713046Z","end":"2026-06-23T04:46:57.020473Z","steps":["trace[653974344] 'agreement among raft nodes before linearized reading' (duration: 307.291486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.02052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:46:56.713028Z","time spent":"307.482752ms","remote":"127.0.0.1:35664","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-d0319d6c-e537-41a6-b3e5-8ebc3b320da5\" "} {"level":"warn","ts":"2026-06-23T04:46:57.020559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.212578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-23T04:46:57.020605Z","caller":"traceutil/trace.go:171","msg":"trace[1079400269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5022; }","duration":"210.330592ms","start":"2026-06-23T04:46:56.81026Z","end":"2026-06-23T04:46:57.020591Z","steps":["trace[1079400269] 'agreement among raft nodes before linearized reading' (duration: 210.124335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.020732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.144539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:46:57.020829Z","caller":"traceutil/trace.go:171","msg":"trace[1227019300] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:5022; }","duration":"197.313165ms","start":"2026-06-23T04:46:56.823494Z","end":"2026-06-23T04:46:57.020807Z","steps":["trace[1227019300] 'agreement among raft nodes before linearized reading' (duration: 197.134289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.020883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.132945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-23T04:46:57.020926Z","caller":"traceutil/trace.go:171","msg":"trace[1749137451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5022; }","duration":"205.222708ms","start":"2026-06-23T04:46:56.815694Z","end":"2026-06-23T04:46:57.020916Z","steps":["trace[1749137451] 'agreement among raft nodes before linearized reading' (duration: 205.112415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.021075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.946549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786824"} {"level":"info","ts":"2026-06-23T04:46:57.021138Z","caller":"traceutil/trace.go:171","msg":"trace[207497586] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5022; }","duration":"230.072493ms","start":"2026-06-23T04:46:56.791054Z","end":"2026-06-23T04:46:57.021127Z","steps":["trace[207497586] 'agreement among raft nodes before linearized reading' (duration: 229.66517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:46:57.021174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.018206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-23T04:46:57.021214Z","caller":"traceutil/trace.go:171","msg":"trace[1853477552] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5022; }","duration":"282.096099ms","start":"2026-06-23T04:46:56.739108Z","end":"2026-06-23T04:46:57.021204Z","steps":["trace[1853477552] 'agreement among raft nodes before linearized reading' (duration: 281.998296ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:10.617419Z","caller":"traceutil/trace.go:171","msg":"trace[1032387640] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"131.342998ms","start":"2026-06-23T04:47:10.486046Z","end":"2026-06-23T04:47:10.617388Z","steps":["trace[1032387640] 'process raft request' (duration: 130.736379ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:11.450158Z","caller":"traceutil/trace.go:171","msg":"trace[1369629005] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"296.100946ms","start":"2026-06-23T04:47:11.154016Z","end":"2026-06-23T04:47:11.450117Z","steps":["trace[1369629005] 'process raft request' (duration: 295.812377ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:11.451411Z","caller":"traceutil/trace.go:171","msg":"trace[1269832928] linearizableReadLoop","detail":"{readStateIndex:5473; appliedIndex:5471; }","duration":"139.516006ms","start":"2026-06-23T04:47:11.311866Z","end":"2026-06-23T04:47:11.451382Z","steps":["trace[1269832928] 'read index received' (duration: 137.867335ms)","trace[1269832928] 'applied index is now lower than readState.Index' (duration: 1.647251ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:47:11.451491Z","caller":"traceutil/trace.go:171","msg":"trace[1863311651] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"296.034994ms","start":"2026-06-23T04:47:11.155433Z","end":"2026-06-23T04:47:11.451468Z","steps":["trace[1863311651] 'process raft request' (duration: 295.817107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:11.451748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.874768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-pm29t\" ","response":"range_response_count:1 size:7666"} {"level":"info","ts":"2026-06-23T04:47:11.45182Z","caller":"traceutil/trace.go:171","msg":"trace[1984851938] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-cf56b6468-pm29t; range_end:; response_count:1; response_revision:5273; }","duration":"139.961491ms","start":"2026-06-23T04:47:11.311844Z","end":"2026-06-23T04:47:11.451805Z","steps":["trace[1984851938] 'agreement among raft nodes before linearized reading' (duration: 139.647831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:25.113624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.505509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:47:25.113807Z","caller":"traceutil/trace.go:171","msg":"trace[750999191] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5541; }","duration":"447.750676ms","start":"2026-06-23T04:47:24.666027Z","end":"2026-06-23T04:47:25.113778Z","steps":["trace[750999191] 'range keys from in-memory index tree' (duration: 447.377595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:25.113825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.525738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-23T04:47:25.113874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:24.665996Z","time spent":"447.86571ms","remote":"127.0.0.1:35674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-23T04:47:25.113688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.981321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-acd4cb24-01c5-45b1-8910-303d9aa3c1b4\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-23T04:47:25.113885Z","caller":"traceutil/trace.go:171","msg":"trace[1125803364] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5541; }","duration":"306.60064ms","start":"2026-06-23T04:47:24.807262Z","end":"2026-06-23T04:47:25.113862Z","steps":["trace[1125803364] 'range keys from in-memory index tree' (duration: 306.126255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:25.11386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.019461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T04:47:25.113946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:24.807244Z","time spent":"306.689122ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-23T04:47:25.113955Z","caller":"traceutil/trace.go:171","msg":"trace[904247108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5541; }","duration":"184.166215ms","start":"2026-06-23T04:47:24.929769Z","end":"2026-06-23T04:47:25.113935Z","steps":["trace[904247108] 'range keys from in-memory index tree' (duration: 183.877126ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:25.113956Z","caller":"traceutil/trace.go:171","msg":"trace[903770186] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-acd4cb24-01c5-45b1-8910-303d9aa3c1b4; range_end:; response_count:1; response_revision:5541; }","duration":"272.308761ms","start":"2026-06-23T04:47:24.841615Z","end":"2026-06-23T04:47:25.113924Z","steps":["trace[903770186] 'range keys from in-memory index tree' (duration: 271.733304ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:25.467229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.498676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:47:25.46735Z","caller":"traceutil/trace.go:171","msg":"trace[1680153264] linearizableReadLoop","detail":"{readStateIndex:5751; appliedIndex:5750; }","duration":"290.617903ms","start":"2026-06-23T04:47:25.176713Z","end":"2026-06-23T04:47:25.467331Z","steps":["trace[1680153264] 'read index received' (duration: 63.86041ms)","trace[1680153264] 'applied index is now lower than readState.Index' (duration: 226.755763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:47:25.46759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.869651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-23T04:47:25.46764Z","caller":"traceutil/trace.go:171","msg":"trace[1805744946] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5543; }","duration":"290.940083ms","start":"2026-06-23T04:47:25.176682Z","end":"2026-06-23T04:47:25.467622Z","steps":["trace[1805744946] 'agreement among raft nodes before linearized reading' (duration: 290.698806ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:25.467888Z","caller":"traceutil/trace.go:171","msg":"trace[2100878263] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"292.15759ms","start":"2026-06-23T04:47:25.175716Z","end":"2026-06-23T04:47:25.467873Z","steps":["trace[2100878263] 'process raft request' (duration: 64.899761ms)","trace[2100878263] 'compare' (duration: 226.170316ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:47:26.088401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.396325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:47:26.088632Z","caller":"traceutil/trace.go:171","msg":"trace[778526642] linearizableReadLoop","detail":"{readStateIndex:5752; appliedIndex:5751; }","duration":"594.152327ms","start":"2026-06-23T04:47:25.494456Z","end":"2026-06-23T04:47:26.088608Z","steps":["trace[778526642] 'read index received' (duration: 373.527795ms)","trace[778526642] 'applied index is now lower than readState.Index' (duration: 220.622242ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:47:26.088671Z","caller":"traceutil/trace.go:171","msg":"trace[647871127] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"603.654647ms","start":"2026-06-23T04:47:25.484982Z","end":"2026-06-23T04:47:26.088637Z","steps":["trace[647871127] 'process raft request' (duration: 383.116888ms)","trace[647871127] 'compare' (duration: 218.737544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:47:26.088848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:25.484944Z","time spent":"603.821252ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:47:26.088905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.444675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-23T04:47:26.088968Z","caller":"traceutil/trace.go:171","msg":"trace[1299157910] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5544; }","duration":"594.507757ms","start":"2026-06-23T04:47:25.494441Z","end":"2026-06-23T04:47:26.088949Z","steps":["trace[1299157910] 'agreement among raft nodes before linearized reading' (duration: 594.2719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:26.089027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:25.494423Z","time spent":"594.59028ms","remote":"127.0.0.1:35642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-23T04:47:26.108042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.228016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-23T04:47:26.108069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.256856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tn2f\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-23T04:47:26.108121Z","caller":"traceutil/trace.go:171","msg":"trace[855087714] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5546; }","duration":"592.369731ms","start":"2026-06-23T04:47:25.515734Z","end":"2026-06-23T04:47:26.108104Z","steps":["trace[855087714] 'agreement among raft nodes before linearized reading' (duration: 592.234227ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:26.108153Z","caller":"traceutil/trace.go:171","msg":"trace[242704558] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tn2f; range_end:; response_count:1; response_revision:5546; }","duration":"308.3851ms","start":"2026-06-23T04:47:25.799742Z","end":"2026-06-23T04:47:26.108127Z","steps":["trace[242704558] 'agreement among raft nodes before linearized reading' (duration: 308.157703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:26.108166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:25.515714Z","time spent":"592.442903ms","remote":"127.0.0.1:35948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-23T04:47:26.108178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.787987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-23T04:47:26.108212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:25.799716Z","time spent":"308.471233ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6474,"request content":"key:\"/registry/pods/openstack/keepalived-5tn2f\" "} {"level":"info","ts":"2026-06-23T04:47:26.108225Z","caller":"traceutil/trace.go:171","msg":"trace[1194999575] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5546; }","duration":"579.87534ms","start":"2026-06-23T04:47:25.528334Z","end":"2026-06-23T04:47:26.108209Z","steps":["trace[1194999575] 'agreement among raft nodes before linearized reading' (duration: 579.790307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:26.108265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:25.528313Z","time spent":"579.944512ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-23T04:47:26.108081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.919163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-23T04:47:26.108434Z","caller":"traceutil/trace.go:171","msg":"trace[1415475600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5546; }","duration":"583.293544ms","start":"2026-06-23T04:47:25.525125Z","end":"2026-06-23T04:47:26.108418Z","steps":["trace[1415475600] 'agreement among raft nodes before linearized reading' (duration: 582.82954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:26.108463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.488121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-06-23T04:47:26.108471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:47:25.52512Z","time spent":"583.340805ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-23T04:47:26.108519Z","caller":"traceutil/trace.go:171","msg":"trace[1167199722] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5546; }","duration":"172.554963ms","start":"2026-06-23T04:47:25.935929Z","end":"2026-06-23T04:47:26.108484Z","steps":["trace[1167199722] 'agreement among raft nodes before linearized reading' (duration: 172.479631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:47:26.108394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.461994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:47:26.108647Z","caller":"traceutil/trace.go:171","msg":"trace[2087871860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5546; }","duration":"178.752332ms","start":"2026-06-23T04:47:25.929882Z","end":"2026-06-23T04:47:26.108634Z","steps":["trace[2087871860] 'agreement among raft nodes before linearized reading' (duration: 178.490394ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:38.405338Z","caller":"traceutil/trace.go:171","msg":"trace[1982801859] linearizableReadLoop","detail":"{readStateIndex:5860; appliedIndex:5859; }","duration":"172.130311ms","start":"2026-06-23T04:47:38.23317Z","end":"2026-06-23T04:47:38.405301Z","steps":["trace[1982801859] 'read index received' (duration: 111.100425ms)","trace[1982801859] 'applied index is now lower than readState.Index' (duration: 61.028846ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:47:38.405451Z","caller":"traceutil/trace.go:171","msg":"trace[1722014876] transaction","detail":"{read_only:false; response_revision:5649; number_of_response:1; }","duration":"172.44022ms","start":"2026-06-23T04:47:38.232969Z","end":"2026-06-23T04:47:38.405409Z","steps":["trace[1722014876] 'process raft request' (duration: 111.29163ms)","trace[1722014876] 'compare' (duration: 60.918923ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:47:38.405699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.506552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81739"} {"level":"info","ts":"2026-06-23T04:47:38.405743Z","caller":"traceutil/trace.go:171","msg":"trace[841985930] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5649; }","duration":"172.600195ms","start":"2026-06-23T04:47:38.233132Z","end":"2026-06-23T04:47:38.405733Z","steps":["trace[841985930] 'agreement among raft nodes before linearized reading' (duration: 172.287995ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:47:38.409625Z","caller":"traceutil/trace.go:171","msg":"trace[803163558] transaction","detail":"{read_only:false; response_revision:5650; number_of_response:1; }","duration":"176.355427ms","start":"2026-06-23T04:47:38.233241Z","end":"2026-06-23T04:47:38.409597Z","steps":["trace[803163558] 'process raft request' (duration: 176.190692ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:48:13.876018Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2918} {"level":"info","ts":"2026-06-23T04:48:13.9548Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2918,"took":"77.329898ms","hash":1454679549,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":33759232,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-23T04:48:13.954852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1454679549,"revision":2918,"compact-revision":-1} {"level":"info","ts":"2026-06-23T04:48:32.170749Z","caller":"traceutil/trace.go:171","msg":"trace[761842713] linearizableReadLoop","detail":"{readStateIndex:6309; appliedIndex:6308; }","duration":"104.935567ms","start":"2026-06-23T04:48:32.065791Z","end":"2026-06-23T04:48:32.170726Z","steps":["trace[761842713] 'read index received' (duration: 104.718781ms)","trace[761842713] 'applied index is now lower than readState.Index' (duration: 215.846µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:48:32.17083Z","caller":"traceutil/trace.go:171","msg":"trace[916228905] transaction","detail":"{read_only:false; response_revision:6085; number_of_response:1; }","duration":"173.913328ms","start":"2026-06-23T04:48:31.996882Z","end":"2026-06-23T04:48:32.170795Z","steps":["trace[916228905] 'process raft request' (duration: 173.701782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:48:32.170915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.094931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:48:32.170999Z","caller":"traceutil/trace.go:171","msg":"trace[1506503592] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6085; }","duration":"105.236015ms","start":"2026-06-23T04:48:32.065746Z","end":"2026-06-23T04:48:32.170982Z","steps":["trace[1506503592] 'agreement among raft nodes before linearized reading' (duration: 105.080091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:48:32.370731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.909644ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-23T04:48:32.370882Z","caller":"traceutil/trace.go:171","msg":"trace[755553529] linearizableReadLoop","detail":"{readStateIndex:6310; appliedIndex:6309; }","duration":"200.036231ms","start":"2026-06-23T04:48:32.170818Z","end":"2026-06-23T04:48:32.370854Z","steps":["trace[755553529] 'read index received' (duration: 11.943581ms)","trace[755553529] 'applied index is now lower than readState.Index' (duration: 188.0903ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:48:32.370988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.492144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:48:32.371038Z","caller":"traceutil/trace.go:171","msg":"trace[368650866] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6085; }","duration":"304.571465ms","start":"2026-06-23T04:48:32.066451Z","end":"2026-06-23T04:48:32.371022Z","steps":["trace[368650866] 'agreement among raft nodes before linearized reading' (duration: 304.471442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:48:32.371082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:48:32.066443Z","time spent":"304.628008ms","remote":"127.0.0.1:35728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"info","ts":"2026-06-23T04:48:32.542425Z","caller":"traceutil/trace.go:171","msg":"trace[1047088741] transaction","detail":"{read_only:false; response_revision:6087; number_of_response:1; }","duration":"126.533964ms","start":"2026-06-23T04:48:32.415855Z","end":"2026-06-23T04:48:32.542389Z","steps":["trace[1047088741] 'process raft request' (duration: 126.319108ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:13.882514Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5961} {"level":"info","ts":"2026-06-23T04:53:13.99032Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5961,"took":"105.919015ms","hash":764457653,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":21987328,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-23T04:53:13.990408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":764457653,"revision":5961,"compact-revision":2918} {"level":"warn","ts":"2026-06-23T04:53:45.158017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.743432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T04:53:45.158051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.822324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tn2f\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-23T04:53:45.15809Z","caller":"traceutil/trace.go:171","msg":"trace[718298190] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:8370; }","duration":"615.02392ms","start":"2026-06-23T04:53:44.543051Z","end":"2026-06-23T04:53:45.158075Z","steps":["trace[718298190] 'count revisions from in-memory index tree' (duration: 613.690891ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:45.158111Z","caller":"traceutil/trace.go:171","msg":"trace[1811150294] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tn2f; range_end:; response_count:1; response_revision:8370; }","duration":"584.920886ms","start":"2026-06-23T04:53:44.573174Z","end":"2026-06-23T04:53:45.158095Z","steps":["trace[1811150294] 'range keys from in-memory index tree' (duration: 584.64763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:53:45.158138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:53:44.573155Z","time spent":"584.977448ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6474,"request content":"key:\"/registry/pods/openstack/keepalived-5tn2f\" "} {"level":"warn","ts":"2026-06-23T04:53:45.158137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:53:44.543032Z","time spent":"615.096781ms","remote":"127.0.0.1:38778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-23T04:53:45.158987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.842777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-5c995f8487-nsdqr.18bb9cbd63f7aa3a\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-06-23T04:53:45.159033Z","caller":"traceutil/trace.go:171","msg":"trace[1980831813] range","detail":"{range_begin:/registry/events/openstack/barbican-api-5c995f8487-nsdqr.18bb9cbd63f7aa3a; range_end:; response_count:1; response_revision:8370; }","duration":"361.948859ms","start":"2026-06-23T04:53:44.79707Z","end":"2026-06-23T04:53:45.159019Z","steps":["trace[1980831813] 'range keys from in-memory index tree' (duration: 361.688433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:53:45.159063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:53:44.797048Z","time spent":"362.006799ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-5c995f8487-nsdqr.18bb9cbd63f7aa3a\" "} {"level":"warn","ts":"2026-06-23T04:53:57.027834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.090334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:53:57.027999Z","caller":"traceutil/trace.go:171","msg":"trace[2084797799] linearizableReadLoop","detail":"{readStateIndex:8737; appliedIndex:8736; }","duration":"268.192404ms","start":"2026-06-23T04:53:56.759787Z","end":"2026-06-23T04:53:57.02798Z","steps":["trace[2084797799] 'read index received' (duration: 53.714813ms)","trace[2084797799] 'applied index is now lower than readState.Index' (duration: 214.475171ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:53:57.028221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.425549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T04:53:57.02944Z","caller":"traceutil/trace.go:171","msg":"trace[256518547] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:8434; }","duration":"269.617854ms","start":"2026-06-23T04:53:56.759767Z","end":"2026-06-23T04:53:57.029385Z","steps":["trace[256518547] 'agreement among raft nodes before linearized reading' (duration: 268.290446ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:57.028609Z","caller":"traceutil/trace.go:171","msg":"trace[1112053182] transaction","detail":"{read_only:false; response_revision:8434; number_of_response:1; }","duration":"307.058396ms","start":"2026-06-23T04:53:56.721528Z","end":"2026-06-23T04:53:57.028586Z","steps":["trace[1112053182] 'process raft request' (duration: 92.094234ms)","trace[1112053182] 'compare' (duration: 213.674025ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:53:57.030195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:53:56.721503Z","time spent":"308.066007ms","remote":"127.0.0.1:35738","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-06-23T04:53:57.209272Z","caller":"traceutil/trace.go:171","msg":"trace[465044806] transaction","detail":"{read_only:false; response_revision:8435; number_of_response:1; }","duration":"143.950996ms","start":"2026-06-23T04:53:57.065296Z","end":"2026-06-23T04:53:57.209247Z","steps":["trace[465044806] 'process raft request' (duration: 143.749242ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:58.445926Z","caller":"traceutil/trace.go:171","msg":"trace[881428252] linearizableReadLoop","detail":"{readStateIndex:8746; appliedIndex:8745; }","duration":"265.428931ms","start":"2026-06-23T04:53:58.180474Z","end":"2026-06-23T04:53:58.445903Z","steps":["trace[881428252] 'read index received' (duration: 265.202127ms)","trace[881428252] 'applied index is now lower than readState.Index' (duration: 225.694µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:53:58.44599Z","caller":"traceutil/trace.go:171","msg":"trace[867520882] transaction","detail":"{read_only:false; response_revision:8442; number_of_response:1; }","duration":"351.944858ms","start":"2026-06-23T04:53:58.094014Z","end":"2026-06-23T04:53:58.445959Z","steps":["trace[867520882] 'process raft request' (duration: 351.728283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:53:58.446104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.620455ms","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-06-23T04:53:58.446185Z","caller":"traceutil/trace.go:171","msg":"trace[806081536] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8442; }","duration":"265.752638ms","start":"2026-06-23T04:53:58.180418Z","end":"2026-06-23T04:53:58.44617Z","steps":["trace[806081536] 'agreement among raft nodes before linearized reading' (duration: 265.630555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:53:58.446119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:53:58.094001Z","time spent":"352.041629ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:53:58.695887Z","caller":"traceutil/trace.go:171","msg":"trace[842766298] transaction","detail":"{read_only:false; response_revision:8443; number_of_response:1; }","duration":"244.652657ms","start":"2026-06-23T04:53:58.451187Z","end":"2026-06-23T04:53:58.695839Z","steps":["trace[842766298] 'process raft request' (duration: 177.24067ms)","trace[842766298] 'compare' (duration: 67.08973ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:53:58.69591Z","caller":"traceutil/trace.go:171","msg":"trace[14274768] linearizableReadLoop","detail":"{readStateIndex:8748; appliedIndex:8746; }","duration":"242.506583ms","start":"2026-06-23T04:53:58.453314Z","end":"2026-06-23T04:53:58.695821Z","steps":["trace[14274768] 'read index received' (duration: 175.082335ms)","trace[14274768] 'applied index is now lower than readState.Index' (duration: 67.422878ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:53:58.696109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.773878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:53:58.696165Z","caller":"traceutil/trace.go:171","msg":"trace[260810816] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8444; }","duration":"242.86235ms","start":"2026-06-23T04:53:58.45329Z","end":"2026-06-23T04:53:58.696152Z","steps":["trace[260810816] 'agreement among raft nodes before linearized reading' (duration: 242.768228ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:58.696022Z","caller":"traceutil/trace.go:171","msg":"trace[770045142] transaction","detail":"{read_only:false; response_revision:8444; number_of_response:1; }","duration":"242.954862ms","start":"2026-06-23T04:53:58.453038Z","end":"2026-06-23T04:53:58.695993Z","steps":["trace[770045142] 'process raft request' (duration: 242.705427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:53:58.697159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.492222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-23T04:53:58.69724Z","caller":"traceutil/trace.go:171","msg":"trace[1100663209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8444; }","duration":"230.604234ms","start":"2026-06-23T04:53:58.46662Z","end":"2026-06-23T04:53:58.697224Z","steps":["trace[1100663209] 'agreement among raft nodes before linearized reading' (duration: 230.39412ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:59.860519Z","caller":"traceutil/trace.go:171","msg":"trace[743568530] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"130.466932ms","start":"2026-06-23T04:53:59.730029Z","end":"2026-06-23T04:53:59.860496Z","steps":["trace[743568530] 'process raft request' (duration: 130.429011ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:53:59.86057Z","caller":"traceutil/trace.go:171","msg":"trace[2052407753] transaction","detail":"{read_only:false; response_revision:8450; number_of_response:1; }","duration":"151.262226ms","start":"2026-06-23T04:53:59.709246Z","end":"2026-06-23T04:53:59.860508Z","steps":["trace[2052407753] 'process raft request' (duration: 66.523148ms)","trace[2052407753] 'compare' (duration: 84.276419ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:53:59.860607Z","caller":"traceutil/trace.go:171","msg":"trace[492968748] transaction","detail":"{read_only:false; response_revision:8451; number_of_response:1; }","duration":"137.250904ms","start":"2026-06-23T04:53:59.723316Z","end":"2026-06-23T04:53:59.860567Z","steps":["trace[492968748] 'process raft request' (duration: 137.08849ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:00.830225Z","caller":"traceutil/trace.go:171","msg":"trace[1340225820] transaction","detail":"{read_only:false; response_revision:8454; number_of_response:1; }","duration":"125.912516ms","start":"2026-06-23T04:54:00.704284Z","end":"2026-06-23T04:54:00.830196Z","steps":["trace[1340225820] 'process raft request' (duration: 125.721422ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:00.835638Z","caller":"traceutil/trace.go:171","msg":"trace[181627266] transaction","detail":"{read_only:false; response_revision:8455; number_of_response:1; }","duration":"129.792497ms","start":"2026-06-23T04:54:00.705794Z","end":"2026-06-23T04:54:00.835587Z","steps":["trace[181627266] 'process raft request' (duration: 129.655244ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:03.590411Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000224c.wal"} {"level":"info","ts":"2026-06-23T04:54:25.86681Z","caller":"traceutil/trace.go:171","msg":"trace[795105292] transaction","detail":"{read_only:false; response_revision:8637; number_of_response:1; }","duration":"131.518201ms","start":"2026-06-23T04:54:25.735256Z","end":"2026-06-23T04:54:25.866775Z","steps":["trace[795105292] 'process raft request' (duration: 131.359908ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:25.883347Z","caller":"traceutil/trace.go:171","msg":"trace[713015074] linearizableReadLoop","detail":"{readStateIndex:8950; appliedIndex:8948; }","duration":"107.755151ms","start":"2026-06-23T04:54:25.775571Z","end":"2026-06-23T04:54:25.883326Z","steps":["trace[713015074] 'read index received' (duration: 90.989096ms)","trace[713015074] 'applied index is now lower than readState.Index' (duration: 16.764545ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:54:25.883415Z","caller":"traceutil/trace.go:171","msg":"trace[67823242] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"145.5495ms","start":"2026-06-23T04:54:25.737846Z","end":"2026-06-23T04:54:25.883396Z","steps":["trace[67823242] 'process raft request' (duration: 145.360926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:25.883621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.026707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-csi-config\" ","response":"range_response_count:1 size:512"} {"level":"info","ts":"2026-06-23T04:54:25.883706Z","caller":"traceutil/trace.go:171","msg":"trace[21221403] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-csi-config; range_end:; response_count:1; response_revision:8638; }","duration":"108.20353ms","start":"2026-06-23T04:54:25.775483Z","end":"2026-06-23T04:54:25.883687Z","steps":["trace[21221403] 'agreement among raft nodes before linearized reading' (duration: 107.952405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:29.244521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.311085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-23T04:54:29.244664Z","caller":"traceutil/trace.go:171","msg":"trace[282492645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8658; }","duration":"275.53069ms","start":"2026-06-23T04:54:28.969111Z","end":"2026-06-23T04:54:29.244642Z","steps":["trace[282492645] 'range keys from in-memory index tree' (duration: 275.0658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:29.244811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.059522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:54:29.244882Z","caller":"traceutil/trace.go:171","msg":"trace[481391527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8658; }","duration":"314.176215ms","start":"2026-06-23T04:54:28.93069Z","end":"2026-06-23T04:54:29.244866Z","steps":["trace[481391527] 'range keys from in-memory index tree' (duration: 313.977801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:29.244933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:54:28.930669Z","time spent":"314.256616ms","remote":"127.0.0.1:35500","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-06-23T04:54:29.245134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.672256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-23T04:54:29.245246Z","caller":"traceutil/trace.go:171","msg":"trace[1394587171] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8658; }","duration":"281.823398ms","start":"2026-06-23T04:54:28.963401Z","end":"2026-06-23T04:54:29.245224Z","steps":["trace[1394587171] 'range keys from in-memory index tree' (duration: 281.498242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:29.245417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.881505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-23T04:54:29.245514Z","caller":"traceutil/trace.go:171","msg":"trace[1027150721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8658; }","duration":"291.030058ms","start":"2026-06-23T04:54:28.954463Z","end":"2026-06-23T04:54:29.245493Z","steps":["trace[1027150721] 'range keys from in-memory index tree' (duration: 290.320373ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:29.523641Z","caller":"traceutil/trace.go:171","msg":"trace[711036219] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"274.459697ms","start":"2026-06-23T04:54:29.249155Z","end":"2026-06-23T04:54:29.523615Z","steps":["trace[711036219] 'process raft request' (duration: 274.265423ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:29.524635Z","caller":"traceutil/trace.go:171","msg":"trace[1686414860] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"275.445877ms","start":"2026-06-23T04:54:29.249171Z","end":"2026-06-23T04:54:29.524617Z","steps":["trace[1686414860] 'process raft request' (duration: 275.321894ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:29.524798Z","caller":"traceutil/trace.go:171","msg":"trace[816676221] linearizableReadLoop","detail":"{readStateIndex:8974; appliedIndex:8971; }","duration":"216.662158ms","start":"2026-06-23T04:54:29.308113Z","end":"2026-06-23T04:54:29.524775Z","steps":["trace[816676221] 'read index received' (duration: 215.384182ms)","trace[816676221] 'applied index is now lower than readState.Index' (duration: 1.276146ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:54:29.524911Z","caller":"traceutil/trace.go:171","msg":"trace[922324591] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"274.652281ms","start":"2026-06-23T04:54:29.250252Z","end":"2026-06-23T04:54:29.524904Z","steps":["trace[922324591] 'process raft request' (duration: 274.343694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:29.525051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.930463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-23T04:54:29.525134Z","caller":"traceutil/trace.go:171","msg":"trace[516427909] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8661; }","duration":"217.071606ms","start":"2026-06-23T04:54:29.308039Z","end":"2026-06-23T04:54:29.525111Z","steps":["trace[516427909] 'agreement among raft nodes before linearized reading' (duration: 216.847941ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:33.671615Z","caller":"traceutil/trace.go:171","msg":"trace[2051463295] transaction","detail":"{read_only:false; response_revision:8680; number_of_response:1; }","duration":"124.696221ms","start":"2026-06-23T04:54:33.546894Z","end":"2026-06-23T04:54:33.67159Z","steps":["trace[2051463295] 'process raft request' (duration: 124.587519ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:33.671679Z","caller":"traceutil/trace.go:171","msg":"trace[578385441] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"125.417436ms","start":"2026-06-23T04:54:33.546218Z","end":"2026-06-23T04:54:33.671635Z","steps":["trace[578385441] 'process raft request' (duration: 125.085899ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:33.671857Z","caller":"traceutil/trace.go:171","msg":"trace[1732589022] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"124.783653ms","start":"2026-06-23T04:54:33.547061Z","end":"2026-06-23T04:54:33.671845Z","steps":["trace[1732589022] 'process raft request' (duration: 124.461226ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:33.671854Z","caller":"traceutil/trace.go:171","msg":"trace[134829967] linearizableReadLoop","detail":"{readStateIndex:8995; appliedIndex:8991; }","duration":"118.706118ms","start":"2026-06-23T04:54:33.55312Z","end":"2026-06-23T04:54:33.671826Z","steps":["trace[134829967] 'read index received' (duration: 13.594939ms)","trace[134829967] 'applied index is now lower than readState.Index' (duration: 105.108859ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:54:33.672071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.932482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tn2f\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-23T04:54:33.672128Z","caller":"traceutil/trace.go:171","msg":"trace[2129642309] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tn2f; range_end:; response_count:1; response_revision:8681; }","duration":"119.005194ms","start":"2026-06-23T04:54:33.553108Z","end":"2026-06-23T04:54:33.672113Z","steps":["trace[2129642309] 'agreement among raft nodes before linearized reading' (duration: 118.790389ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:34.27361Z","caller":"traceutil/trace.go:171","msg":"trace[1504410145] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"289.984053ms","start":"2026-06-23T04:54:33.983598Z","end":"2026-06-23T04:54:34.273582Z","steps":["trace[1504410145] 'process raft request' (duration: 201.740632ms)","trace[1504410145] 'compare' (duration: 87.961746ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:54:34.308226Z","caller":"traceutil/trace.go:171","msg":"trace[531957607] transaction","detail":"{read_only:false; response_revision:8685; number_of_response:1; }","duration":"321.906618ms","start":"2026-06-23T04:54:33.986301Z","end":"2026-06-23T04:54:34.308207Z","steps":["trace[531957607] 'process raft request' (duration: 321.772785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:34.308348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:54:33.986276Z","time spent":"322.007441ms","remote":"127.0.0.1:35738","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-06-23T04:54:34.308407Z","caller":"traceutil/trace.go:171","msg":"trace[173442736] linearizableReadLoop","detail":"{readStateIndex:9000; appliedIndex:8997; }","duration":"231.36784ms","start":"2026-06-23T04:54:34.077013Z","end":"2026-06-23T04:54:34.308381Z","steps":["trace[173442736] 'read index received' (duration: 108.438326ms)","trace[173442736] 'applied index is now lower than readState.Index' (duration: 122.927624ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:54:34.30845Z","caller":"traceutil/trace.go:171","msg":"trace[441393441] transaction","detail":"{read_only:false; response_revision:8686; number_of_response:1; }","duration":"321.382888ms","start":"2026-06-23T04:54:33.987058Z","end":"2026-06-23T04:54:34.308441Z","steps":["trace[441393441] 'process raft request' (duration: 321.119513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:34.308584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.554633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-23T04:54:34.30862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:54:33.987044Z","time spent":"321.449249ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:54:34.30866Z","caller":"traceutil/trace.go:171","msg":"trace[1832167411] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:8686; }","duration":"231.695907ms","start":"2026-06-23T04:54:34.076946Z","end":"2026-06-23T04:54:34.308642Z","steps":["trace[1832167411] 'agreement among raft nodes before linearized reading' (duration: 231.545924ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:44.081614Z","caller":"traceutil/trace.go:171","msg":"trace[1697589911] linearizableReadLoop","detail":"{readStateIndex:9094; appliedIndex:9093; }","duration":"102.569997ms","start":"2026-06-23T04:54:43.979013Z","end":"2026-06-23T04:54:44.081583Z","steps":["trace[1697589911] 'read index received' (duration: 102.345192ms)","trace[1697589911] 'applied index is now lower than readState.Index' (duration: 223.485µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:54:44.081696Z","caller":"traceutil/trace.go:171","msg":"trace[1378543743] transaction","detail":"{read_only:false; response_revision:8776; number_of_response:1; }","duration":"122.815171ms","start":"2026-06-23T04:54:43.958851Z","end":"2026-06-23T04:54:44.081666Z","steps":["trace[1378543743] 'process raft request' (duration: 122.509465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:54:44.081886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.854553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-23T04:54:44.08193Z","caller":"traceutil/trace.go:171","msg":"trace[1814060792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8776; }","duration":"102.970065ms","start":"2026-06-23T04:54:43.978949Z","end":"2026-06-23T04:54:44.081919Z","steps":["trace[1814060792] 'agreement among raft nodes before linearized reading' (duration: 102.782862ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:44.37374Z","caller":"traceutil/trace.go:171","msg":"trace[1311947440] transaction","detail":"{read_only:false; response_revision:8778; number_of_response:1; }","duration":"286.476706ms","start":"2026-06-23T04:54:44.087238Z","end":"2026-06-23T04:54:44.373715Z","steps":["trace[1311947440] 'process raft request' (duration: 286.281372ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:44.509458Z","caller":"traceutil/trace.go:171","msg":"trace[1855226792] transaction","detail":"{read_only:false; response_revision:8779; number_of_response:1; }","duration":"398.6998ms","start":"2026-06-23T04:54:44.110729Z","end":"2026-06-23T04:54:44.509429Z","steps":["trace[1855226792] 'process raft request' (duration: 353.496436ms)","trace[1855226792] 'compare' (duration: 44.957099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:54:44.509651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:54:44.1107Z","time spent":"398.867443ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4638,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:54:44.510316Z","caller":"traceutil/trace.go:171","msg":"trace[928473864] transaction","detail":"{read_only:false; response_revision:8782; number_of_response:1; }","duration":"162.576773ms","start":"2026-06-23T04:54:44.347724Z","end":"2026-06-23T04:54:44.5103Z","steps":["trace[928473864] 'process raft request' (duration: 162.531332ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:44.510322Z","caller":"traceutil/trace.go:171","msg":"trace[1357421838] transaction","detail":"{read_only:false; response_revision:8780; number_of_response:1; }","duration":"201.04503ms","start":"2026-06-23T04:54:44.309251Z","end":"2026-06-23T04:54:44.510296Z","steps":["trace[1357421838] 'process raft request' (duration: 200.142132ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:44.510547Z","caller":"traceutil/trace.go:171","msg":"trace[376205834] transaction","detail":"{read_only:false; response_revision:8781; number_of_response:1; }","duration":"164.046353ms","start":"2026-06-23T04:54:44.346423Z","end":"2026-06-23T04:54:44.510469Z","steps":["trace[376205834] 'process raft request' (duration: 163.795098ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:45.385823Z","caller":"traceutil/trace.go:171","msg":"trace[1558717838] transaction","detail":"{read_only:false; response_revision:8786; number_of_response:1; }","duration":"132.552967ms","start":"2026-06-23T04:54:45.253241Z","end":"2026-06-23T04:54:45.385794Z","steps":["trace[1558717838] 'process raft request' (duration: 132.352613ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:54:45.81814Z","caller":"traceutil/trace.go:171","msg":"trace[406035598] transaction","detail":"{read_only:false; response_revision:8789; number_of_response:1; }","duration":"162.93766ms","start":"2026-06-23T04:54:45.655151Z","end":"2026-06-23T04:54:45.818089Z","steps":["trace[406035598] 'process raft request' (duration: 162.729515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:55:48.976811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.883692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:55:48.977083Z","caller":"traceutil/trace.go:171","msg":"trace[1707459738] linearizableReadLoop","detail":"{readStateIndex:9798; appliedIndex:9794; }","duration":"154.473852ms","start":"2026-06-23T04:55:48.822589Z","end":"2026-06-23T04:55:48.977062Z","steps":["trace[1707459738] 'read index received' (duration: 40.365755ms)","trace[1707459738] 'applied index is now lower than readState.Index' (duration: 114.107117ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:55:48.977122Z","caller":"traceutil/trace.go:171","msg":"trace[111535328] transaction","detail":"{read_only:false; response_revision:9461; number_of_response:1; }","duration":"194.800146ms","start":"2026-06-23T04:55:48.782292Z","end":"2026-06-23T04:55:48.977092Z","steps":["trace[111535328] 'process raft request' (duration: 194.644433ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:55:48.977147Z","caller":"traceutil/trace.go:171","msg":"trace[201956107] transaction","detail":"{read_only:false; response_revision:9460; number_of_response:1; }","duration":"195.841688ms","start":"2026-06-23T04:55:48.781277Z","end":"2026-06-23T04:55:48.977119Z","steps":["trace[201956107] 'process raft request' (duration: 81.561328ms)","trace[201956107] 'compare' (duration: 113.747869ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:55:48.977187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.589004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:55:48.977223Z","caller":"traceutil/trace.go:171","msg":"trace[401450093] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:9463; }","duration":"154.651596ms","start":"2026-06-23T04:55:48.822559Z","end":"2026-06-23T04:55:48.977211Z","steps":["trace[401450093] 'agreement among raft nodes before linearized reading' (duration: 154.564244ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:55:48.977374Z","caller":"traceutil/trace.go:171","msg":"trace[478409752] transaction","detail":"{read_only:false; response_revision:9462; number_of_response:1; }","duration":"194.94491ms","start":"2026-06-23T04:55:48.782413Z","end":"2026-06-23T04:55:48.977358Z","steps":["trace[478409752] 'process raft request' (duration: 194.577692ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:55:48.977425Z","caller":"traceutil/trace.go:171","msg":"trace[2074499975] transaction","detail":"{read_only:false; response_revision:9463; number_of_response:1; }","duration":"194.928479ms","start":"2026-06-23T04:55:48.782485Z","end":"2026-06-23T04:55:48.977414Z","steps":["trace[2074499975] 'process raft request' (duration: 194.538291ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:56:06.235328Z","caller":"traceutil/trace.go:171","msg":"trace[174927033] transaction","detail":"{read_only:false; response_revision:9557; number_of_response:1; }","duration":"170.208236ms","start":"2026-06-23T04:56:06.06509Z","end":"2026-06-23T04:56:06.235299Z","steps":["trace[174927033] 'process raft request' (duration: 170.023802ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:56:06.459327Z","caller":"traceutil/trace.go:171","msg":"trace[1637306789] transaction","detail":"{read_only:false; response_revision:9559; number_of_response:1; }","duration":"153.330572ms","start":"2026-06-23T04:56:06.30596Z","end":"2026-06-23T04:56:06.45929Z","steps":["trace[1637306789] 'process raft request' (duration: 122.336627ms)","trace[1637306789] 'compare' (duration: 30.852502ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:56:06.4641Z","caller":"traceutil/trace.go:171","msg":"trace[1069195384] transaction","detail":"{read_only:false; response_revision:9560; number_of_response:1; }","duration":"156.623597ms","start":"2026-06-23T04:56:06.307461Z","end":"2026-06-23T04:56:06.464085Z","steps":["trace[1069195384] 'process raft request' (duration: 156.500185ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:56:06.464528Z","caller":"traceutil/trace.go:171","msg":"trace[353747472] transaction","detail":"{read_only:false; response_revision:9561; number_of_response:1; }","duration":"156.895133ms","start":"2026-06-23T04:56:06.307618Z","end":"2026-06-23T04:56:06.464513Z","steps":["trace[353747472] 'process raft request' (duration: 156.427543ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:56:18.070616Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T04:56:18.076314Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-23T04:56:18.076397Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-06-23T04:57:10.95416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.934603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e4c92958-857f-4d9d-9809-44f7bdd6da79\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-23T04:57:10.954272Z","caller":"traceutil/trace.go:171","msg":"trace[1741503591] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e4c92958-857f-4d9d-9809-44f7bdd6da79; range_end:; response_count:1; response_revision:10014; }","duration":"126.060275ms","start":"2026-06-23T04:57:10.828174Z","end":"2026-06-23T04:57:10.954234Z","steps":["trace[1741503591] 'range keys from in-memory index tree' (duration: 125.78422ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:58:13.889884Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8030} {"level":"info","ts":"2026-06-23T04:58:13.95415Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8030,"took":"62.220005ms","hash":190988117,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":28819456,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-23T04:58:13.954197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":190988117,"revision":8030,"compact-revision":5961} {"level":"warn","ts":"2026-06-23T05:01:22.691457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.8684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T05:01:22.691724Z","caller":"traceutil/trace.go:171","msg":"trace[103444549] linearizableReadLoop","detail":"{readStateIndex:12285; appliedIndex:12283; }","duration":"191.844576ms","start":"2026-06-23T05:01:22.499862Z","end":"2026-06-23T05:01:22.691707Z","steps":["trace[103444549] 'read index received' (duration: 32.63699ms)","trace[103444549] 'applied index is now lower than readState.Index' (duration: 159.206416ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:01:22.691792Z","caller":"traceutil/trace.go:171","msg":"trace[658694959] transaction","detail":"{read_only:false; response_revision:11871; number_of_response:1; }","duration":"436.734706ms","start":"2026-06-23T05:01:22.255027Z","end":"2026-06-23T05:01:22.691762Z","steps":["trace[658694959] 'process raft request' (duration: 436.570732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:01:22.691833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.978239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T05:01:22.69198Z","caller":"traceutil/trace.go:171","msg":"trace[1064967362] transaction","detail":"{read_only:false; response_revision:11870; number_of_response:1; }","duration":"437.804176ms","start":"2026-06-23T05:01:22.254103Z","end":"2026-06-23T05:01:22.691907Z","steps":["trace[1064967362] 'process raft request' (duration: 278.388816ms)","trace[1064967362] 'compare' (duration: 158.586135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:01:22.692331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:01:22.254078Z","time spent":"438.062841ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:01:22.692056Z","caller":"traceutil/trace.go:171","msg":"trace[1266028388] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:11871; }","duration":"192.243384ms","start":"2026-06-23T05:01:22.499772Z","end":"2026-06-23T05:01:22.692015Z","steps":["trace[1266028388] 'agreement among raft nodes before linearized reading' (duration: 192.02645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:01:22.691967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:01:22.255021Z","time spent":"436.864448ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:01:50.33128Z","caller":"traceutil/trace.go:171","msg":"trace[18019507] transaction","detail":"{read_only:false; response_revision:12020; number_of_response:1; }","duration":"182.281626ms","start":"2026-06-23T05:01:50.148964Z","end":"2026-06-23T05:01:50.331246Z","steps":["trace[18019507] 'process raft request' (duration: 182.046657ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:03:13.896291Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10436} {"level":"info","ts":"2026-06-23T05:03:13.987003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10436,"took":"88.859986ms","hash":1503271297,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":26488832,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-23T05:03:13.987069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1503271297,"revision":10436,"compact-revision":8030} {"level":"info","ts":"2026-06-23T05:08:13.90561Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12565} {"level":"info","ts":"2026-06-23T05:08:13.990211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12565,"took":"80.849024ms","hash":3222560655,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":28016640,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T05:08:13.990288Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3222560655,"revision":12565,"compact-revision":10436} {"level":"warn","ts":"2026-06-23T05:08:22.458663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.597578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T05:08:22.458751Z","caller":"traceutil/trace.go:171","msg":"trace[296634538] linearizableReadLoop","detail":"{readStateIndex:15188; appliedIndex:15186; }","duration":"477.980573ms","start":"2026-06-23T05:08:21.980756Z","end":"2026-06-23T05:08:22.458737Z","steps":["trace[296634538] 'read index received' (duration: 24.481144ms)","trace[296634538] 'applied index is now lower than readState.Index' (duration: 453.498569ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:08:22.458779Z","caller":"traceutil/trace.go:171","msg":"trace[1257132352] transaction","detail":"{read_only:false; response_revision:14677; number_of_response:1; }","duration":"479.098545ms","start":"2026-06-23T05:08:21.979668Z","end":"2026-06-23T05:08:22.458767Z","steps":["trace[1257132352] 'process raft request' (duration: 337.326242ms)","trace[1257132352] 'compare' (duration: 141.226498ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:08:22.458854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:08:21.97961Z","time spent":"479.196248ms","remote":"127.0.0.1:35738","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-06-23T05:08:22.458885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.130007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-85lsw\" ","response":"range_response_count:1 size:11628"} {"level":"info","ts":"2026-06-23T05:08:22.458913Z","caller":"traceutil/trace.go:171","msg":"trace[1839335345] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-85lsw; range_end:; response_count:1; response_revision:14677; }","duration":"478.158418ms","start":"2026-06-23T05:08:21.980746Z","end":"2026-06-23T05:08:22.458905Z","steps":["trace[1839335345] 'agreement among raft nodes before linearized reading' (duration: 478.043175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:08:22.458945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:08:21.980696Z","time spent":"478.242541ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11651,"request content":"key:\"/registry/pods/openstack/openvswitch-85lsw\" "} {"level":"info","ts":"2026-06-23T05:08:22.533774Z","caller":"traceutil/trace.go:171","msg":"trace[585698153] transaction","detail":"{read_only:false; response_revision:14678; number_of_response:1; }","duration":"274.985331ms","start":"2026-06-23T05:08:22.258763Z","end":"2026-06-23T05:08:22.533748Z","steps":["trace[585698153] 'process raft request' (duration: 274.763124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:08:22.533985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.502406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-23T05:08:22.534055Z","caller":"traceutil/trace.go:171","msg":"trace[1031984968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14679; }","duration":"259.585878ms","start":"2026-06-23T05:08:22.274452Z","end":"2026-06-23T05:08:22.534038Z","steps":["trace[1031984968] 'agreement among raft nodes before linearized reading' (duration: 259.433744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:08:22.534078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.75659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tn2f\" ","response":"range_response_count:1 size:6451"} {"level":"warn","ts":"2026-06-23T05:08:22.534094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.865402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T05:08:22.534154Z","caller":"traceutil/trace.go:171","msg":"trace[855763205] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tn2f; range_end:; response_count:1; response_revision:14679; }","duration":"293.869634ms","start":"2026-06-23T05:08:22.24027Z","end":"2026-06-23T05:08:22.534139Z","steps":["trace[855763205] 'agreement among raft nodes before linearized reading' (duration: 293.644947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:08:22.534163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.970339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-23T05:08:22.534176Z","caller":"traceutil/trace.go:171","msg":"trace[291564289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14679; }","duration":"264.010415ms","start":"2026-06-23T05:08:22.270144Z","end":"2026-06-23T05:08:22.534155Z","steps":["trace[291564289] 'agreement among raft nodes before linearized reading' (duration: 263.756328ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:08:22.534204Z","caller":"traceutil/trace.go:171","msg":"trace[1176294333] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14679; }","duration":"189.058702ms","start":"2026-06-23T05:08:22.345136Z","end":"2026-06-23T05:08:22.534195Z","steps":["trace[1176294333] 'agreement among raft nodes before linearized reading' (duration: 188.95889ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:08:22.534079Z","caller":"traceutil/trace.go:171","msg":"trace[1960148432] transaction","detail":"{read_only:false; response_revision:14679; number_of_response:1; }","duration":"270.933014ms","start":"2026-06-23T05:08:22.263119Z","end":"2026-06-23T05:08:22.534052Z","steps":["trace[1960148432] 'process raft request' (duration: 270.572054ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:08:45.47904Z","caller":"traceutil/trace.go:171","msg":"trace[1798174493] transaction","detail":"{read_only:false; response_revision:14994; number_of_response:1; }","duration":"202.008712ms","start":"2026-06-23T05:08:45.277Z","end":"2026-06-23T05:08:45.479009Z","steps":["trace[1798174493] 'process raft request' (duration: 138.728326ms)","trace[1798174493] 'compare' (duration: 62.882864ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:08:45.479002Z","caller":"traceutil/trace.go:171","msg":"trace[1011114569] linearizableReadLoop","detail":"{readStateIndex:15519; appliedIndex:15518; }","duration":"179.785791ms","start":"2026-06-23T05:08:45.299193Z","end":"2026-06-23T05:08:45.478978Z","steps":["trace[1011114569] 'read index received' (duration: 116.457814ms)","trace[1011114569] 'applied index is now lower than readState.Index' (duration: 63.327087ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:08:45.479191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.983576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-31b02b46-71eb-4907-95be-d62cedefb54f\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-23T05:08:45.479243Z","caller":"traceutil/trace.go:171","msg":"trace[1791605460] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-31b02b46-71eb-4907-95be-d62cedefb54f; range_end:; response_count:1; response_revision:14994; }","duration":"180.082909ms","start":"2026-06-23T05:08:45.29915Z","end":"2026-06-23T05:08:45.479233Z","steps":["trace[1791605460] 'agreement among raft nodes before linearized reading' (duration: 179.911534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:08:45.479451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.508576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-31b02b46-71eb-4907-95be-d62cedefb54f\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-23T05:08:45.47951Z","caller":"traceutil/trace.go:171","msg":"trace[1626742009] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-31b02b46-71eb-4907-95be-d62cedefb54f; range_end:; response_count:1; response_revision:14994; }","duration":"128.623409ms","start":"2026-06-23T05:08:45.350869Z","end":"2026-06-23T05:08:45.479492Z","steps":["trace[1626742009] 'agreement among raft nodes before linearized reading' (duration: 128.422574ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:08:45.782794Z","caller":"traceutil/trace.go:171","msg":"trace[1707009526] transaction","detail":"{read_only:false; response_revision:14995; number_of_response:1; }","duration":"297.290305ms","start":"2026-06-23T05:08:45.485468Z","end":"2026-06-23T05:08:45.782758Z","steps":["trace[1707009526] 'process raft request' (duration: 252.197735ms)","trace[1707009526] 'compare' (duration: 44.965576ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:09:38.818511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.793311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T05:09:38.81864Z","caller":"traceutil/trace.go:171","msg":"trace[760889615] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15628; }","duration":"209.958195ms","start":"2026-06-23T05:09:38.608664Z","end":"2026-06-23T05:09:38.818622Z","steps":["trace[760889615] 'range keys from in-memory index tree' (duration: 209.738979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.818704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.443371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T05:09:38.818782Z","caller":"traceutil/trace.go:171","msg":"trace[380265956] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15628; }","duration":"209.547264ms","start":"2026-06-23T05:09:38.609218Z","end":"2026-06-23T05:09:38.818765Z","steps":["trace[380265956] 'range keys from in-memory index tree' (duration: 209.373739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.818899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.287587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T05:09:38.818984Z","caller":"traceutil/trace.go:171","msg":"trace[1155405732] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15628; }","duration":"363.441312ms","start":"2026-06-23T05:09:38.455522Z","end":"2026-06-23T05:09:38.818964Z","steps":["trace[1155405732] 'range keys from in-memory index tree' (duration: 363.229076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.819026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:09:38.455516Z","time spent":"363.500753ms","remote":"127.0.0.1:35728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-06-23T05:09:38.819034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.168911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-06-23T05:09:38.819073Z","caller":"traceutil/trace.go:171","msg":"trace[1297954241] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15628; }","duration":"289.266155ms","start":"2026-06-23T05:09:38.529797Z","end":"2026-06-23T05:09:38.819063Z","steps":["trace[1297954241] 'range keys from in-memory index tree' (duration: 288.937345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.819107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.399674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-23T05:09:38.81918Z","caller":"traceutil/trace.go:171","msg":"trace[1326317657] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15628; }","duration":"207.540518ms","start":"2026-06-23T05:09:38.611622Z","end":"2026-06-23T05:09:38.819163Z","steps":["trace[1326317657] 'range keys from in-memory index tree' (duration: 207.139458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.81921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.933146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-23T05:09:38.819247Z","caller":"traceutil/trace.go:171","msg":"trace[1961112221] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15628; }","duration":"364.009457ms","start":"2026-06-23T05:09:38.455227Z","end":"2026-06-23T05:09:38.819237Z","steps":["trace[1961112221] 'range keys from in-memory index tree' (duration: 363.789201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.819292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:09:38.455204Z","time spent":"364.082389ms","remote":"127.0.0.1:35728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5471,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-06-23T05:09:38.819269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.129143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-06-23T05:09:38.819354Z","caller":"traceutil/trace.go:171","msg":"trace[114603937] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15628; }","duration":"363.255166ms","start":"2026-06-23T05:09:38.456074Z","end":"2026-06-23T05:09:38.819329Z","steps":["trace[114603937] 'range keys from in-memory index tree' (duration: 362.956338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.819394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:09:38.456052Z","time spent":"363.333159ms","remote":"127.0.0.1:35652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-06-23T05:09:38.8199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.654692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T05:09:38.819952Z","caller":"traceutil/trace.go:171","msg":"trace[1438815651] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15628; }","duration":"211.704804ms","start":"2026-06-23T05:09:38.608234Z","end":"2026-06-23T05:09:38.819939Z","steps":["trace[1438815651] 'range keys from in-memory index tree' (duration: 211.5813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:09:38.820092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.667906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-mcwjg\" ","response":"range_response_count:1 size:9712"} {"level":"info","ts":"2026-06-23T05:09:38.820118Z","caller":"traceutil/trace.go:171","msg":"trace[1694185599] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-mcwjg; range_end:; response_count:1; response_revision:15628; }","duration":"243.768048ms","start":"2026-06-23T05:09:38.576341Z","end":"2026-06-23T05:09:38.82011Z","steps":["trace[1694185599] 'range keys from in-memory index tree' (duration: 243.350906ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:10:07.757273Z","caller":"traceutil/trace.go:171","msg":"trace[290177537] transaction","detail":"{read_only:false; response_revision:15784; number_of_response:1; }","duration":"208.113214ms","start":"2026-06-23T05:10:07.549102Z","end":"2026-06-23T05:10:07.757215Z","steps":["trace[290177537] 'process raft request' (duration: 207.956209ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:10:07.76826Z","caller":"traceutil/trace.go:171","msg":"trace[1444916589] transaction","detail":"{read_only:false; response_revision:15786; number_of_response:1; }","duration":"208.029211ms","start":"2026-06-23T05:10:07.560216Z","end":"2026-06-23T05:10:07.768245Z","steps":["trace[1444916589] 'process raft request' (duration: 207.713682ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:10:07.768462Z","caller":"traceutil/trace.go:171","msg":"trace[869454966] transaction","detail":"{read_only:false; response_revision:15785; number_of_response:1; }","duration":"216.694617ms","start":"2026-06-23T05:10:07.551751Z","end":"2026-06-23T05:10:07.768445Z","steps":["trace[869454966] 'process raft request' (duration: 215.996828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:10:09.322253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.585028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T05:10:09.322359Z","caller":"traceutil/trace.go:171","msg":"trace[801744549] linearizableReadLoop","detail":"{readStateIndex:16340; appliedIndex:16339; }","duration":"240.314224ms","start":"2026-06-23T05:10:09.082029Z","end":"2026-06-23T05:10:09.322344Z","steps":["trace[801744549] 'read index received' (duration: 12.546682ms)","trace[801744549] 'applied index is now lower than readState.Index' (duration: 227.766242ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:10:09.322629Z","caller":"traceutil/trace.go:171","msg":"trace[821563278] transaction","detail":"{read_only:false; response_revision:15791; number_of_response:1; }","duration":"253.590984ms","start":"2026-06-23T05:10:09.069025Z","end":"2026-06-23T05:10:09.322616Z","steps":["trace[821563278] 'process raft request' (duration: 25.550615ms)","trace[821563278] 'compare' (duration: 227.382321ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:10:09.323177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.912443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-mcwjg\" ","response":"range_response_count:1 size:9712"} {"level":"warn","ts":"2026-06-23T05:10:09.32325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.464253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-23T05:10:09.323238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.189547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T05:10:09.323281Z","caller":"traceutil/trace.go:171","msg":"trace[2116558412] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-mcwjg; range_end:; response_count:1; response_revision:15791; }","duration":"119.052547ms","start":"2026-06-23T05:10:09.204202Z","end":"2026-06-23T05:10:09.323255Z","steps":["trace[2116558412] 'agreement among raft nodes before linearized reading' (duration: 118.79326ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:10:09.323306Z","caller":"traceutil/trace.go:171","msg":"trace[812451884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15791; }","duration":"238.554086ms","start":"2026-06-23T05:10:09.084737Z","end":"2026-06-23T05:10:09.323291Z","steps":["trace[812451884] 'agreement among raft nodes before linearized reading' (duration: 237.953069ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:10:09.323327Z","caller":"traceutil/trace.go:171","msg":"trace[698205267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15791; }","duration":"241.320441ms","start":"2026-06-23T05:10:09.081984Z","end":"2026-06-23T05:10:09.323305Z","steps":["trace[698205267] 'agreement among raft nodes before linearized reading' (duration: 241.035163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:10:09.826949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.689715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T05:10:09.827154Z","caller":"traceutil/trace.go:171","msg":"trace[1366885215] linearizableReadLoop","detail":"{readStateIndex:16342; appliedIndex:16340; }","duration":"422.424355ms","start":"2026-06-23T05:10:09.404713Z","end":"2026-06-23T05:10:09.827137Z","steps":["trace[1366885215] 'read index received' (duration: 224.466853ms)","trace[1366885215] 'applied index is now lower than readState.Index' (duration: 197.956572ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:10:09.827147Z","caller":"traceutil/trace.go:171","msg":"trace[503405422] transaction","detail":"{read_only:false; response_revision:15792; number_of_response:1; }","duration":"497.521666ms","start":"2026-06-23T05:10:09.329593Z","end":"2026-06-23T05:10:09.827114Z","steps":["trace[503405422] 'process raft request' (duration: 299.585725ms)","trace[503405422] 'compare' (duration: 197.413477ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:10:09.827263Z","caller":"traceutil/trace.go:171","msg":"trace[439918984] transaction","detail":"{read_only:false; response_revision:15793; number_of_response:1; }","duration":"497.591448ms","start":"2026-06-23T05:10:09.329633Z","end":"2026-06-23T05:10:09.827225Z","steps":["trace[439918984] 'process raft request' (duration: 497.417693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:10:09.827299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:10:09.329577Z","time spent":"497.63783ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T05:10:09.827389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.674131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-23T05:10:09.82741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:10:09.329613Z","time spent":"497.716692ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:10:09.827443Z","caller":"traceutil/trace.go:171","msg":"trace[1768999190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15793; }","duration":"422.731432ms","start":"2026-06-23T05:10:09.404696Z","end":"2026-06-23T05:10:09.827427Z","steps":["trace[1768999190] 'agreement among raft nodes before linearized reading' (duration: 422.518447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:10:09.82748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:10:09.404673Z","time spent":"422.798995ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T05:10:09.828138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.751935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T05:10:09.828228Z","caller":"traceutil/trace.go:171","msg":"trace[1041113175] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:15794; }","duration":"315.94469ms","start":"2026-06-23T05:10:09.512265Z","end":"2026-06-23T05:10:09.82821Z","steps":["trace[1041113175] 'agreement among raft nodes before linearized reading' (duration: 315.760735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:10:09.82818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.463283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tn2f\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-23T05:10:09.828335Z","caller":"traceutil/trace.go:171","msg":"trace[2111910593] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tn2f; range_end:; response_count:1; response_revision:15794; }","duration":"288.655148ms","start":"2026-06-23T05:10:09.539667Z","end":"2026-06-23T05:10:09.828322Z","steps":["trace[2111910593] 'agreement among raft nodes before linearized reading' (duration: 288.36396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:10:09.828274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:10:09.512248Z","time spent":"316.015411ms","remote":"127.0.0.1:35938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":39,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-06-23T05:13:13.912951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14619} {"level":"info","ts":"2026-06-23T05:13:13.992572Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14619,"took":"76.998729ms","hash":1815217921,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":33714176,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-23T05:13:13.992628Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1815217921,"revision":14619,"compact-revision":12565} {"level":"info","ts":"2026-06-23T05:16:24.451677Z","caller":"traceutil/trace.go:171","msg":"trace[162871255] linearizableReadLoop","detail":"{readStateIndex:19149; appliedIndex:19148; }","duration":"522.759509ms","start":"2026-06-23T05:16:23.928893Z","end":"2026-06-23T05:16:24.451653Z","steps":["trace[162871255] 'read index received' (duration: 70.839072ms)","trace[162871255] 'applied index is now lower than readState.Index' (duration: 451.916347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:16:24.451825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.904022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T05:16:24.451868Z","caller":"traceutil/trace.go:171","msg":"trace[424758482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18511; }","duration":"522.991325ms","start":"2026-06-23T05:16:23.928864Z","end":"2026-06-23T05:16:24.451855Z","steps":["trace[424758482] 'agreement among raft nodes before linearized reading' (duration: 522.903322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:24.4519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:23.92885Z","time spent":"523.042815ms","remote":"127.0.0.1:35500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T05:16:24.451741Z","caller":"traceutil/trace.go:171","msg":"trace[1582806743] transaction","detail":"{read_only:false; response_revision:18511; number_of_response:1; }","duration":"547.22684ms","start":"2026-06-23T05:16:23.904488Z","end":"2026-06-23T05:16:24.451715Z","steps":["trace[1582806743] 'process raft request' (duration: 541.174657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:24.452406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:23.904468Z","time spent":"547.864285ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T05:16:24.46209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.519331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T05:16:24.462149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.263052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T05:16:24.462186Z","caller":"traceutil/trace.go:171","msg":"trace[1792072391] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:18514; }","duration":"401.669734ms","start":"2026-06-23T05:16:24.060502Z","end":"2026-06-23T05:16:24.462171Z","steps":["trace[1792072391] 'agreement among raft nodes before linearized reading' (duration: 401.510111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:24.462971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:24.060483Z","time spent":"402.460763ms","remote":"127.0.0.1:60330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "} {"level":"info","ts":"2026-06-23T05:16:24.463053Z","caller":"traceutil/trace.go:171","msg":"trace[1293715050] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:18514; }","duration":"205.386785ms","start":"2026-06-23T05:16:24.256815Z","end":"2026-06-23T05:16:24.462202Z","steps":["trace[1293715050] 'agreement among raft nodes before linearized reading' (duration: 205.18833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:25.70959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203138019927702,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T05:16:26.210212Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203138019927702,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T05:16:26.328766Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.16020255s","expected-duration":"1s"} {"level":"info","ts":"2026-06-23T05:16:26.329171Z","caller":"traceutil/trace.go:171","msg":"trace[25227150] transaction","detail":"{read_only:false; response_revision:18516; number_of_response:1; }","duration":"1.160743143s","start":"2026-06-23T05:16:25.168399Z","end":"2026-06-23T05:16:26.329143Z","steps":["trace[25227150] 'process raft request' (duration: 1.160567139s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.329317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.168382Z","time spent":"1.160851775s","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:16:26.340713Z","caller":"traceutil/trace.go:171","msg":"trace[966535938] transaction","detail":"{read_only:false; response_revision:18517; number_of_response:1; }","duration":"1.166591332s","start":"2026-06-23T05:16:25.174102Z","end":"2026-06-23T05:16:26.340693Z","steps":["trace[966535938] 'process raft request' (duration: 1.166454979s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.340808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.174065Z","time spent":"1.166695645s","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:16:26.340896Z","caller":"traceutil/trace.go:171","msg":"trace[69279719] linearizableReadLoop","detail":"{readStateIndex:19156; appliedIndex:19153; }","duration":"1.131613252s","start":"2026-06-23T05:16:25.20925Z","end":"2026-06-23T05:16:26.340864Z","steps":["trace[69279719] 'read index received' (duration: 1.11973176s)","trace[69279719] 'applied index is now lower than readState.Index' (duration: 11.878402ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:16:26.340914Z","caller":"traceutil/trace.go:171","msg":"trace[873542042] transaction","detail":"{read_only:false; response_revision:18518; number_of_response:1; }","duration":"572.534065ms","start":"2026-06-23T05:16:25.768352Z","end":"2026-06-23T05:16:26.340886Z","steps":["trace[873542042] 'process raft request' (duration: 572.304209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.34106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.768328Z","time spent":"572.650377ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T05:16:26.341071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131779516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T05:16:26.341134Z","caller":"traceutil/trace.go:171","msg":"trace[1778742404] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:18518; }","duration":"1.131915339s","start":"2026-06-23T05:16:25.209202Z","end":"2026-06-23T05:16:26.341117Z","steps":["trace[1778742404] 'agreement among raft nodes before linearized reading' (duration: 1.131766096s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013464338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-06-23T05:16:26.341176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.209183Z","time spent":"1.13198529s","remote":"127.0.0.1:59970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"info","ts":"2026-06-23T05:16:26.341196Z","caller":"traceutil/trace.go:171","msg":"trace[284162909] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18518; }","duration":"1.01354043s","start":"2026-06-23T05:16:25.327642Z","end":"2026-06-23T05:16:26.341183Z","steps":["trace[284162909] 'agreement among raft nodes before linearized reading' (duration: 1.013368176s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.699064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T05:16:26.341236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.327632Z","time spent":"1.013596471s","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-23T05:16:26.341262Z","caller":"traceutil/trace.go:171","msg":"trace[1641312756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18518; }","duration":"410.753385ms","start":"2026-06-23T05:16:25.930497Z","end":"2026-06-23T05:16:26.341251Z","steps":["trace[1641312756] 'agreement among raft nodes before linearized reading' (duration: 410.708324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-23T05:16:26.341293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.930483Z","time spent":"410.804596ms","remote":"127.0.0.1:35502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T05:16:26.341313Z","caller":"traceutil/trace.go:171","msg":"trace[1450786590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18518; }","duration":"537.430352ms","start":"2026-06-23T05:16:25.803871Z","end":"2026-06-23T05:16:26.341301Z","steps":["trace[1450786590] 'agreement among raft nodes before linearized reading' (duration: 537.306559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.47005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-23T05:16:26.341353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.803863Z","time spent":"537.482763ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-23T05:16:26.341373Z","caller":"traceutil/trace.go:171","msg":"trace[1367325758] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18518; }","duration":"539.601163ms","start":"2026-06-23T05:16:25.801755Z","end":"2026-06-23T05:16:26.341356Z","steps":["trace[1367325758] 'agreement among raft nodes before linearized reading' (duration: 539.356677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.801737Z","time spent":"539.664295ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-23T05:16:26.341412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.60403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T05:16:26.341438Z","caller":"traceutil/trace.go:171","msg":"trace[1187368970] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18518; }","duration":"573.671412ms","start":"2026-06-23T05:16:25.767759Z","end":"2026-06-23T05:16:26.34143Z","steps":["trace[1187368970] 'agreement among raft nodes before linearized reading' (duration: 573.626651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.767738Z","time spent":"573.715332ms","remote":"127.0.0.1:36554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-23T05:16:26.34117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.481975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T05:16:26.341498Z","caller":"traceutil/trace.go:171","msg":"trace[25222196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18518; }","duration":"535.830353ms","start":"2026-06-23T05:16:25.805659Z","end":"2026-06-23T05:16:26.341489Z","steps":["trace[25222196] 'agreement among raft nodes before linearized reading' (duration: 535.388923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.341527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.805649Z","time spent":"535.869955ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T05:16:26.341523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.26913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-mcwjg\" ","response":"range_response_count:1 size:9713"} {"level":"info","ts":"2026-06-23T05:16:26.341596Z","caller":"traceutil/trace.go:171","msg":"trace[1822081619] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-mcwjg; range_end:; response_count:1; response_revision:18518; }","duration":"492.365002ms","start":"2026-06-23T05:16:25.849222Z","end":"2026-06-23T05:16:26.341587Z","steps":["trace[1822081619] 'agreement among raft nodes before linearized reading' (duration: 492.206469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.34163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:16:25.849211Z","time spent":"492.412263ms","remote":"127.0.0.1:35664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9736,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-mcwjg\" "} {"level":"info","ts":"2026-06-23T05:16:26.581821Z","caller":"traceutil/trace.go:171","msg":"trace[414033313] transaction","detail":"{read_only:false; response_revision:18520; number_of_response:1; }","duration":"236.033559ms","start":"2026-06-23T05:16:26.345771Z","end":"2026-06-23T05:16:26.581805Z","steps":["trace[414033313] 'process raft request' (duration: 191.698988ms)","trace[414033313] 'compare' (duration: 44.217629ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:16:26.582105Z","caller":"traceutil/trace.go:171","msg":"trace[958476055] transaction","detail":"{read_only:false; response_revision:18521; number_of_response:1; }","duration":"236.228964ms","start":"2026-06-23T05:16:26.34587Z","end":"2026-06-23T05:16:26.582099Z","steps":["trace[958476055] 'process raft request' (duration: 235.904377ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:16:26.582098Z","caller":"traceutil/trace.go:171","msg":"trace[239136217] linearizableReadLoop","detail":"{readStateIndex:19159; appliedIndex:19157; }","duration":"148.862122ms","start":"2026-06-23T05:16:26.433211Z","end":"2026-06-23T05:16:26.582073Z","steps":["trace[239136217] 'read index received' (duration: 104.269604ms)","trace[239136217] 'applied index is now lower than readState.Index' (duration: 44.591308ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:16:26.582332Z","caller":"traceutil/trace.go:171","msg":"trace[1560460445] transaction","detail":"{read_only:false; response_revision:18522; number_of_response:1; }","duration":"114.63386ms","start":"2026-06-23T05:16:26.467694Z","end":"2026-06-23T05:16:26.582328Z","steps":["trace[1560460445] 'process raft request' (duration: 114.303482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.582351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.867366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-23T05:16:26.582387Z","caller":"traceutil/trace.go:171","msg":"trace[1147571376] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18522; }","duration":"235.948148ms","start":"2026-06-23T05:16:26.346428Z","end":"2026-06-23T05:16:26.582376Z","steps":["trace[1147571376] 'agreement among raft nodes before linearized reading' (duration: 235.778914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:26.582404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.24941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T05:16:26.582465Z","caller":"traceutil/trace.go:171","msg":"trace[1631582552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18523; }","duration":"103.343432ms","start":"2026-06-23T05:16:26.479106Z","end":"2026-06-23T05:16:26.582449Z","steps":["trace[1631582552] 'agreement among raft nodes before linearized reading' (duration: 103.185238ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:16:26.582554Z","caller":"traceutil/trace.go:171","msg":"trace[1508003687] transaction","detail":"{read_only:false; response_revision:18523; number_of_response:1; }","duration":"113.78557ms","start":"2026-06-23T05:16:26.468716Z","end":"2026-06-23T05:16:26.582501Z","steps":["trace[1508003687] 'process raft request' (duration: 113.508663ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:16:31.05606Z","caller":"traceutil/trace.go:171","msg":"trace[1355625096] linearizableReadLoop","detail":"{readStateIndex:19210; appliedIndex:19209; }","duration":"125.472033ms","start":"2026-06-23T05:16:30.930575Z","end":"2026-06-23T05:16:31.056047Z","steps":["trace[1355625096] 'read index received' (duration: 125.368681ms)","trace[1355625096] 'applied index is now lower than readState.Index' (duration: 102.462µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:16:31.056127Z","caller":"traceutil/trace.go:171","msg":"trace[731861268] transaction","detail":"{read_only:false; response_revision:18571; number_of_response:1; }","duration":"157.340598ms","start":"2026-06-23T05:16:30.898755Z","end":"2026-06-23T05:16:31.056095Z","steps":["trace[731861268] 'process raft request' (duration: 157.188435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:31.056198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.636867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T05:16:31.056223Z","caller":"traceutil/trace.go:171","msg":"trace[643132557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18571; }","duration":"125.738079ms","start":"2026-06-23T05:16:30.930478Z","end":"2026-06-23T05:16:31.056216Z","steps":["trace[643132557] 'agreement among raft nodes before linearized reading' (duration: 125.655627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:16:34.640413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.940193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T05:16:34.640556Z","caller":"traceutil/trace.go:171","msg":"trace[2025225114] transaction","detail":"{read_only:false; response_revision:18639; number_of_response:1; }","duration":"172.325499ms","start":"2026-06-23T05:16:34.468201Z","end":"2026-06-23T05:16:34.640527Z","steps":["trace[2025225114] 'process raft request' (duration: 43.208673ms)","trace[2025225114] 'compare' (duration: 128.789269ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:16:34.64068Z","caller":"traceutil/trace.go:171","msg":"trace[697855805] transaction","detail":"{read_only:false; response_revision:18640; number_of_response:1; }","duration":"171.342917ms","start":"2026-06-23T05:16:34.469332Z","end":"2026-06-23T05:16:34.640675Z","steps":["trace[697855805] 'process raft request' (duration: 171.142912ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:16:34.640667Z","caller":"traceutil/trace.go:171","msg":"trace[648936207] linearizableReadLoop","detail":"{readStateIndex:19280; appliedIndex:19278; }","duration":"163.082531ms","start":"2026-06-23T05:16:34.477549Z","end":"2026-06-23T05:16:34.640631Z","steps":["trace[648936207] 'read index received' (duration: 33.873692ms)","trace[648936207] 'applied index is now lower than readState.Index' (duration: 129.206539ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:16:34.640796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.271306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-23T05:16:34.640812Z","caller":"traceutil/trace.go:171","msg":"trace[1392861526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18640; }","duration":"163.312376ms","start":"2026-06-23T05:16:34.477493Z","end":"2026-06-23T05:16:34.640806Z","steps":["trace[1392861526] 'agreement among raft nodes before linearized reading' (duration: 163.253235ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:17:21.059721Z","caller":"traceutil/trace.go:171","msg":"trace[271896112] transaction","detail":"{read_only:false; response_revision:19174; number_of_response:1; }","duration":"117.185973ms","start":"2026-06-23T05:17:20.942501Z","end":"2026-06-23T05:17:21.059687Z","steps":["trace[271896112] 'process raft request' (duration: 116.798464ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:17:41.31125Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T05:17:41.31709Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-23T05:17:41.31717Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-23T05:18:13.919823Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17256} {"level":"info","ts":"2026-06-23T05:18:14.025201Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17256,"took":"102.164323ms","hash":2225959930,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":34680832,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-23T05:18:14.02531Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2225959930,"revision":17256,"compact-revision":14619} {"level":"warn","ts":"2026-06-23T05:22:10.31316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.166984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-23T05:22:10.313223Z","caller":"traceutil/trace.go:171","msg":"trace[1496446681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21197; }","duration":"272.275456ms","start":"2026-06-23T05:22:10.040932Z","end":"2026-06-23T05:22:10.313208Z","steps":["trace[1496446681] 'range keys from in-memory index tree' (duration: 272.01252ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:10.318772Z","caller":"traceutil/trace.go:171","msg":"trace[662529219] transaction","detail":"{read_only:false; response_revision:21198; number_of_response:1; }","duration":"234.086799ms","start":"2026-06-23T05:22:10.084665Z","end":"2026-06-23T05:22:10.318752Z","steps":["trace[662529219] 'process raft request' (duration: 233.943326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:31.713987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.104829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T05:22:31.714091Z","caller":"traceutil/trace.go:171","msg":"trace[1008621947] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:21309; }","duration":"198.275552ms","start":"2026-06-23T05:22:31.515797Z","end":"2026-06-23T05:22:31.714072Z","steps":["trace[1008621947] 'count revisions from in-memory index tree' (duration: 198.023747ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:31.715337Z","caller":"traceutil/trace.go:171","msg":"trace[660219860] transaction","detail":"{read_only:false; response_revision:21310; number_of_response:1; }","duration":"155.288093ms","start":"2026-06-23T05:22:31.560025Z","end":"2026-06-23T05:22:31.715313Z","steps":["trace[660219860] 'process raft request' (duration: 151.913908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:31.974629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.976847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T05:22:31.974708Z","caller":"traceutil/trace.go:171","msg":"trace[261320823] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:21310; }","duration":"132.11457ms","start":"2026-06-23T05:22:31.842576Z","end":"2026-06-23T05:22:31.974691Z","steps":["trace[261320823] 'count revisions from in-memory index tree' (duration: 131.886255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:32.424057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.064031ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-23T05:22:32.424821Z","caller":"traceutil/trace.go:171","msg":"trace[959147506] transaction","detail":"{read_only:false; response_revision:21311; number_of_response:1; }","duration":"325.683468ms","start":"2026-06-23T05:22:32.099095Z","end":"2026-06-23T05:22:32.424779Z","steps":["trace[959147506] 'process raft request' (duration: 325.073005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:32.424997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:22:32.099071Z","time spent":"325.834241ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:22:32.512929Z","caller":"traceutil/trace.go:171","msg":"trace[310421565] transaction","detail":"{read_only:false; response_revision:21312; number_of_response:1; }","duration":"413.401477ms","start":"2026-06-23T05:22:32.099503Z","end":"2026-06-23T05:22:32.512904Z","steps":["trace[310421565] 'process raft request' (duration: 325.253919ms)","trace[310421565] 'compare' (duration: 87.705578ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:22:32.512945Z","caller":"traceutil/trace.go:171","msg":"trace[1402746555] transaction","detail":"{read_only:false; response_revision:21313; number_of_response:1; }","duration":"411.603077ms","start":"2026-06-23T05:22:32.101316Z","end":"2026-06-23T05:22:32.512919Z","steps":["trace[1402746555] 'process raft request' (duration: 411.475345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:32.513109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:22:32.101307Z","time spent":"411.71221ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T05:22:32.51359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:22:32.099489Z","time spent":"413.506669ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T05:22:32.658866Z","caller":"traceutil/trace.go:171","msg":"trace[474175849] linearizableReadLoop","detail":"{readStateIndex:22045; appliedIndex:22044; }","duration":"247.124451ms","start":"2026-06-23T05:22:32.411713Z","end":"2026-06-23T05:22:32.658838Z","steps":["trace[474175849] 'read index received' (duration: 247.021129ms)","trace[474175849] 'applied index is now lower than readState.Index' (duration: 102.322µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:22:32.658911Z","caller":"traceutil/trace.go:171","msg":"trace[1660778417] transaction","detail":"{read_only:false; response_revision:21314; number_of_response:1; }","duration":"254.718049ms","start":"2026-06-23T05:22:32.404163Z","end":"2026-06-23T05:22:32.658882Z","steps":["trace[1660778417] 'process raft request' (duration: 254.514455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:32.659121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.382808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T05:22:32.659181Z","caller":"traceutil/trace.go:171","msg":"trace[1409809196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21314; }","duration":"247.4971ms","start":"2026-06-23T05:22:32.411671Z","end":"2026-06-23T05:22:32.659168Z","steps":["trace[1409809196] 'agreement among raft nodes before linearized reading' (duration: 247.278865ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:32.674682Z","caller":"traceutil/trace.go:171","msg":"trace[1474234075] transaction","detail":"{read_only:false; response_revision:21315; number_of_response:1; }","duration":"124.316797ms","start":"2026-06-23T05:22:32.550348Z","end":"2026-06-23T05:22:32.674664Z","steps":["trace[1474234075] 'process raft request' (duration: 124.227735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:32.67483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.097229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-23T05:22:32.674893Z","caller":"traceutil/trace.go:171","msg":"trace[1295861897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21315; }","duration":"151.192422ms","start":"2026-06-23T05:22:32.523687Z","end":"2026-06-23T05:22:32.67488Z","steps":["trace[1295861897] 'agreement among raft nodes before linearized reading' (duration: 151.012898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:22:32.674937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.788229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-23T05:22:32.674977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.13795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-23T05:22:32.674977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.20455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T05:22:32.675006Z","caller":"traceutil/trace.go:171","msg":"trace[981042914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21315; }","duration":"177.949873ms","start":"2026-06-23T05:22:32.49704Z","end":"2026-06-23T05:22:32.67499Z","steps":["trace[981042914] 'agreement among raft nodes before linearized reading' (duration: 177.652917ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:32.675048Z","caller":"traceutil/trace.go:171","msg":"trace[1416293114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21315; }","duration":"155.306602ms","start":"2026-06-23T05:22:32.519724Z","end":"2026-06-23T05:22:32.675031Z","steps":["trace[1416293114] 'agreement among raft nodes before linearized reading' (duration: 155.094918ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:32.675056Z","caller":"traceutil/trace.go:171","msg":"trace[1517816412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21315; }","duration":"151.216752ms","start":"2026-06-23T05:22:32.523806Z","end":"2026-06-23T05:22:32.675023Z","steps":["trace[1517816412] 'agreement among raft nodes before linearized reading' (duration: 151.025838ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:32.861248Z","caller":"traceutil/trace.go:171","msg":"trace[564114318] transaction","detail":"{read_only:false; response_revision:21319; number_of_response:1; }","duration":"179.593699ms","start":"2026-06-23T05:22:32.681632Z","end":"2026-06-23T05:22:32.861225Z","steps":["trace[564114318] 'process raft request' (duration: 179.274932ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:32.861275Z","caller":"traceutil/trace.go:171","msg":"trace[599127818] transaction","detail":"{read_only:false; response_revision:21318; number_of_response:1; }","duration":"179.799394ms","start":"2026-06-23T05:22:32.681449Z","end":"2026-06-23T05:22:32.861249Z","steps":["trace[599127818] 'process raft request' (duration: 179.310553ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:22:32.861349Z","caller":"traceutil/trace.go:171","msg":"trace[1228849988] transaction","detail":"{read_only:false; response_revision:21320; number_of_response:1; }","duration":"179.579449ms","start":"2026-06-23T05:22:32.681724Z","end":"2026-06-23T05:22:32.861304Z","steps":["trace[1228849988] 'process raft request' (duration: 179.226071ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:23:13.926304Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19579} {"level":"info","ts":"2026-06-23T05:23:14.039817Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19579,"took":"109.915086ms","hash":4276555648,"current-db-size-bytes":58597376,"current-db-size":"59 MB","current-db-size-in-use-bytes":29220864,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-23T05:23:14.039891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4276555648,"revision":19579,"compact-revision":17256}