{"level":"warn","ts":"2026-06-30T17:53:20.080004Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T17:53:20.08013Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-30T17:53:20.08022Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T17:53:20.080242Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-30T17:53:20.080266Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T17:53:20.081154Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-30T17:53:20.081249Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-30T17:53:20.085222Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.698325ms"} {"level":"info","ts":"2026-06-30T17:53:20.091415Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-30T17:53:20.091497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T17:53:20.091515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-30T17:53:20.091529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T17:53:20.091539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-30T17:53:20.091581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-30T17:53:20.098575Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T17:53:20.099887Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T17:53:20.101159Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-30T17:53:20.10324Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T17:53:20.103366Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T17:53:20.103524Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T17:53:20.103675Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T17:53:20.103896Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T17:53:20.10471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-30T17:53:20.105296Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-30T17:53:20.108775Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T17:53:20.108913Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-30T17:53:20.108948Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-30T17:53:20.109282Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T17:53:20.109354Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T17:53:21.09184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T17:53:21.091908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T17:53:21.091962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-30T17:53:21.091982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-30T17:53:21.091993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-30T17:53:21.092009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-30T17:53:21.092024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-30T17:53:21.09331Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:21.094022Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T17:53:21.094234Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:53:21.094319Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:53:21.094528Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:21.094367Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T17:53:21.094592Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T17:53:21.094701Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:21.094754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:53:21.098184Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T17:53:21.098457Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"warn","ts":"2026-06-30T17:53:21.406983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.773038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.407096Z","caller":"traceutil/trace.go:171","msg":"trace[1033213824] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"137.968514ms","start":"2026-06-30T17:53:21.269109Z","end":"2026-06-30T17:53:21.407077Z","steps":["trace[1033213824] 'count revisions from in-memory index tree' (duration: 137.720677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.407113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.136192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.407213Z","caller":"traceutil/trace.go:171","msg":"trace[364598438] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"108.270335ms","start":"2026-06-30T17:53:21.298924Z","end":"2026-06-30T17:53:21.407194Z","steps":["trace[364598438] 'count revisions from in-memory index tree' (duration: 108.114332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.407087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.624272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.407409Z","caller":"traceutil/trace.go:171","msg":"trace[204718813] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"123.995853ms","start":"2026-06-30T17:53:21.283372Z","end":"2026-06-30T17:53:21.407368Z","steps":["trace[204718813] 'range keys from in-memory index tree' (duration: 123.473099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.407482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.557344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.407561Z","caller":"traceutil/trace.go:171","msg":"trace[1418355256] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"108.658646ms","start":"2026-06-30T17:53:21.298886Z","end":"2026-06-30T17:53:21.407545Z","steps":["trace[1418355256] 'range keys from in-memory index tree' (duration: 108.467951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.407555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.058874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.407696Z","caller":"traceutil/trace.go:171","msg":"trace[300045679] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"124.214367ms","start":"2026-06-30T17:53:21.28347Z","end":"2026-06-30T17:53:21.407684Z","steps":["trace[300045679] 'count revisions from in-memory index tree' (duration: 124.019173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.408143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.008158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.408206Z","caller":"traceutil/trace.go:171","msg":"trace[1755517693] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"262.06015ms","start":"2026-06-30T17:53:21.146121Z","end":"2026-06-30T17:53:21.408181Z","steps":["trace[1755517693] 'count revisions from in-memory index tree' (duration: 261.925585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.408353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.108759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.408389Z","caller":"traceutil/trace.go:171","msg":"trace[486477850] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"262.178081ms","start":"2026-06-30T17:53:21.146202Z","end":"2026-06-30T17:53:21.40838Z","steps":["trace[486477850] 'range keys from in-memory index tree' (duration: 262.039477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.408458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.111383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.408523Z","caller":"traceutil/trace.go:171","msg":"trace[1758634140] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"223.207726ms","start":"2026-06-30T17:53:21.185301Z","end":"2026-06-30T17:53:21.408508Z","steps":["trace[1758634140] 'count revisions from in-memory index tree' (duration: 223.016899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.408624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.355661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.408748Z","caller":"traceutil/trace.go:171","msg":"trace[2130700287] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"208.511066ms","start":"2026-06-30T17:53:21.200225Z","end":"2026-06-30T17:53:21.408736Z","steps":["trace[2130700287] 'range keys from in-memory index tree' (duration: 208.270539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.408775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.508755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.408818Z","caller":"traceutil/trace.go:171","msg":"trace[635549961] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"208.583668ms","start":"2026-06-30T17:53:21.200223Z","end":"2026-06-30T17:53:21.408807Z","steps":["trace[635549961] 'count revisions from in-memory index tree' (duration: 208.391553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.408929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.7481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.408967Z","caller":"traceutil/trace.go:171","msg":"trace[1638051205] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"194.800992ms","start":"2026-06-30T17:53:21.214157Z","end":"2026-06-30T17:53:21.408958Z","steps":["trace[1638051205] 'count revisions from in-memory index tree' (duration: 194.694838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.409151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.924684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.409183Z","caller":"traceutil/trace.go:171","msg":"trace[113832263] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"194.985636ms","start":"2026-06-30T17:53:21.214189Z","end":"2026-06-30T17:53:21.409175Z","steps":["trace[113832263] 'range keys from in-memory index tree' (duration: 194.870613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.409446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.396742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-30T17:53:21.409467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.296169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.409511Z","caller":"traceutil/trace.go:171","msg":"trace[27207370] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"182.481344ms","start":"2026-06-30T17:53:21.227018Z","end":"2026-06-30T17:53:21.4095Z","steps":["trace[27207370] 'range keys from in-memory index tree' (duration: 182.343781ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:53:21.409527Z","caller":"traceutil/trace.go:171","msg":"trace[1794436441] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"182.397362ms","start":"2026-06-30T17:53:21.227114Z","end":"2026-06-30T17:53:21.409512Z","steps":["trace[1794436441] 'count revisions from in-memory index tree' (duration: 182.222528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.409566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.382765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.409651Z","caller":"traceutil/trace.go:171","msg":"trace[940421385] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"169.528909ms","start":"2026-06-30T17:53:21.240101Z","end":"2026-06-30T17:53:21.40963Z","steps":["trace[940421385] 'range keys from in-memory index tree' (duration: 169.308954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.409832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.367534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.409899Z","caller":"traceutil/trace.go:171","msg":"trace[713742992] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"169.455747ms","start":"2026-06-30T17:53:21.240427Z","end":"2026-06-30T17:53:21.409883Z","steps":["trace[713742992] 'count revisions from in-memory index tree' (duration: 169.312813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.409918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.970867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.409993Z","caller":"traceutil/trace.go:171","msg":"trace[1560240283] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"154.10761ms","start":"2026-06-30T17:53:21.255867Z","end":"2026-06-30T17:53:21.409975Z","steps":["trace[1560240283] 'range keys from in-memory index tree' (duration: 153.855924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.409998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.994968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.410031Z","caller":"traceutil/trace.go:171","msg":"trace[1399606744] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"154.071329ms","start":"2026-06-30T17:53:21.255952Z","end":"2026-06-30T17:53:21.410024Z","steps":["trace[1399606744] 'count revisions from in-memory index tree' (duration: 153.822182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:53:21.410091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.990892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-30T17:53:21.410118Z","caller":"traceutil/trace.go:171","msg":"trace[1266296502] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"141.035713ms","start":"2026-06-30T17:53:21.269071Z","end":"2026-06-30T17:53:21.410107Z","steps":["trace[1266296502] 'range keys from in-memory index tree' (duration: 140.929871ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.06185Z","caller":"traceutil/trace.go:171","msg":"trace[1812641645] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"249.046447ms","start":"2026-06-30T17:54:00.81278Z","end":"2026-06-30T17:54:01.061826Z","steps":["trace[1812641645] 'read index received' (duration: 248.981805ms)","trace[1812641645] 'applied index is now lower than readState.Index' (duration: 63.662µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:54:01.061887Z","caller":"traceutil/trace.go:171","msg":"trace[514660612] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"275.20289ms","start":"2026-06-30T17:54:00.786664Z","end":"2026-06-30T17:54:01.061867Z","steps":["trace[514660612] 'process raft request' (duration: 274.999795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:01.061981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.188961ms","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-30T17:54:01.062213Z","caller":"traceutil/trace.go:171","msg":"trace[630142784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"249.437277ms","start":"2026-06-30T17:54:00.812736Z","end":"2026-06-30T17:54:01.062173Z","steps":["trace[630142784] 'agreement among raft nodes before linearized reading' (duration: 249.18677ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074188Z","caller":"traceutil/trace.go:171","msg":"trace[7001086] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"236.093993ms","start":"2026-06-30T17:54:00.838073Z","end":"2026-06-30T17:54:01.074167Z","steps":["trace[7001086] 'process raft request' (duration: 235.797255ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074265Z","caller":"traceutil/trace.go:171","msg":"trace[2126961663] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"232.734197ms","start":"2026-06-30T17:54:00.841501Z","end":"2026-06-30T17:54:01.074235Z","steps":["trace[2126961663] 'process raft request' (duration: 232.559883ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074302Z","caller":"traceutil/trace.go:171","msg":"trace[1299856248] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"232.07213ms","start":"2026-06-30T17:54:00.842209Z","end":"2026-06-30T17:54:01.074281Z","steps":["trace[1299856248] 'process raft request' (duration: 231.903916ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074357Z","caller":"traceutil/trace.go:171","msg":"trace[1082110783] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"222.403411ms","start":"2026-06-30T17:54:00.851936Z","end":"2026-06-30T17:54:01.074339Z","steps":["trace[1082110783] 'process raft request' (duration: 222.219137ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074451Z","caller":"traceutil/trace.go:171","msg":"trace[1197035792] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"221.216301ms","start":"2026-06-30T17:54:00.853224Z","end":"2026-06-30T17:54:01.074441Z","steps":["trace[1197035792] 'process raft request' (duration: 221.097918ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074438Z","caller":"traceutil/trace.go:171","msg":"trace[562952176] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"221.706894ms","start":"2026-06-30T17:54:00.852682Z","end":"2026-06-30T17:54:01.074389Z","steps":["trace[562952176] 'process raft request' (duration: 221.520119ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074572Z","caller":"traceutil/trace.go:171","msg":"trace[1149053915] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"220.925413ms","start":"2026-06-30T17:54:00.853628Z","end":"2026-06-30T17:54:01.074553Z","steps":["trace[1149053915] 'process raft request' (duration: 220.756719ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074783Z","caller":"traceutil/trace.go:171","msg":"trace[1779128051] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"215.198087ms","start":"2026-06-30T17:54:00.85957Z","end":"2026-06-30T17:54:01.074768Z","steps":["trace[1779128051] 'process raft request' (duration: 215.024622ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074932Z","caller":"traceutil/trace.go:171","msg":"trace[187612535] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"208.706989ms","start":"2026-06-30T17:54:00.86616Z","end":"2026-06-30T17:54:01.074867Z","steps":["trace[187612535] 'process raft request' (duration: 208.508944ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.074999Z","caller":"traceutil/trace.go:171","msg":"trace[1413845255] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"207.340704ms","start":"2026-06-30T17:54:00.867642Z","end":"2026-06-30T17:54:01.074982Z","steps":["trace[1413845255] 'process raft request' (duration: 207.103658ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:01.075102Z","caller":"traceutil/trace.go:171","msg":"trace[1726497454] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"186.924429ms","start":"2026-06-30T17:54:00.888168Z","end":"2026-06-30T17:54:01.075092Z","steps":["trace[1726497454] 'process raft request' (duration: 186.743994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:01.075271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.144001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:54:01.075311Z","caller":"traceutil/trace.go:171","msg":"trace[1610656003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:503; }","duration":"183.230043ms","start":"2026-06-30T17:54:00.89207Z","end":"2026-06-30T17:54:01.0753Z","steps":["trace[1610656003] 'agreement among raft nodes before linearized reading' (duration: 183.11187ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:06.934266Z","caller":"traceutil/trace.go:171","msg":"trace[2069814160] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"200.457896ms","start":"2026-06-30T17:54:06.733776Z","end":"2026-06-30T17:54:06.934234Z","steps":["trace[2069814160] 'process raft request' (duration: 200.290382ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:07.065858Z","caller":"traceutil/trace.go:171","msg":"trace[907559452] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"324.719554ms","start":"2026-06-30T17:54:06.741112Z","end":"2026-06-30T17:54:07.065832Z","steps":["trace[907559452] 'process raft request' (duration: 323.441091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:07.066768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:06.741088Z","time spent":"324.854597ms","remote":"127.0.0.1:44238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:54:07.380503Z","caller":"traceutil/trace.go:171","msg":"trace[1299514321] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"256.449328ms","start":"2026-06-30T17:54:07.124028Z","end":"2026-06-30T17:54:07.380478Z","steps":["trace[1299514321] 'process raft request' (duration: 256.378036ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:07.380531Z","caller":"traceutil/trace.go:171","msg":"trace[1622080255] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"256.52095ms","start":"2026-06-30T17:54:07.123973Z","end":"2026-06-30T17:54:07.380494Z","steps":["trace[1622080255] 'process raft request' (duration: 256.292564ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:07.380692Z","caller":"traceutil/trace.go:171","msg":"trace[1767628775] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"256.444767ms","start":"2026-06-30T17:54:07.124238Z","end":"2026-06-30T17:54:07.380683Z","steps":["trace[1767628775] 'process raft request' (duration: 256.207251ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:07.380751Z","caller":"traceutil/trace.go:171","msg":"trace[949133940] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:624; }","duration":"246.566173ms","start":"2026-06-30T17:54:07.134114Z","end":"2026-06-30T17:54:07.380681Z","steps":["trace[949133940] 'read index received' (duration: 246.061839ms)","trace[949133940] 'applied index is now lower than readState.Index' (duration: 502.394µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:07.380907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.767857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:54:07.381028Z","caller":"traceutil/trace.go:171","msg":"trace[173551758] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:602; }","duration":"246.918761ms","start":"2026-06-30T17:54:07.134078Z","end":"2026-06-30T17:54:07.380997Z","steps":["trace[173551758] 'agreement among raft nodes before linearized reading' (duration: 246.736987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:08.301946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.225644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:54:08.302012Z","caller":"traceutil/trace.go:171","msg":"trace[1614806969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"632.327837ms","start":"2026-06-30T17:54:07.66967Z","end":"2026-06-30T17:54:08.301998Z","steps":["trace[1614806969] 'range keys from in-memory index tree' (duration: 632.162343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:08.30204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:07.669655Z","time spent":"632.379308ms","remote":"127.0.0.1:44130","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-30T17:54:08.302419Z","caller":"traceutil/trace.go:171","msg":"trace[689773840] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"112.755542ms","start":"2026-06-30T17:54:08.189647Z","end":"2026-06-30T17:54:08.302403Z","steps":["trace[689773840] 'read index received' (duration: 110.167115ms)","trace[689773840] 'applied index is now lower than readState.Index' (duration: 2.587377ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:08.302535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.879585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:54:08.302578Z","caller":"traceutil/trace.go:171","msg":"trace[763538626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"112.962297ms","start":"2026-06-30T17:54:08.189603Z","end":"2026-06-30T17:54:08.302566Z","steps":["trace[763538626] 'agreement among raft nodes before linearized reading' (duration: 112.865974ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:08.302669Z","caller":"traceutil/trace.go:171","msg":"trace[298922535] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"531.690859ms","start":"2026-06-30T17:54:07.770954Z","end":"2026-06-30T17:54:08.302645Z","steps":["trace[298922535] 'process raft request' (duration: 529.095562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:08.302796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:07.770926Z","time spent":"531.800041ms","remote":"127.0.0.1:44238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:54:23.935427Z","caller":"traceutil/trace.go:171","msg":"trace[1385324546] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"248.069261ms","start":"2026-06-30T17:54:23.68733Z","end":"2026-06-30T17:54:23.935399Z","steps":["trace[1385324546] 'process raft request' (duration: 247.918507ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:24.115845Z","caller":"traceutil/trace.go:171","msg":"trace[1774362748] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"110.452091ms","start":"2026-06-30T17:54:24.005362Z","end":"2026-06-30T17:54:24.115815Z","steps":["trace[1774362748] 'process raft request' (duration: 110.104373ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:38.390042Z","caller":"traceutil/trace.go:171","msg":"trace[605122792] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"526.946305ms","start":"2026-06-30T17:55:37.863046Z","end":"2026-06-30T17:55:38.389993Z","steps":["trace[605122792] 'process raft request' (duration: 526.662637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.390323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:37.863026Z","time spent":"527.153219ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:38.475556Z","caller":"traceutil/trace.go:171","msg":"trace[596169457] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"611.677673ms","start":"2026-06-30T17:55:37.86385Z","end":"2026-06-30T17:55:38.475528Z","steps":["trace[596169457] 'process raft request' (duration: 549.859409ms)","trace[596169457] 'compare' (duration: 61.630669ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:38.475747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:37.863834Z","time spent":"611.813046ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:38.475914Z","caller":"traceutil/trace.go:171","msg":"trace[1071455636] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"611.893338ms","start":"2026-06-30T17:55:37.86398Z","end":"2026-06-30T17:55:38.475873Z","steps":["trace[1071455636] 'process raft request' (duration: 611.499859ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:38.47594Z","caller":"traceutil/trace.go:171","msg":"trace[71017294] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1901; }","duration":"115.203488ms","start":"2026-06-30T17:55:38.360718Z","end":"2026-06-30T17:55:38.475922Z","steps":["trace[71017294] 'read index received' (duration: 29.010072ms)","trace[71017294] 'applied index is now lower than readState.Index' (duration: 86.192186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:38.476076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:37.863955Z","time spent":"612.041992ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:38.476076Z","caller":"traceutil/trace.go:171","msg":"trace[1806041011] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"583.440901ms","start":"2026-06-30T17:55:37.892611Z","end":"2026-06-30T17:55:38.476052Z","steps":["trace[1806041011] 'process raft request' (duration: 583.223554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.476198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:37.892573Z","time spent":"583.558744ms","remote":"127.0.0.1:44414","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-30T17:55:38.476342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.62539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:55:38.476467Z","caller":"traceutil/trace.go:171","msg":"trace[1066460114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1833; }","duration":"115.799414ms","start":"2026-06-30T17:55:38.360648Z","end":"2026-06-30T17:55:38.476447Z","steps":["trace[1066460114] 'agreement among raft nodes before linearized reading' (duration: 115.379024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.93712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.025006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:38.937393Z","caller":"traceutil/trace.go:171","msg":"trace[1048531070] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1906; }","duration":"427.907845ms","start":"2026-06-30T17:55:38.509465Z","end":"2026-06-30T17:55:38.937373Z","steps":["trace[1048531070] 'read index received' (duration: 169.188211ms)","trace[1048531070] 'applied index is now lower than readState.Index' (duration: 258.718534ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:38.937482Z","caller":"traceutil/trace.go:171","msg":"trace[417043714] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"459.464773ms","start":"2026-06-30T17:55:38.478005Z","end":"2026-06-30T17:55:38.93747Z","steps":["trace[417043714] 'process raft request' (duration: 200.703918ms)","trace[417043714] 'compare' (duration: 257.850121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:38.937618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:38.477986Z","time spent":"459.529335ms","remote":"127.0.0.1:44414","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-30T17:55:38.937618Z","caller":"traceutil/trace.go:171","msg":"trace[1256324072] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"456.65802ms","start":"2026-06-30T17:55:38.480918Z","end":"2026-06-30T17:55:38.937576Z","steps":["trace[1256324072] 'process raft request' (duration: 456.355771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.937988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:38.480908Z","time spent":"456.982168ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:55:38.938032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.558232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a693707-2bee-45de-8c19-b0591cbff00c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-30T17:55:38.938104Z","caller":"traceutil/trace.go:171","msg":"trace[669362626] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a693707-2bee-45de-8c19-b0591cbff00c; range_end:; response_count:1; response_revision:1836; }","duration":"428.683954ms","start":"2026-06-30T17:55:38.509403Z","end":"2026-06-30T17:55:38.938087Z","steps":["trace[669362626] 'agreement among raft nodes before linearized reading' (duration: 428.263953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.938142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:38.509376Z","time spent":"428.756747ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a693707-2bee-45de-8c19-b0591cbff00c\" "} {"level":"warn","ts":"2026-06-30T17:55:38.945323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.478239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-30T17:55:38.945315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.076043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-30T17:55:38.94533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.66783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a693707-2bee-45de-8c19-b0591cbff00c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-30T17:55:38.94536Z","caller":"traceutil/trace.go:171","msg":"trace[1410599925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1837; }","duration":"171.549761ms","start":"2026-06-30T17:55:38.773802Z","end":"2026-06-30T17:55:38.945351Z","steps":["trace[1410599925] 'agreement among raft nodes before linearized reading' (duration: 171.434509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.945373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.241237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:38.945373Z","caller":"traceutil/trace.go:171","msg":"trace[579305704] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"380.143835ms","start":"2026-06-30T17:55:38.565216Z","end":"2026-06-30T17:55:38.94536Z","steps":["trace[579305704] 'agreement among raft nodes before linearized reading' (duration: 379.96484ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:38.945384Z","caller":"traceutil/trace.go:171","msg":"trace[2116987033] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a693707-2bee-45de-8c19-b0591cbff00c; range_end:; response_count:1; response_revision:1837; }","duration":"135.745053ms","start":"2026-06-30T17:55:38.809624Z","end":"2026-06-30T17:55:38.94537Z","steps":["trace[2116987033] 'agreement among raft nodes before linearized reading' (duration: 135.587739ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:38.945409Z","caller":"traceutil/trace.go:171","msg":"trace[797167227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1837; }","duration":"274.306338ms","start":"2026-06-30T17:55:38.671094Z","end":"2026-06-30T17:55:38.945401Z","steps":["trace[797167227] 'agreement among raft nodes before linearized reading' (duration: 274.232476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:38.945416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:38.565149Z","time spent":"380.258927ms","remote":"127.0.0.1:37182","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":"info","ts":"2026-06-30T17:55:55.187693Z","caller":"traceutil/trace.go:171","msg":"trace[1099498487] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"194.744923ms","start":"2026-06-30T17:55:54.992921Z","end":"2026-06-30T17:55:55.187666Z","steps":["trace[1099498487] 'process raft request' (duration: 194.62433ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:55.187733Z","caller":"traceutil/trace.go:171","msg":"trace[118649556] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2047; }","duration":"184.930609ms","start":"2026-06-30T17:55:55.002748Z","end":"2026-06-30T17:55:55.187679Z","steps":["trace[118649556] 'read index received' (duration: 184.914648ms)","trace[118649556] 'applied index is now lower than readState.Index' (duration: 13.331µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:55.188038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.260297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T17:55:55.188158Z","caller":"traceutil/trace.go:171","msg":"trace[2112479476] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1970; }","duration":"185.489914ms","start":"2026-06-30T17:55:55.002642Z","end":"2026-06-30T17:55:55.188132Z","steps":["trace[2112479476] 'agreement among raft nodes before linearized reading' (duration: 185.189055ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:55.352712Z","caller":"traceutil/trace.go:171","msg":"trace[759927287] linearizableReadLoop","detail":"{readStateIndex:2048; appliedIndex:2047; }","duration":"164.856809ms","start":"2026-06-30T17:55:55.187829Z","end":"2026-06-30T17:55:55.352685Z","steps":["trace[759927287] 'read index received' (duration: 164.634803ms)","trace[759927287] 'applied index is now lower than readState.Index' (duration: 220.626µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:55.352845Z","caller":"traceutil/trace.go:171","msg":"trace[1764850776] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"210.03235ms","start":"2026-06-30T17:55:55.142775Z","end":"2026-06-30T17:55:55.352807Z","steps":["trace[1764850776] 'process raft request' (duration: 209.717412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:55.352968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.040905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:55:55.353069Z","caller":"traceutil/trace.go:171","msg":"trace[1636165374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1971; }","duration":"342.175109ms","start":"2026-06-30T17:55:55.010884Z","end":"2026-06-30T17:55:55.353059Z","steps":["trace[1636165374] 'agreement among raft nodes before linearized reading' (duration: 341.917313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:55.353109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:55.010876Z","time spent":"342.22461ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:55:55.353432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.849182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-30T17:55:55.353485Z","caller":"traceutil/trace.go:171","msg":"trace[1566398405] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1971; }","duration":"301.982906ms","start":"2026-06-30T17:55:55.051486Z","end":"2026-06-30T17:55:55.353469Z","steps":["trace[1566398405] 'agreement among raft nodes before linearized reading' (duration: 301.777351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:55.353514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:55.051457Z","time spent":"302.049638ms","remote":"127.0.0.1:37182","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":"info","ts":"2026-06-30T17:55:55.354816Z","caller":"traceutil/trace.go:171","msg":"trace[305156221] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"161.360708ms","start":"2026-06-30T17:55:55.193398Z","end":"2026-06-30T17:55:55.354759Z","steps":["trace[305156221] 'process raft request' (duration: 161.178093ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:34.86189Z","caller":"traceutil/trace.go:171","msg":"trace[1087006071] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"190.370625ms","start":"2026-06-30T17:56:34.671497Z","end":"2026-06-30T17:56:34.861868Z","steps":["trace[1087006071] 'process raft request' (duration: 190.249052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:35.205174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.530093ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:56:35.205345Z","caller":"traceutil/trace.go:171","msg":"trace[1792841046] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2271; }","duration":"462.258303ms","start":"2026-06-30T17:56:34.743068Z","end":"2026-06-30T17:56:35.205327Z","steps":["trace[1792841046] 'read index received' (duration: 118.785582ms)","trace[1792841046] 'applied index is now lower than readState.Index' (duration: 343.471821ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:35.205424Z","caller":"traceutil/trace.go:171","msg":"trace[1198561382] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"531.715121ms","start":"2026-06-30T17:56:34.673698Z","end":"2026-06-30T17:56:35.205413Z","steps":["trace[1198561382] 'process raft request' (duration: 531.572627ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:35.205426Z","caller":"traceutil/trace.go:171","msg":"trace[25780797] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"531.754112ms","start":"2026-06-30T17:56:34.673613Z","end":"2026-06-30T17:56:35.205367Z","steps":["trace[25780797] 'process raft request' (duration: 366.940162ms)","trace[25780797] 'compare' (duration: 164.411779ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:56:35.205487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:56:34.673682Z","time spent":"531.772973ms","remote":"127.0.0.1:44414","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-30T17:56:35.205635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:56:34.673602Z","time spent":"531.924617ms","remote":"127.0.0.1:44414","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-30T17:56:35.205874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.785187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-30T17:56:35.20596Z","caller":"traceutil/trace.go:171","msg":"trace[443371737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2187; }","duration":"462.905989ms","start":"2026-06-30T17:56:34.743035Z","end":"2026-06-30T17:56:35.205941Z","steps":["trace[443371737] 'agreement among raft nodes before linearized reading' (duration: 462.644493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:35.205953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.414972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-30T17:56:35.206002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:56:34.743022Z","time spent":"462.970943ms","remote":"127.0.0.1:44414","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-30T17:56:35.206064Z","caller":"traceutil/trace.go:171","msg":"trace[1048098341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2187; }","duration":"443.575807ms","start":"2026-06-30T17:56:34.76246Z","end":"2026-06-30T17:56:35.206036Z","steps":["trace[1048098341] 'agreement among raft nodes before linearized reading' (duration: 443.134955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:35.206116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:56:34.762437Z","time spent":"443.669189ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T17:56:35.414849Z","caller":"traceutil/trace.go:171","msg":"trace[1253503433] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"204.197385ms","start":"2026-06-30T17:56:35.210622Z","end":"2026-06-30T17:56:35.414819Z","steps":["trace[1253503433] 'process raft request' (duration: 125.201069ms)","trace[1253503433] 'compare' (duration: 78.812102ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:35.415016Z","caller":"traceutil/trace.go:171","msg":"trace[1697112456] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"204.315518ms","start":"2026-06-30T17:56:35.21067Z","end":"2026-06-30T17:56:35.414985Z","steps":["trace[1697112456] 'process raft request' (duration: 204.105743ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:35.608122Z","caller":"traceutil/trace.go:171","msg":"trace[1254674743] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"110.853765ms","start":"2026-06-30T17:56:35.497234Z","end":"2026-06-30T17:56:35.608088Z","steps":["trace[1254674743] 'process raft request' (duration: 110.717672ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:35.608187Z","caller":"traceutil/trace.go:171","msg":"trace[1837011398] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"264.091364ms","start":"2026-06-30T17:56:35.344056Z","end":"2026-06-30T17:56:35.608147Z","steps":["trace[1837011398] 'process raft request' (duration: 234.71403ms)","trace[1837011398] 'compare' (duration: 29.024815ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:05.297717Z","caller":"traceutil/trace.go:171","msg":"trace[1033986726] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"160.009931ms","start":"2026-06-30T17:57:05.137677Z","end":"2026-06-30T17:57:05.297687Z","steps":["trace[1033986726] 'process raft request' (duration: 159.364394ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:05.303788Z","caller":"traceutil/trace.go:171","msg":"trace[1242146706] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"165.009181ms","start":"2026-06-30T17:57:05.138743Z","end":"2026-06-30T17:57:05.303752Z","steps":["trace[1242146706] 'process raft request' (duration: 164.695813ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:05.303812Z","caller":"traceutil/trace.go:171","msg":"trace[1921717288] linearizableReadLoop","detail":"{readStateIndex:2618; appliedIndex:2614; }","duration":"158.007368ms","start":"2026-06-30T17:57:05.145772Z","end":"2026-06-30T17:57:05.303779Z","steps":["trace[1921717288] 'read index received' (duration: 151.17916ms)","trace[1921717288] 'applied index is now lower than readState.Index' (duration: 6.826838ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:57:05.303981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.196103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7398"} {"level":"info","ts":"2026-06-30T17:57:05.304018Z","caller":"traceutil/trace.go:171","msg":"trace[1390602010] transaction","detail":"{read_only:false; response_revision:2518; number_of_response:1; }","duration":"161.800237ms","start":"2026-06-30T17:57:05.142205Z","end":"2026-06-30T17:57:05.304006Z","steps":["trace[1390602010] 'process raft request' (duration: 161.505278ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:05.304017Z","caller":"traceutil/trace.go:171","msg":"trace[2119110532] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2518; }","duration":"158.285786ms","start":"2026-06-30T17:57:05.145717Z","end":"2026-06-30T17:57:05.304003Z","steps":["trace[2119110532] 'agreement among raft nodes before linearized reading' (duration: 158.181173ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:05.304111Z","caller":"traceutil/trace.go:171","msg":"trace[16436936] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"165.107314ms","start":"2026-06-30T17:57:05.138995Z","end":"2026-06-30T17:57:05.304102Z","steps":["trace[16436936] 'process raft request' (duration: 164.621971ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:43.228102Z","caller":"traceutil/trace.go:171","msg":"trace[139693856] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"123.035445ms","start":"2026-06-30T17:57:43.105028Z","end":"2026-06-30T17:57:43.228064Z","steps":["trace[139693856] 'process raft request' (duration: 122.880461ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:00:08.593593Z","caller":"traceutil/trace.go:171","msg":"trace[887256509] transaction","detail":"{read_only:false; response_revision:3722; number_of_response:1; }","duration":"112.122176ms","start":"2026-06-30T18:00:08.481441Z","end":"2026-06-30T18:00:08.593563Z","steps":["trace[887256509] 'process raft request' (duration: 111.934361ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:00:08.633434Z","caller":"traceutil/trace.go:171","msg":"trace[973289912] transaction","detail":"{read_only:false; response_revision:3723; number_of_response:1; }","duration":"150.657906ms","start":"2026-06-30T18:00:08.482752Z","end":"2026-06-30T18:00:08.63341Z","steps":["trace[973289912] 'process raft request' (duration: 150.370398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:19.305475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.51439ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-06-30T18:01:31.773996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.605267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:22 size:526831"} {"level":"info","ts":"2026-06-30T18:01:31.774082Z","caller":"traceutil/trace.go:171","msg":"trace[1082627215] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:22; response_revision:4754; }","duration":"113.74922ms","start":"2026-06-30T18:01:31.660316Z","end":"2026-06-30T18:01:31.774065Z","steps":["trace[1082627215] 'range keys from in-memory index tree' (duration: 113.236886ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.19269Z","caller":"traceutil/trace.go:171","msg":"trace[999956650] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"173.394594ms","start":"2026-06-30T18:01:32.019266Z","end":"2026-06-30T18:01:32.192661Z","steps":["trace[999956650] 'process raft request' (duration: 173.23391ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.196204Z","caller":"traceutil/trace.go:171","msg":"trace[993322764] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"176.211397ms","start":"2026-06-30T18:01:32.019963Z","end":"2026-06-30T18:01:32.196175Z","steps":["trace[993322764] 'process raft request' (duration: 176.111394ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.196245Z","caller":"traceutil/trace.go:171","msg":"trace[1045118026] linearizableReadLoop","detail":"{readStateIndex:4948; appliedIndex:4944; }","duration":"176.111985ms","start":"2026-06-30T18:01:32.02012Z","end":"2026-06-30T18:01:32.196232Z","steps":["trace[1045118026] 'read index received' (duration: 171.808633ms)","trace[1045118026] 'applied index is now lower than readState.Index' (duration: 4.302632ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:01:32.196305Z","caller":"traceutil/trace.go:171","msg":"trace[1926932343] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"176.33212ms","start":"2026-06-30T18:01:32.019963Z","end":"2026-06-30T18:01:32.196296Z","steps":["trace[1926932343] 'process raft request' (duration: 176.133665ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.1964Z","caller":"traceutil/trace.go:171","msg":"trace[86633570] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"166.775039ms","start":"2026-06-30T18:01:32.029616Z","end":"2026-06-30T18:01:32.196391Z","steps":["trace[86633570] 'process raft request' (duration: 166.585735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:32.196517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.377492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:01:32.19656Z","caller":"traceutil/trace.go:171","msg":"trace[1429550916] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:4767; }","duration":"176.455633ms","start":"2026-06-30T18:01:32.020092Z","end":"2026-06-30T18:01:32.196548Z","steps":["trace[1429550916] 'agreement among raft nodes before linearized reading' (duration: 176.379641ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.196601Z","caller":"traceutil/trace.go:171","msg":"trace[1180492164] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"175.55593ms","start":"2026-06-30T18:01:32.021032Z","end":"2026-06-30T18:01:32.196588Z","steps":["trace[1180492164] 'process raft request' (duration: 175.090038ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.196516Z","caller":"traceutil/trace.go:171","msg":"trace[2071783188] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"176.550386ms","start":"2026-06-30T18:01:32.019939Z","end":"2026-06-30T18:01:32.196489Z","steps":["trace[2071783188] 'process raft request' (duration: 176.056223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:32.196648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.000362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-06-30T18:01:32.196718Z","caller":"traceutil/trace.go:171","msg":"trace[1798739779] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4767; }","duration":"176.110805ms","start":"2026-06-30T18:01:32.020589Z","end":"2026-06-30T18:01:32.1967Z","steps":["trace[1798739779] 'agreement among raft nodes before linearized reading' (duration: 175.891088ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.196737Z","caller":"traceutil/trace.go:171","msg":"trace[1857760095] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"175.695644ms","start":"2026-06-30T18:01:32.021032Z","end":"2026-06-30T18:01:32.196728Z","steps":["trace[1857760095] 'process raft request' (duration: 175.106668ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:32.196837Z","caller":"traceutil/trace.go:171","msg":"trace[1465355704] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"172.635424ms","start":"2026-06-30T18:01:32.024192Z","end":"2026-06-30T18:01:32.196827Z","steps":["trace[1465355704] 'process raft request' (duration: 171.968027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:36.080725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.465764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:01:36.080818Z","caller":"traceutil/trace.go:171","msg":"trace[1464009981] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4910; }","duration":"184.602268ms","start":"2026-06-30T18:01:35.896195Z","end":"2026-06-30T18:01:36.080798Z","steps":["trace[1464009981] 'range keys from in-memory index tree' (duration: 184.405272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:36.080704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.617536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29213829-14eb-497b-b879-d894e14f72ea\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-06-30T18:01:36.080901Z","caller":"traceutil/trace.go:171","msg":"trace[704777452] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29213829-14eb-497b-b879-d894e14f72ea; range_end:; response_count:1; response_revision:4910; }","duration":"121.878303ms","start":"2026-06-30T18:01:35.959003Z","end":"2026-06-30T18:01:36.080881Z","steps":["trace[704777452] 'range keys from in-memory index tree' (duration: 121.419711ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:36.263038Z","caller":"traceutil/trace.go:171","msg":"trace[1658292871] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4910; }","duration":"156.294645ms","start":"2026-06-30T18:01:36.106722Z","end":"2026-06-30T18:01:36.263017Z","steps":["trace[1658292871] 'process raft request' (duration: 156.211923ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:36.340645Z","caller":"traceutil/trace.go:171","msg":"trace[2129243804] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"132.377618ms","start":"2026-06-30T18:01:36.208199Z","end":"2026-06-30T18:01:36.340577Z","steps":["trace[2129243804] 'process raft request' (duration: 132.047129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:38.973554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.573561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T18:01:38.974032Z","caller":"traceutil/trace.go:171","msg":"trace[1727529674] linearizableReadLoop","detail":"{readStateIndex:5171; appliedIndex:5169; }","duration":"318.039693ms","start":"2026-06-30T18:01:38.655974Z","end":"2026-06-30T18:01:38.974013Z","steps":["trace[1727529674] 'read index received' (duration: 115.919058ms)","trace[1727529674] 'applied index is now lower than readState.Index' (duration: 202.119525ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:01:38.974111Z","caller":"traceutil/trace.go:171","msg":"trace[1108075566] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"301.345895ms","start":"2026-06-30T18:01:38.672753Z","end":"2026-06-30T18:01:38.974099Z","steps":["trace[1108075566] 'process raft request' (duration: 301.14618ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:38.9741Z","caller":"traceutil/trace.go:171","msg":"trace[1873076053] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"327.125031ms","start":"2026-06-30T18:01:38.646944Z","end":"2026-06-30T18:01:38.974069Z","steps":["trace[1873076053] 'process raft request' (duration: 326.742662ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:38.974133Z","caller":"traceutil/trace.go:171","msg":"trace[1449817293] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"294.844785ms","start":"2026-06-30T18:01:38.679256Z","end":"2026-06-30T18:01:38.974101Z","steps":["trace[1449817293] 'process raft request' (duration: 294.709832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:38.974192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:01:38.672733Z","time spent":"301.412277ms","remote":"127.0.0.1:44414","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-30T18:01:38.97396Z","caller":"traceutil/trace.go:171","msg":"trace[1806137483] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"327.030769ms","start":"2026-06-30T18:01:38.646903Z","end":"2026-06-30T18:01:38.973934Z","steps":["trace[1806137483] 'process raft request' (duration: 124.975985ms)","trace[1806137483] 'compare' (duration: 201.350085ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:01:38.974234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:01:38.646927Z","time spent":"327.235484ms","remote":"127.0.0.1:44302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:01:38.974282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.189229ms","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-30T18:01:38.974331Z","caller":"traceutil/trace.go:171","msg":"trace[2049212313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4982; }","duration":"236.26394ms","start":"2026-06-30T18:01:38.738053Z","end":"2026-06-30T18:01:38.974317Z","steps":["trace[2049212313] 'agreement among raft nodes before linearized reading' (duration: 236.096635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:38.974356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:01:38.646884Z","time spent":"327.385418ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1563,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:01:38.97442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.46024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:1 size:799"} {"level":"info","ts":"2026-06-30T18:01:38.974483Z","caller":"traceutil/trace.go:171","msg":"trace[1995665937] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:1; response_revision:4982; }","duration":"235.586303ms","start":"2026-06-30T18:01:38.738878Z","end":"2026-06-30T18:01:38.974465Z","steps":["trace[1995665937] 'agreement among raft nodes before linearized reading' (duration: 235.380628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:38.97542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.429949ms","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":"warn","ts":"2026-06-30T18:01:38.975724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.434577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:797328"} {"level":"info","ts":"2026-06-30T18:01:38.975806Z","caller":"traceutil/trace.go:171","msg":"trace[1252939118] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:4982; }","duration":"183.554759ms","start":"2026-06-30T18:01:38.792232Z","end":"2026-06-30T18:01:38.975786Z","steps":["trace[1252939118] 'agreement among raft nodes before linearized reading' (duration: 181.976078ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:38.976054Z","caller":"traceutil/trace.go:171","msg":"trace[2010328144] 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:4982; }","duration":"320.053666ms","start":"2026-06-30T18:01:38.655968Z","end":"2026-06-30T18:01:38.976022Z","steps":["trace[2010328144] 'agreement among raft nodes before linearized reading' (duration: 318.123295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:38.97615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:01:38.65595Z","time spent":"320.173289ms","remote":"127.0.0.1:44298","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":"info","ts":"2026-06-30T18:01:39.162996Z","caller":"traceutil/trace.go:171","msg":"trace[40493402] linearizableReadLoop","detail":"{readStateIndex:5176; appliedIndex:5175; }","duration":"113.071283ms","start":"2026-06-30T18:01:39.049871Z","end":"2026-06-30T18:01:39.162942Z","steps":["trace[40493402] 'read index received' (duration: 104.345594ms)","trace[40493402] 'applied index is now lower than readState.Index' (duration: 8.723939ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:01:39.163065Z","caller":"traceutil/trace.go:171","msg":"trace[1209993113] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"116.956345ms","start":"2026-06-30T18:01:39.046073Z","end":"2026-06-30T18:01:39.163029Z","steps":["trace[1209993113] 'process raft request' (duration: 108.254217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:39.163239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.629105ms","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-30T18:01:39.163284Z","caller":"traceutil/trace.go:171","msg":"trace[243204856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4985; }","duration":"111.718158ms","start":"2026-06-30T18:01:39.051552Z","end":"2026-06-30T18:01:39.16327Z","steps":["trace[243204856] 'agreement among raft nodes before linearized reading' (duration: 111.591674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:39.163339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.446812ms","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-30T18:01:39.163434Z","caller":"traceutil/trace.go:171","msg":"trace[757859582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4985; }","duration":"113.556195ms","start":"2026-06-30T18:01:39.049852Z","end":"2026-06-30T18:01:39.163409Z","steps":["trace[757859582] 'agreement among raft nodes before linearized reading' (duration: 113.247636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:39.163434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.84765ms","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-30T18:01:39.16353Z","caller":"traceutil/trace.go:171","msg":"trace[1100988785] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4985; }","duration":"106.980584ms","start":"2026-06-30T18:01:39.056527Z","end":"2026-06-30T18:01:39.163507Z","steps":["trace[1100988785] 'agreement among raft nodes before linearized reading' (duration: 106.663935ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:48.477148Z","caller":"traceutil/trace.go:171","msg":"trace[227859863] transaction","detail":"{read_only:false; response_revision:5162; number_of_response:1; }","duration":"102.617898ms","start":"2026-06-30T18:01:48.374481Z","end":"2026-06-30T18:01:48.477099Z","steps":["trace[227859863] 'process raft request' (duration: 102.210588ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:49.369028Z","caller":"traceutil/trace.go:171","msg":"trace[906278075] linearizableReadLoop","detail":"{readStateIndex:5370; appliedIndex:5369; }","duration":"103.156262ms","start":"2026-06-30T18:01:49.265792Z","end":"2026-06-30T18:01:49.368948Z","steps":["trace[906278075] 'read index received' (duration: 5.036181ms)","trace[906278075] 'applied index is now lower than readState.Index' (duration: 98.117931ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:01:49.369198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.195949ms","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-30T18:01:49.369295Z","caller":"traceutil/trace.go:171","msg":"trace[1682404178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5172; }","duration":"157.300452ms","start":"2026-06-30T18:01:49.211972Z","end":"2026-06-30T18:01:49.369272Z","steps":["trace[1682404178] 'agreement among raft nodes before linearized reading' (duration: 157.025125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:49.369281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.518738ms","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-30T18:01:49.36932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.364732ms","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-30T18:01:49.369366Z","caller":"traceutil/trace.go:171","msg":"trace[1335901672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5172; }","duration":"160.464814ms","start":"2026-06-30T18:01:49.208887Z","end":"2026-06-30T18:01:49.369352Z","steps":["trace[1335901672] 'agreement among raft nodes before linearized reading' (duration: 160.241198ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:49.369361Z","caller":"traceutil/trace.go:171","msg":"trace[1041915297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5172; }","duration":"157.62979ms","start":"2026-06-30T18:01:49.211711Z","end":"2026-06-30T18:01:49.369341Z","steps":["trace[1041915297] 'agreement among raft nodes before linearized reading' (duration: 157.373043ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:49.369979Z","caller":"traceutil/trace.go:171","msg":"trace[674152285] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"102.029134ms","start":"2026-06-30T18:01:49.267917Z","end":"2026-06-30T18:01:49.369946Z","steps":["trace[674152285] 'process raft request' (duration: 100.982406ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:49.498353Z","caller":"traceutil/trace.go:171","msg":"trace[482695051] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"123.366372ms","start":"2026-06-30T18:01:49.374961Z","end":"2026-06-30T18:01:49.498327Z","steps":["trace[482695051] 'process raft request' (duration: 123.319471ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:49.498749Z","caller":"traceutil/trace.go:171","msg":"trace[244356198] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"124.313467ms","start":"2026-06-30T18:01:49.37441Z","end":"2026-06-30T18:01:49.498724Z","steps":["trace[244356198] 'process raft request' (duration: 97.943826ms)","trace[244356198] 'compare' (duration: 25.649852ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:01:49.498833Z","caller":"traceutil/trace.go:171","msg":"trace[777257546] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"124.203595ms","start":"2026-06-30T18:01:49.374585Z","end":"2026-06-30T18:01:49.498789Z","steps":["trace[777257546] 'process raft request' (duration: 123.65461ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:49.498994Z","caller":"traceutil/trace.go:171","msg":"trace[2097945160] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"124.455441ms","start":"2026-06-30T18:01:49.374524Z","end":"2026-06-30T18:01:49.49898Z","steps":["trace[2097945160] 'process raft request' (duration: 123.64803ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:50.256084Z","caller":"traceutil/trace.go:171","msg":"trace[1119046362] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"488.823178ms","start":"2026-06-30T18:01:49.767229Z","end":"2026-06-30T18:01:50.256052Z","steps":["trace[1119046362] 'process raft request' (duration: 488.601712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:01:50.256268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:01:49.767214Z","time spent":"488.958001ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:01:52.629341Z","caller":"traceutil/trace.go:171","msg":"trace[1096502200] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"196.046127ms","start":"2026-06-30T18:01:52.433263Z","end":"2026-06-30T18:01:52.629309Z","steps":["trace[1096502200] 'process raft request' (duration: 195.861123ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:52.629856Z","caller":"traceutil/trace.go:171","msg":"trace[1255519793] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"138.805007ms","start":"2026-06-30T18:01:52.491032Z","end":"2026-06-30T18:01:52.629837Z","steps":["trace[1255519793] 'process raft request' (duration: 138.779707ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:01:52.629897Z","caller":"traceutil/trace.go:171","msg":"trace[310812969] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"139.28544ms","start":"2026-06-30T18:01:52.490579Z","end":"2026-06-30T18:01:52.629864Z","steps":["trace[310812969] 'process raft request' (duration: 139.139846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:03.566199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.621187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-30T18:02:03.566268Z","caller":"traceutil/trace.go:171","msg":"trace[1453787672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5396; }","duration":"113.72224ms","start":"2026-06-30T18:02:03.452531Z","end":"2026-06-30T18:02:03.566254Z","steps":["trace[1453787672] 'range keys from in-memory index tree' (duration: 113.516364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:03.904064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.306305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T18:02:03.904232Z","caller":"traceutil/trace.go:171","msg":"trace[252521318] linearizableReadLoop","detail":"{readStateIndex:5601; appliedIndex:5599; }","duration":"235.975873ms","start":"2026-06-30T18:02:03.668237Z","end":"2026-06-30T18:02:03.904213Z","steps":["trace[252521318] 'read index received' (duration: 42.416922ms)","trace[252521318] 'applied index is now lower than readState.Index' (duration: 193.557981ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:03.9043Z","caller":"traceutil/trace.go:171","msg":"trace[1834480521] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"333.027026ms","start":"2026-06-30T18:02:03.571223Z","end":"2026-06-30T18:02:03.90425Z","steps":["trace[1834480521] 'process raft request' (duration: 139.452215ms)","trace[1834480521] 'compare' (duration: 193.182221ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:03.904425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.167918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T18:02:03.904487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:03.571201Z","time spent":"333.193681ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:02:03.904503Z","caller":"traceutil/trace.go:171","msg":"trace[162912930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5399; }","duration":"236.290331ms","start":"2026-06-30T18:02:03.668197Z","end":"2026-06-30T18:02:03.904487Z","steps":["trace[162912930] 'agreement among raft nodes before linearized reading' (duration: 236.168978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:03.904597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.180835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8cd064c-ef96-40d9-b484-414a13b84691\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-30T18:02:03.904637Z","caller":"traceutil/trace.go:171","msg":"trace[1442578216] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a8cd064c-ef96-40d9-b484-414a13b84691; range_end:; response_count:1; response_revision:5399; }","duration":"221.259527ms","start":"2026-06-30T18:02:03.683365Z","end":"2026-06-30T18:02:03.904625Z","steps":["trace[1442578216] 'agreement among raft nodes before linearized reading' (duration: 221.061822ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:03.904312Z","caller":"traceutil/trace.go:171","msg":"trace[1103083784] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"332.754268ms","start":"2026-06-30T18:02:03.571533Z","end":"2026-06-30T18:02:03.904287Z","steps":["trace[1103083784] 'process raft request' (duration: 332.625805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:03.904748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:03.571524Z","time spent":"333.16683ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:02:03.904781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.036737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:02:03.904831Z","caller":"traceutil/trace.go:171","msg":"trace[665551250] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:5399; }","duration":"125.105889ms","start":"2026-06-30T18:02:03.779695Z","end":"2026-06-30T18:02:03.904801Z","steps":["trace[665551250] 'agreement among raft nodes before linearized reading' (duration: 125.057498ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.221232Z","caller":"traceutil/trace.go:171","msg":"trace[947527185] linearizableReadLoop","detail":"{readStateIndex:5602; appliedIndex:5601; }","duration":"127.346287ms","start":"2026-06-30T18:02:04.093858Z","end":"2026-06-30T18:02:04.221204Z","steps":["trace[947527185] 'read index received' (duration: 121.057762ms)","trace[947527185] 'applied index is now lower than readState.Index' (duration: 6.287075ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:04.221295Z","caller":"traceutil/trace.go:171","msg":"trace[800083994] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"309.003316ms","start":"2026-06-30T18:02:03.912268Z","end":"2026-06-30T18:02:04.221271Z","steps":["trace[800083994] 'process raft request' (duration: 302.704141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:04.221452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.578623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-30T18:02:04.2215Z","caller":"traceutil/trace.go:171","msg":"trace[1823860345] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:5400; }","duration":"127.667305ms","start":"2026-06-30T18:02:04.093814Z","end":"2026-06-30T18:02:04.221482Z","steps":["trace[1823860345] 'agreement among raft nodes before linearized reading' (duration: 127.492411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:04.222087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:03.912244Z","time spent":"309.108809ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:02:04.52176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.83337ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-30T18:02:04.521884Z","caller":"traceutil/trace.go:171","msg":"trace[898778964] linearizableReadLoop","detail":"{readStateIndex:5603; appliedIndex:5602; }","duration":"296.109299ms","start":"2026-06-30T18:02:04.225754Z","end":"2026-06-30T18:02:04.521863Z","steps":["trace[898778964] 'read index received' (duration: 147.105034ms)","trace[898778964] 'applied index is now lower than readState.Index' (duration: 149.002385ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:04.522043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.277124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-gateway-cf54cb88c-lqg5d\" ","response":"range_response_count:1 size:4760"} {"level":"info","ts":"2026-06-30T18:02:04.522079Z","caller":"traceutil/trace.go:171","msg":"trace[1489921096] range","detail":"{range_begin:/registry/pods/monitoring/loki-gateway-cf54cb88c-lqg5d; range_end:; response_count:1; response_revision:5400; }","duration":"296.357536ms","start":"2026-06-30T18:02:04.225713Z","end":"2026-06-30T18:02:04.522071Z","steps":["trace[1489921096] 'agreement among raft nodes before linearized reading' (duration: 296.204651ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.778272Z","caller":"traceutil/trace.go:171","msg":"trace[1150756698] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"199.802445ms","start":"2026-06-30T18:02:04.578441Z","end":"2026-06-30T18:02:04.778243Z","steps":["trace[1150756698] 'process raft request' (duration: 198.755878ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.792227Z","caller":"traceutil/trace.go:171","msg":"trace[128004779] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"213.433892ms","start":"2026-06-30T18:02:04.578764Z","end":"2026-06-30T18:02:04.792198Z","steps":["trace[128004779] 'process raft request' (duration: 213.174015ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.792553Z","caller":"traceutil/trace.go:171","msg":"trace[897008716] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"212.769635ms","start":"2026-06-30T18:02:04.579762Z","end":"2026-06-30T18:02:04.792532Z","steps":["trace[897008716] 'process raft request' (duration: 212.599151ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.792649Z","caller":"traceutil/trace.go:171","msg":"trace[665393311] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"213.32149ms","start":"2026-06-30T18:02:04.579313Z","end":"2026-06-30T18:02:04.792635Z","steps":["trace[665393311] 'process raft request' (duration: 212.799876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:04.79267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.774337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:02:04.792556Z","caller":"traceutil/trace.go:171","msg":"trace[1176197737] linearizableReadLoop","detail":"{readStateIndex:5610; appliedIndex:5605; }","duration":"122.648313ms","start":"2026-06-30T18:02:04.669891Z","end":"2026-06-30T18:02:04.792539Z","steps":["trace[1176197737] 'read index received' (duration: 107.278591ms)","trace[1176197737] 'applied index is now lower than readState.Index' (duration: 15.368912ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:04.792695Z","caller":"traceutil/trace.go:171","msg":"trace[1926353449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5409; }","duration":"122.847239ms","start":"2026-06-30T18:02:04.669841Z","end":"2026-06-30T18:02:04.792688Z","steps":["trace[1926353449] 'agreement among raft nodes before linearized reading' (duration: 122.752867ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.792808Z","caller":"traceutil/trace.go:171","msg":"trace[212872804] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"115.011604ms","start":"2026-06-30T18:02:04.677789Z","end":"2026-06-30T18:02:04.792801Z","steps":["trace[212872804] 'process raft request' (duration: 114.699866ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.792841Z","caller":"traceutil/trace.go:171","msg":"trace[598783530] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"212.392445ms","start":"2026-06-30T18:02:04.580441Z","end":"2026-06-30T18:02:04.792834Z","steps":["trace[598783530] 'process raft request' (duration: 212.014365ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:04.792917Z","caller":"traceutil/trace.go:171","msg":"trace[170855731] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"109.687213ms","start":"2026-06-30T18:02:04.683224Z","end":"2026-06-30T18:02:04.792911Z","steps":["trace[170855731] 'process raft request' (duration: 109.293284ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:21.132214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962} {"level":"info","ts":"2026-06-30T18:03:21.222853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"88.95374ms","hash":600212315,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":34131968,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-30T18:03:21.222976Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":600212315,"revision":2962,"compact-revision":-1} {"level":"info","ts":"2026-06-30T18:05:40.553474Z","caller":"traceutil/trace.go:171","msg":"trace[31024504] transaction","detail":"{read_only:false; response_revision:6934; number_of_response:1; }","duration":"126.656078ms","start":"2026-06-30T18:05:40.426783Z","end":"2026-06-30T18:05:40.553439Z","steps":["trace[31024504] 'process raft request' (duration: 115.557547ms)","trace[31024504] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; req_size:414225; } (duration: 10.057955ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:11.720965Z","caller":"traceutil/trace.go:171","msg":"trace[837633581] linearizableReadLoop","detail":"{readStateIndex:8371; appliedIndex:8370; }","duration":"324.182413ms","start":"2026-06-30T18:08:11.396757Z","end":"2026-06-30T18:08:11.72094Z","steps":["trace[837633581] 'read index received' (duration: 324.026919ms)","trace[837633581] 'applied index is now lower than readState.Index' (duration: 154.234µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:11.721052Z","caller":"traceutil/trace.go:171","msg":"trace[733926946] transaction","detail":"{read_only:false; response_revision:8080; number_of_response:1; }","duration":"437.44438ms","start":"2026-06-30T18:08:11.28357Z","end":"2026-06-30T18:08:11.721015Z","steps":["trace[733926946] 'process raft request' (duration: 437.221064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:11.721209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:11.283544Z","time spent":"437.583084ms","remote":"127.0.0.1:44414","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-30T18:08:11.721224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.44637ms","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-30T18:08:11.721511Z","caller":"traceutil/trace.go:171","msg":"trace[1645255640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8080; }","duration":"324.765738ms","start":"2026-06-30T18:08:11.396711Z","end":"2026-06-30T18:08:11.721477Z","steps":["trace[1645255640] 'agreement among raft nodes before linearized reading' (duration: 324.400589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:11.72157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:11.396692Z","time spent":"324.862641ms","remote":"127.0.0.1:44414","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":"info","ts":"2026-06-30T18:08:13.86449Z","caller":"traceutil/trace.go:171","msg":"trace[1946660743] linearizableReadLoop","detail":"{readStateIndex:8383; appliedIndex:8381; }","duration":"105.570105ms","start":"2026-06-30T18:08:13.758893Z","end":"2026-06-30T18:08:13.864463Z","steps":["trace[1946660743] 'read index received' (duration: 32.174005ms)","trace[1946660743] 'applied index is now lower than readState.Index' (duration: 73.3949ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:13.864528Z","caller":"traceutil/trace.go:171","msg":"trace[1297178094] transaction","detail":"{read_only:false; response_revision:8092; number_of_response:1; }","duration":"106.307665ms","start":"2026-06-30T18:08:13.758181Z","end":"2026-06-30T18:08:13.864488Z","steps":["trace[1297178094] 'process raft request' (duration: 106.11547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:13.864709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.795912ms","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-30T18:08:13.864773Z","caller":"traceutil/trace.go:171","msg":"trace[1103118051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8092; }","duration":"105.915576ms","start":"2026-06-30T18:08:13.758829Z","end":"2026-06-30T18:08:13.864745Z","steps":["trace[1103118051] 'agreement among raft nodes before linearized reading' (duration: 105.752281ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:08:21.79964Z","caller":"traceutil/trace.go:171","msg":"trace[2062148459] linearizableReadLoop","detail":"{readStateIndex:8558; appliedIndex:8557; }","duration":"345.406821ms","start":"2026-06-30T18:08:21.454207Z","end":"2026-06-30T18:08:21.799614Z","steps":["trace[2062148459] 'read index received' (duration: 345.223276ms)","trace[2062148459] 'applied index is now lower than readState.Index' (duration: 182.235µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:21.799697Z","caller":"traceutil/trace.go:171","msg":"trace[1426978272] transaction","detail":"{read_only:false; response_revision:8265; number_of_response:1; }","duration":"665.393013ms","start":"2026-06-30T18:08:21.134267Z","end":"2026-06-30T18:08:21.79966Z","steps":["trace[1426978272] 'process raft request' (duration: 665.203018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:21.799872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:21.134235Z","time spent":"665.548868ms","remote":"127.0.0.1:44136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:08:21.799873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.648097ms","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-30T18:08:21.799939Z","caller":"traceutil/trace.go:171","msg":"trace[1965774635] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:8265; }","duration":"345.74862ms","start":"2026-06-30T18:08:21.454173Z","end":"2026-06-30T18:08:21.799921Z","steps":["trace[1965774635] 'agreement among raft nodes before linearized reading' (duration: 345.577886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:21.799982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:21.454155Z","time spent":"345.818222ms","remote":"127.0.0.1:54490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "} {"level":"info","ts":"2026-06-30T18:08:21.839773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6071} {"level":"info","ts":"2026-06-30T18:08:21.933906Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6071,"took":"92.110431ms","hash":1250594328,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":23924736,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-30T18:08:21.933963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1250594328,"revision":6071,"compact-revision":2962} {"level":"info","ts":"2026-06-30T18:08:32.450622Z","caller":"traceutil/trace.go:171","msg":"trace[854070565] linearizableReadLoop","detail":"{readStateIndex:8619; appliedIndex:8618; }","duration":"247.358822ms","start":"2026-06-30T18:08:32.203241Z","end":"2026-06-30T18:08:32.4506Z","steps":["trace[854070565] 'read index received' (duration: 247.197368ms)","trace[854070565] 'applied index is now lower than readState.Index' (duration: 160.464µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:32.450681Z","caller":"traceutil/trace.go:171","msg":"trace[803419687] transaction","detail":"{read_only:false; response_revision:8323; number_of_response:1; }","duration":"271.164109ms","start":"2026-06-30T18:08:32.179484Z","end":"2026-06-30T18:08:32.450648Z","steps":["trace[803419687] 'process raft request' (duration: 270.976544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:32.450934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.675952ms","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-30T18:08:32.45096Z","caller":"traceutil/trace.go:171","msg":"trace[1033973845] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8323; }","duration":"247.743843ms","start":"2026-06-30T18:08:32.20321Z","end":"2026-06-30T18:08:32.450954Z","steps":["trace[1033973845] 'agreement among raft nodes before linearized reading' (duration: 247.674161ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:08:32.466415Z","caller":"traceutil/trace.go:171","msg":"trace[1198326571] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"245.3186ms","start":"2026-06-30T18:08:32.221069Z","end":"2026-06-30T18:08:32.466388Z","steps":["trace[1198326571] 'process raft request' (duration: 245.149046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:32.46664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.015604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T18:08:32.466742Z","caller":"traceutil/trace.go:171","msg":"trace[528675694] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:8326; }","duration":"123.181558ms","start":"2026-06-30T18:08:32.343536Z","end":"2026-06-30T18:08:32.466717Z","steps":["trace[528675694] 'agreement among raft nodes before linearized reading' (duration: 122.967703ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:08:32.824242Z","caller":"traceutil/trace.go:171","msg":"trace[252293958] linearizableReadLoop","detail":"{readStateIndex:8623; appliedIndex:8622; }","duration":"156.466003ms","start":"2026-06-30T18:08:32.66775Z","end":"2026-06-30T18:08:32.824216Z","steps":["trace[252293958] 'read index received' (duration: 156.250588ms)","trace[252293958] 'applied index is now lower than readState.Index' (duration: 214.575µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:32.824302Z","caller":"traceutil/trace.go:171","msg":"trace[1011348872] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"209.864047ms","start":"2026-06-30T18:08:32.614404Z","end":"2026-06-30T18:08:32.824268Z","steps":["trace[1011348872] 'process raft request' (duration: 209.652562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:32.824375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.605157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:08:32.824427Z","caller":"traceutil/trace.go:171","msg":"trace[304665528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8327; }","duration":"156.70949ms","start":"2026-06-30T18:08:32.667707Z","end":"2026-06-30T18:08:32.824416Z","steps":["trace[304665528] 'agreement among raft nodes before linearized reading' (duration: 156.615168ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:08:34.587278Z","caller":"traceutil/trace.go:171","msg":"trace[192891608] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"116.484302ms","start":"2026-06-30T18:08:34.470757Z","end":"2026-06-30T18:08:34.587242Z","steps":["trace[192891608] 'process raft request' (duration: 116.294757ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:08:34.587309Z","caller":"traceutil/trace.go:171","msg":"trace[1855183935] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"116.301918ms","start":"2026-06-30T18:08:34.470981Z","end":"2026-06-30T18:08:34.587283Z","steps":["trace[1855183935] 'process raft request' (duration: 116.194935ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:08:34.587369Z","caller":"traceutil/trace.go:171","msg":"trace[113308494] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"115.901336ms","start":"2026-06-30T18:08:34.471442Z","end":"2026-06-30T18:08:34.587343Z","steps":["trace[113308494] 'process raft request' (duration: 115.807904ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:01.480624Z","caller":"traceutil/trace.go:171","msg":"trace[1856939805] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"144.43467ms","start":"2026-06-30T18:09:01.336125Z","end":"2026-06-30T18:09:01.480559Z","steps":["trace[1856939805] 'process raft request' (duration: 144.03585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.171865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305497081688042121,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T18:09:03.295274Z","caller":"traceutil/trace.go:171","msg":"trace[1655881580] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"646.326533ms","start":"2026-06-30T18:09:02.648924Z","end":"2026-06-30T18:09:03.295251Z","steps":["trace[1655881580] 'process raft request' (duration: 646.166759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.295419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.648906Z","time spent":"646.439496ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:09:03.298773Z","caller":"traceutil/trace.go:171","msg":"trace[1547237960] transaction","detail":"{read_only:false; response_revision:8539; number_of_response:1; }","duration":"622.199909ms","start":"2026-06-30T18:09:02.676532Z","end":"2026-06-30T18:09:03.298732Z","steps":["trace[1547237960] 'process raft request' (duration: 621.928002ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:03.298788Z","caller":"traceutil/trace.go:171","msg":"trace[767909511] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"616.543799ms","start":"2026-06-30T18:09:02.682206Z","end":"2026-06-30T18:09:03.29875Z","steps":["trace[767909511] 'process raft request' (duration: 616.399626ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:03.298847Z","caller":"traceutil/trace.go:171","msg":"trace[155923628] linearizableReadLoop","detail":"{readStateIndex:8847; appliedIndex:8842; }","duration":"627.485887ms","start":"2026-06-30T18:09:02.67134Z","end":"2026-06-30T18:09:03.298825Z","steps":["trace[155923628] 'read index received' (duration: 623.736419ms)","trace[155923628] 'applied index is now lower than readState.Index' (duration: 3.748318ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:09:03.29888Z","caller":"traceutil/trace.go:171","msg":"trace[2104102574] transaction","detail":"{read_only:false; response_revision:8541; number_of_response:1; }","duration":"613.951322ms","start":"2026-06-30T18:09:02.684914Z","end":"2026-06-30T18:09:03.298866Z","steps":["trace[2104102574] 'process raft request' (duration: 613.733907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.298931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.676511Z","time spent":"622.346513ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:09:03.298986Z","caller":"traceutil/trace.go:171","msg":"trace[299915311] transaction","detail":"{read_only:false; response_revision:8542; number_of_response:1; }","duration":"449.121245ms","start":"2026-06-30T18:09:02.849824Z","end":"2026-06-30T18:09:03.298946Z","steps":["trace[299915311] 'process raft request' (duration: 448.89992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.299028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.685634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:09:03.299088Z","caller":"traceutil/trace.go:171","msg":"trace[1501112646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8542; }","duration":"627.774186ms","start":"2026-06-30T18:09:02.671282Z","end":"2026-06-30T18:09:03.299056Z","steps":["trace[1501112646] 'agreement among raft nodes before linearized reading' (duration: 627.666162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.299096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.915493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T18:09:03.299116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.671264Z","time spent":"627.846327ms","remote":"127.0.0.1:44118","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-30T18:09:03.299126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.849804Z","time spent":"449.250759ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:09:03.299144Z","caller":"traceutil/trace.go:171","msg":"trace[1750645415] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8542; }","duration":"348.009906ms","start":"2026-06-30T18:09:02.951118Z","end":"2026-06-30T18:09:03.299128Z","steps":["trace[1750645415] 'agreement among raft nodes before linearized reading' (duration: 347.847991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.299193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.951102Z","time spent":"348.078747ms","remote":"127.0.0.1:54452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":30,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"warn","ts":"2026-06-30T18:09:03.299202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.484127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T18:09:03.299258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.089346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-30T18:09:03.299279Z","caller":"traceutil/trace.go:171","msg":"trace[1264949808] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:8542; }","duration":"102.59977ms","start":"2026-06-30T18:09:03.196658Z","end":"2026-06-30T18:09:03.299257Z","steps":["trace[1264949808] 'agreement among raft nodes before linearized reading' (duration: 102.455407ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:03.299328Z","caller":"traceutil/trace.go:171","msg":"trace[1761819911] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8542; }","duration":"324.198719ms","start":"2026-06-30T18:09:02.975109Z","end":"2026-06-30T18:09:03.299308Z","steps":["trace[1761819911] 'agreement among raft nodes before linearized reading' (duration: 324.006715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:03.299381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.975091Z","time spent":"324.281411ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-30T18:09:03.299524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.684897Z","time spent":"614.590519ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:09:03.299937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:02.682183Z","time spent":"616.695665ms","remote":"127.0.0.1:44414","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-30T18:09:07.418674Z","caller":"traceutil/trace.go:171","msg":"trace[921099216] transaction","detail":"{read_only:false; response_revision:8560; number_of_response:1; }","duration":"101.533942ms","start":"2026-06-30T18:09:07.317118Z","end":"2026-06-30T18:09:07.418652Z","steps":["trace[921099216] 'process raft request' (duration: 98.364288ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:07.418894Z","caller":"traceutil/trace.go:171","msg":"trace[1359791712] transaction","detail":"{read_only:false; response_revision:8561; number_of_response:1; }","duration":"101.336165ms","start":"2026-06-30T18:09:07.317543Z","end":"2026-06-30T18:09:07.418879Z","steps":["trace[1359791712] 'process raft request' (duration: 101.068779ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:07.419276Z","caller":"traceutil/trace.go:171","msg":"trace[1139733976] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"101.580713ms","start":"2026-06-30T18:09:07.317679Z","end":"2026-06-30T18:09:07.41926Z","steps":["trace[1139733976] 'process raft request' (duration: 101.157221ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:15.773864Z","caller":"traceutil/trace.go:171","msg":"trace[1627360711] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"343.60793ms","start":"2026-06-30T18:09:15.430207Z","end":"2026-06-30T18:09:15.773815Z","steps":["trace[1627360711] 'process raft request' (duration: 244.978335ms)","trace[1627360711] 'compare' (duration: 98.378629ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:09:15.774024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:15.430179Z","time spent":"343.757414ms","remote":"127.0.0.1:44414","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-30T18:09:15.777934Z","caller":"traceutil/trace.go:171","msg":"trace[220532172] transaction","detail":"{read_only:false; response_revision:8648; number_of_response:1; }","duration":"333.076103ms","start":"2026-06-30T18:09:15.444835Z","end":"2026-06-30T18:09:15.777911Z","steps":["trace[220532172] 'process raft request' (duration: 332.919129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:15.778134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:15.444799Z","time spent":"333.255797ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:09:15.77825Z","caller":"traceutil/trace.go:171","msg":"trace[1123325777] transaction","detail":"{read_only:false; response_revision:8649; number_of_response:1; }","duration":"332.542158ms","start":"2026-06-30T18:09:15.44567Z","end":"2026-06-30T18:09:15.778213Z","steps":["trace[1123325777] 'process raft request' (duration: 332.199679ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:15.77828Z","caller":"traceutil/trace.go:171","msg":"trace[600469401] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"332.012036ms","start":"2026-06-30T18:09:15.446248Z","end":"2026-06-30T18:09:15.77826Z","steps":["trace[600469401] 'process raft request' (duration: 331.85014ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:15.778271Z","caller":"traceutil/trace.go:171","msg":"trace[1026500665] linearizableReadLoop","detail":"{readStateIndex:8960; appliedIndex:8956; }","duration":"320.074561ms","start":"2026-06-30T18:09:15.458144Z","end":"2026-06-30T18:09:15.778219Z","steps":["trace[1026500665] 'read index received' (duration: 217.130124ms)","trace[1026500665] 'applied index is now lower than readState.Index' (duration: 102.943337ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:09:15.778417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:15.446236Z","time spent":"332.107458ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:09:15.778451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:15.44566Z","time spent":"332.678451ms","remote":"127.0.0.1:44414","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-30T18:09:15.77853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.351279ms","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-30T18:09:15.778526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.379299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-30T18:09:15.778599Z","caller":"traceutil/trace.go:171","msg":"trace[1900213467] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:8650; }","duration":"320.452711ms","start":"2026-06-30T18:09:15.458128Z","end":"2026-06-30T18:09:15.778581Z","steps":["trace[1900213467] 'agreement among raft nodes before linearized reading' (duration: 320.255596ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:15.778606Z","caller":"traceutil/trace.go:171","msg":"trace[1916054347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8650; }","duration":"233.445051ms","start":"2026-06-30T18:09:15.54512Z","end":"2026-06-30T18:09:15.778565Z","steps":["trace[1916054347] 'agreement among raft nodes before linearized reading' (duration: 233.329858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:15.778615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.928977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T18:09:15.77865Z","caller":"traceutil/trace.go:171","msg":"trace[948917910] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:8650; }","duration":"114.002129ms","start":"2026-06-30T18:09:15.664638Z","end":"2026-06-30T18:09:15.77864Z","steps":["trace[948917910] 'agreement among raft nodes before linearized reading' (duration: 113.908967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:15.778646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:15.458075Z","time spent":"320.560084ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-ls65g\" "} {"level":"info","ts":"2026-06-30T18:09:16.080542Z","caller":"traceutil/trace.go:171","msg":"trace[757720628] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"297.359342ms","start":"2026-06-30T18:09:15.783155Z","end":"2026-06-30T18:09:16.080515Z","steps":["trace[757720628] 'process raft request' (duration: 246.935276ms)","trace[757720628] 'compare' (duration: 50.331694ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:09:17.138338Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002309.wal"} {"level":"info","ts":"2026-06-30T18:09:17.1387Z","caller":"traceutil/trace.go:171","msg":"trace[1694349687] transaction","detail":"{read_only:false; response_revision:8658; number_of_response:1; }","duration":"265.196807ms","start":"2026-06-30T18:09:16.87348Z","end":"2026-06-30T18:09:17.138676Z","steps":["trace[1694349687] 'process raft request' (duration: 265.037093ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:17.395562Z","caller":"traceutil/trace.go:171","msg":"trace[37971190] linearizableReadLoop","detail":"{readStateIndex:8969; appliedIndex:8968; }","duration":"252.318109ms","start":"2026-06-30T18:09:17.143213Z","end":"2026-06-30T18:09:17.395531Z","steps":["trace[37971190] 'read index received' (duration: 170.531257ms)","trace[37971190] 'applied index is now lower than readState.Index' (duration: 81.785222ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:09:17.395754Z","caller":"traceutil/trace.go:171","msg":"trace[1676327700] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"518.46132ms","start":"2026-06-30T18:09:16.877253Z","end":"2026-06-30T18:09:17.395714Z","steps":["trace[1676327700] 'process raft request' (duration: 436.465303ms)","trace[1676327700] 'compare' (duration: 81.635627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:09:17.395839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.599445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rook-ceph-cluster.18bdee3813ff209d\" ","response":"range_response_count:1 size:697"} {"level":"info","ts":"2026-06-30T18:09:17.395886Z","caller":"traceutil/trace.go:171","msg":"trace[1090251682] range","detail":"{range_begin:/registry/events/openstack/rook-ceph-cluster.18bdee3813ff209d; range_end:; response_count:1; response_revision:8659; }","duration":"252.692808ms","start":"2026-06-30T18:09:17.143177Z","end":"2026-06-30T18:09:17.395869Z","steps":["trace[1090251682] 'agreement among raft nodes before linearized reading' (duration: 252.477543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:17.395913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:09:16.877236Z","time spent":"518.605604ms","remote":"127.0.0.1:44238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":583,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T18:09:17.566239Z","caller":"traceutil/trace.go:171","msg":"trace[2064841] linearizableReadLoop","detail":"{readStateIndex:8971; appliedIndex:8969; }","duration":"166.639555ms","start":"2026-06-30T18:09:17.399573Z","end":"2026-06-30T18:09:17.566213Z","steps":["trace[2064841] 'read index received' (duration: 47.060449ms)","trace[2064841] 'applied index is now lower than readState.Index' (duration: 119.577876ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:09:17.566363Z","caller":"traceutil/trace.go:171","msg":"trace[1416790951] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"167.861966ms","start":"2026-06-30T18:09:17.398487Z","end":"2026-06-30T18:09:17.566349Z","steps":["trace[1416790951] 'process raft request' (duration: 99.591ms)","trace[1416790951] 'compare' (duration: 68.014209ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:09:17.566631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.955172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rook-ceph-config\" ","response":"range_response_count:1 size:598"} {"level":"warn","ts":"2026-06-30T18:09:17.56689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.312802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-30T18:09:17.566901Z","caller":"traceutil/trace.go:171","msg":"trace[1401361632] range","detail":"{range_begin:/registry/secrets/openstack/rook-ceph-config; range_end:; response_count:1; response_revision:8661; }","duration":"167.238599ms","start":"2026-06-30T18:09:17.399643Z","end":"2026-06-30T18:09:17.566882Z","steps":["trace[1401361632] 'agreement among raft nodes before linearized reading' (duration: 166.852309ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:09:17.566934Z","caller":"traceutil/trace.go:171","msg":"trace[593521661] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:8661; }","duration":"167.365254ms","start":"2026-06-30T18:09:17.399559Z","end":"2026-06-30T18:09:17.566924Z","steps":["trace[593521661] 'agreement among raft nodes before linearized reading' (duration: 167.230299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:17.56697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.550722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-30T18:09:17.567047Z","caller":"traceutil/trace.go:171","msg":"trace[736178941] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:8661; }","duration":"166.640704ms","start":"2026-06-30T18:09:17.400389Z","end":"2026-06-30T18:09:17.56703Z","steps":["trace[736178941] 'agreement among raft nodes before linearized reading' (duration: 166.404278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:09:17.566763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.348114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:09:17.567137Z","caller":"traceutil/trace.go:171","msg":"trace[511314365] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:8661; }","duration":"118.771575ms","start":"2026-06-30T18:09:17.448352Z","end":"2026-06-30T18:09:17.567123Z","steps":["trace[511314365] 'agreement among raft nodes before linearized reading' (duration: 118.351893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:10:20.882163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.760948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T18:10:20.882205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.329104ms","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:5"} {"level":"info","ts":"2026-06-30T18:10:20.88225Z","caller":"traceutil/trace.go:171","msg":"trace[106672517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9335; }","duration":"204.88822ms","start":"2026-06-30T18:10:20.677344Z","end":"2026-06-30T18:10:20.882232Z","steps":["trace[106672517] 'range keys from in-memory index tree' (duration: 204.680685ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:10:20.882259Z","caller":"traceutil/trace.go:171","msg":"trace[2048328635] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:9335; }","duration":"107.429946ms","start":"2026-06-30T18:10:20.774814Z","end":"2026-06-30T18:10:20.882244Z","steps":["trace[2048328635] 'count revisions from in-memory index tree' (duration: 107.240832ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:10:33.679948Z","caller":"traceutil/trace.go:171","msg":"trace[892200754] transaction","detail":"{read_only:false; response_revision:9405; number_of_response:1; }","duration":"288.328206ms","start":"2026-06-30T18:10:33.391589Z","end":"2026-06-30T18:10:33.679917Z","steps":["trace[892200754] 'process raft request' (duration: 288.155ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:10:33.863335Z","caller":"traceutil/trace.go:171","msg":"trace[1485282318] transaction","detail":"{read_only:false; response_revision:9406; number_of_response:1; }","duration":"159.535357ms","start":"2026-06-30T18:10:33.703768Z","end":"2026-06-30T18:10:33.863304Z","steps":["trace[1485282318] 'process raft request' (duration: 145.58959ms)","trace[1485282318] 'compare' (duration: 13.831603ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:11:09.537852Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T18:11:09.54515Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-30T18:11:09.545272Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-30T18:13:21.847364Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8265} {"level":"info","ts":"2026-06-30T18:13:21.925701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8265,"took":"75.765831ms","hash":2077833828,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":25149440,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-30T18:13:21.9258Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2077833828,"revision":8265,"compact-revision":6071} {"level":"info","ts":"2026-06-30T18:14:42.248705Z","caller":"traceutil/trace.go:171","msg":"trace[760109894] linearizableReadLoop","detail":"{readStateIndex:11384; appliedIndex:11383; }","duration":"363.394566ms","start":"2026-06-30T18:14:41.885286Z","end":"2026-06-30T18:14:42.24868Z","steps":["trace[760109894] 'read index received' (duration: 363.098369ms)","trace[760109894] 'applied index is now lower than readState.Index' (duration: 294.967µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:14:42.248873Z","caller":"traceutil/trace.go:171","msg":"trace[1789744839] transaction","detail":"{read_only:false; response_revision:10996; number_of_response:1; }","duration":"400.659556ms","start":"2026-06-30T18:14:41.848194Z","end":"2026-06-30T18:14:42.248853Z","steps":["trace[1789744839] 'process raft request' (duration: 400.276446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:42.249015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.678964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-30T18:14:42.249033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:14:41.848174Z","time spent":"400.743357ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:14:42.24906Z","caller":"traceutil/trace.go:171","msg":"trace[428340111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10996; }","duration":"363.798027ms","start":"2026-06-30T18:14:41.885249Z","end":"2026-06-30T18:14:42.249047Z","steps":["trace[428340111] 'agreement among raft nodes before linearized reading' (duration: 363.600032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:42.249098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:14:41.885235Z","time spent":"363.85396ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T18:14:42.249251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.94632ms","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-30T18:14:42.249282Z","caller":"traceutil/trace.go:171","msg":"trace[1044075019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10996; }","duration":"350.971111ms","start":"2026-06-30T18:14:41.898297Z","end":"2026-06-30T18:14:42.249268Z","steps":["trace[1044075019] 'agreement among raft nodes before linearized reading' (duration: 350.889799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:42.249307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:14:41.898289Z","time spent":"351.012162ms","remote":"127.0.0.1:44414","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-30T18:14:42.249447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.213079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T18:14:42.249499Z","caller":"traceutil/trace.go:171","msg":"trace[832035265] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:10996; }","duration":"270.304071ms","start":"2026-06-30T18:14:41.979179Z","end":"2026-06-30T18:14:42.249483Z","steps":["trace[832035265] 'agreement among raft nodes before linearized reading' (duration: 270.216109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:43.971581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305497081688048746,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T18:14:44.148015Z","caller":"traceutil/trace.go:171","msg":"trace[1300698504] linearizableReadLoop","detail":"{readStateIndex:11402; appliedIndex:11401; }","duration":"676.825991ms","start":"2026-06-30T18:14:43.471156Z","end":"2026-06-30T18:14:44.147982Z","steps":["trace[1300698504] 'read index received' (duration: 676.42642ms)","trace[1300698504] 'applied index is now lower than readState.Index' (duration: 398.191µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:14:44.148147Z","caller":"traceutil/trace.go:171","msg":"trace[1126380888] transaction","detail":"{read_only:false; response_revision:11014; number_of_response:1; }","duration":"726.794164ms","start":"2026-06-30T18:14:43.421312Z","end":"2026-06-30T18:14:44.148106Z","steps":["trace[1126380888] 'process raft request' (duration: 726.223109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:44.148337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:14:43.421281Z","time spent":"726.961737ms","remote":"127.0.0.1:44414","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-30T18:14:44.148354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.18113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/staffeln-db-init-dn5k5\" ","response":"range_response_count:1 size:7097"} {"level":"info","ts":"2026-06-30T18:14:44.148408Z","caller":"traceutil/trace.go:171","msg":"trace[1690335813] range","detail":"{range_begin:/registry/pods/openstack/staffeln-db-init-dn5k5; range_end:; response_count:1; response_revision:11014; }","duration":"677.294583ms","start":"2026-06-30T18:14:43.471097Z","end":"2026-06-30T18:14:44.148391Z","steps":["trace[1690335813] 'agreement among raft nodes before linearized reading' (duration: 677.043847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:44.148506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:14:43.471075Z","time spent":"677.418907ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":7120,"request content":"key:\"/registry/pods/openstack/staffeln-db-init-dn5k5\" "} {"level":"warn","ts":"2026-06-30T18:14:44.149789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.187497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:11 size:100626"} {"level":"warn","ts":"2026-06-30T18:14:44.149811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.273632ms","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-30T18:14:44.149881Z","caller":"traceutil/trace.go:171","msg":"trace[295744532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11015; }","duration":"299.402356ms","start":"2026-06-30T18:14:43.850465Z","end":"2026-06-30T18:14:44.149867Z","steps":["trace[295744532] 'agreement among raft nodes before linearized reading' (duration: 299.171899ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:14:44.149877Z","caller":"traceutil/trace.go:171","msg":"trace[1327710870] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:11; response_revision:11015; }","duration":"627.324122ms","start":"2026-06-30T18:14:43.522532Z","end":"2026-06-30T18:14:44.149856Z","steps":["trace[1327710870] 'agreement among raft nodes before linearized reading' (duration: 626.731866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:14:44.149925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:14:43.522479Z","time spent":"627.434504ms","remote":"127.0.0.1:44626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":11,"response size":100649,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "} {"level":"info","ts":"2026-06-30T18:16:08.89034Z","caller":"traceutil/trace.go:171","msg":"trace[423843933] linearizableReadLoop","detail":"{readStateIndex:12225; appliedIndex:12224; }","duration":"189.697673ms","start":"2026-06-30T18:16:08.700621Z","end":"2026-06-30T18:16:08.890318Z","steps":["trace[423843933] 'read index received' (duration: 20.223571ms)","trace[423843933] 'applied index is now lower than readState.Index' (duration: 169.473302ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:16:08.890356Z","caller":"traceutil/trace.go:171","msg":"trace[78176692] transaction","detail":"{read_only:false; response_revision:11817; number_of_response:1; }","duration":"190.580157ms","start":"2026-06-30T18:16:08.69975Z","end":"2026-06-30T18:16:08.89033Z","steps":["trace[78176692] 'process raft request' (duration: 166.768701ms)","trace[78176692] 'compare' (duration: 23.498558ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:16:08.890431Z","caller":"traceutil/trace.go:171","msg":"trace[1542548990] transaction","detail":"{read_only:false; response_revision:11818; number_of_response:1; }","duration":"189.472098ms","start":"2026-06-30T18:16:08.700884Z","end":"2026-06-30T18:16:08.890356Z","steps":["trace[1542548990] 'process raft request' (duration: 189.361446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:08.890566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.919689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-30T18:16:08.890479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.618513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T18:16:08.890652Z","caller":"traceutil/trace.go:171","msg":"trace[112337791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11818; }","duration":"190.032372ms","start":"2026-06-30T18:16:08.700602Z","end":"2026-06-30T18:16:08.890635Z","steps":["trace[112337791] 'agreement among raft nodes before linearized reading' (duration: 189.802476ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:16:08.89067Z","caller":"traceutil/trace.go:171","msg":"trace[1979598719] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:11818; }","duration":"170.820067ms","start":"2026-06-30T18:16:08.71982Z","end":"2026-06-30T18:16:08.89064Z","steps":["trace[1979598719] 'agreement among raft nodes before linearized reading' (duration: 170.616412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:11.082346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.940494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-30T18:16:11.082482Z","caller":"traceutil/trace.go:171","msg":"trace[1938243601] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:11831; }","duration":"127.109319ms","start":"2026-06-30T18:16:10.955345Z","end":"2026-06-30T18:16:11.082454Z","steps":["trace[1938243601] 'agreement among raft nodes before linearized reading' (duration: 34.25693ms)","trace[1938243601] 'range keys from in-memory index tree' (duration: 92.553992ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:16:43.574834Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305497081688051632,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T18:16:43.636813Z","caller":"traceutil/trace.go:171","msg":"trace[2007981938] transaction","detail":"{read_only:false; response_revision:12051; number_of_response:1; }","duration":"598.119463ms","start":"2026-06-30T18:16:43.038663Z","end":"2026-06-30T18:16:43.636782Z","steps":["trace[2007981938] 'process raft request' (duration: 597.863707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.637046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:16:43.038625Z","time spent":"598.287357ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:16:43.639067Z","caller":"traceutil/trace.go:171","msg":"trace[932019539] linearizableReadLoop","detail":"{readStateIndex:12471; appliedIndex:12466; }","duration":"564.246624ms","start":"2026-06-30T18:16:43.074799Z","end":"2026-06-30T18:16:43.639046Z","steps":["trace[932019539] 'read index received' (duration: 561.77355ms)","trace[932019539] 'applied index is now lower than readState.Index' (duration: 2.472224ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:16:43.639167Z","caller":"traceutil/trace.go:171","msg":"trace[149331447] transaction","detail":"{read_only:false; response_revision:12054; number_of_response:1; }","duration":"168.963858ms","start":"2026-06-30T18:16:43.470195Z","end":"2026-06-30T18:16:43.639159Z","steps":["trace[149331447] 'process raft request' (duration: 168.792304ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:16:43.639148Z","caller":"traceutil/trace.go:171","msg":"trace[2016937073] transaction","detail":"{read_only:false; response_revision:12053; number_of_response:1; }","duration":"169.333128ms","start":"2026-06-30T18:16:43.469788Z","end":"2026-06-30T18:16:43.639121Z","steps":["trace[2016937073] 'process raft request' (duration: 169.166164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.639418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.606224ms","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-30T18:16:43.639482Z","caller":"traceutil/trace.go:171","msg":"trace[1553403467] transaction","detail":"{read_only:false; response_revision:12052; number_of_response:1; }","duration":"348.440585ms","start":"2026-06-30T18:16:43.291024Z","end":"2026-06-30T18:16:43.639465Z","steps":["trace[1553403467] 'process raft request' (duration: 347.806278ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:16:43.639547Z","caller":"traceutil/trace.go:171","msg":"trace[713661971] transaction","detail":"{read_only:false; response_revision:12055; number_of_response:1; }","duration":"126.981866ms","start":"2026-06-30T18:16:43.512554Z","end":"2026-06-30T18:16:43.639535Z","steps":["trace[713661971] 'process raft request' (duration: 126.462162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.639603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:16:43.291003Z","time spent":"348.530517ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:16:43.6395Z","caller":"traceutil/trace.go:171","msg":"trace[1972176550] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12055; }","duration":"564.739247ms","start":"2026-06-30T18:16:43.074744Z","end":"2026-06-30T18:16:43.639483Z","steps":["trace[1972176550] 'agreement among raft nodes before linearized reading' (duration: 564.495611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.639738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:16:43.074731Z","time spent":"564.995513ms","remote":"127.0.0.1:44414","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-30T18:16:43.639825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.64553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-30T18:16:43.639857Z","caller":"traceutil/trace.go:171","msg":"trace[1459632225] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:12055; }","duration":"329.70458ms","start":"2026-06-30T18:16:43.310145Z","end":"2026-06-30T18:16:43.63985Z","steps":["trace[1459632225] 'agreement among raft nodes before linearized reading' (duration: 329.633039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.639877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:16:43.310133Z","time spent":"329.738793ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-ls65g\" "} {"level":"warn","ts":"2026-06-30T18:16:43.640023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.340546ms","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-30T18:16:43.640047Z","caller":"traceutil/trace.go:171","msg":"trace[1320912702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12055; }","duration":"508.396047ms","start":"2026-06-30T18:16:43.131646Z","end":"2026-06-30T18:16:43.640042Z","steps":["trace[1320912702] 'agreement among raft nodes before linearized reading' (duration: 508.337196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.640063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:16:43.131629Z","time spent":"508.430868ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T18:16:43.639455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.358191ms","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-30T18:16:43.640119Z","caller":"traceutil/trace.go:171","msg":"trace[866645379] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12055; }","duration":"564.06871ms","start":"2026-06-30T18:16:43.076034Z","end":"2026-06-30T18:16:43.640103Z","steps":["trace[866645379] 'agreement among raft nodes before linearized reading' (duration: 563.33038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:16:43.640169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:16:43.076011Z","time spent":"564.144261ms","remote":"127.0.0.1:44414","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-30T18:17:38.352804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.624311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-06-30T18:17:38.352874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.286587ms","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-30T18:17:38.352898Z","caller":"traceutil/trace.go:171","msg":"trace[1561289080] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:12395; }","duration":"333.766334ms","start":"2026-06-30T18:17:38.019111Z","end":"2026-06-30T18:17:38.352877Z","steps":["trace[1561289080] 'range keys from in-memory index tree' (duration: 333.447556ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:17:38.352933Z","caller":"traceutil/trace.go:171","msg":"trace[384760674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12395; }","duration":"418.381768ms","start":"2026-06-30T18:17:37.934536Z","end":"2026-06-30T18:17:38.352917Z","steps":["trace[384760674] 'range keys from in-memory index tree' (duration: 418.149703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:17:38.352937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:17:38.019089Z","time spent":"333.839576ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-ls65g\" "} {"level":"warn","ts":"2026-06-30T18:17:38.352903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.531696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-30T18:17:38.353005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:17:37.934518Z","time spent":"418.442921ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T18:17:38.353039Z","caller":"traceutil/trace.go:171","msg":"trace[1840921850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12395; }","duration":"436.735093ms","start":"2026-06-30T18:17:37.916277Z","end":"2026-06-30T18:17:38.353012Z","steps":["trace[1840921850] 'range keys from in-memory index tree' (duration: 436.164007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:17:38.353111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:17:37.916224Z","time spent":"436.871046ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T18:17:38.353157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.769413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-30T18:17:38.353346Z","caller":"traceutil/trace.go:171","msg":"trace[1971248662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12395; }","duration":"437.011149ms","start":"2026-06-30T18:17:37.916306Z","end":"2026-06-30T18:17:38.353317Z","steps":["trace[1971248662] 'range keys from in-memory index tree' (duration: 436.410133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:17:38.353403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:17:37.916281Z","time spent":"437.105411ms","remote":"127.0.0.1:44414","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-30T18:18:21.852784Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10491} {"level":"info","ts":"2026-06-30T18:18:21.929522Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10491,"took":"74.1648ms","hash":2983878214,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":26025984,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-30T18:18:21.929597Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2983878214,"revision":10491,"compact-revision":8265} {"level":"info","ts":"2026-06-30T18:21:52.818635Z","caller":"traceutil/trace.go:171","msg":"trace[963191432] transaction","detail":"{read_only:false; response_revision:14128; number_of_response:1; }","duration":"101.759035ms","start":"2026-06-30T18:21:52.716853Z","end":"2026-06-30T18:21:52.818612Z","steps":["trace[963191432] 'process raft request' (duration: 95.751857ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:21:52.828959Z","caller":"traceutil/trace.go:171","msg":"trace[143618631] transaction","detail":"{read_only:false; response_revision:14129; number_of_response:1; }","duration":"109.484858ms","start":"2026-06-30T18:21:52.71945Z","end":"2026-06-30T18:21:52.828935Z","steps":["trace[143618631] 'process raft request' (duration: 109.327194ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:21:52.829188Z","caller":"traceutil/trace.go:171","msg":"trace[1792056304] transaction","detail":"{read_only:false; response_revision:14131; number_of_response:1; }","duration":"107.189847ms","start":"2026-06-30T18:21:52.721981Z","end":"2026-06-30T18:21:52.829171Z","steps":["trace[1792056304] 'process raft request' (duration: 107.112735ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:21:52.82935Z","caller":"traceutil/trace.go:171","msg":"trace[1682360256] transaction","detail":"{read_only:false; response_revision:14130; number_of_response:1; }","duration":"109.203141ms","start":"2026-06-30T18:21:52.720058Z","end":"2026-06-30T18:21:52.829261Z","steps":["trace[1682360256] 'process raft request' (duration: 108.83613ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:21:54.615409Z","caller":"traceutil/trace.go:171","msg":"trace[159876893] linearizableReadLoop","detail":"{readStateIndex:14631; appliedIndex:14630; }","duration":"101.880988ms","start":"2026-06-30T18:21:54.513493Z","end":"2026-06-30T18:21:54.615374Z","steps":["trace[159876893] 'read index received' (duration: 76.46509ms)","trace[159876893] 'applied index is now lower than readState.Index' (duration: 25.414108ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:21:54.615661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.128714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/placement-ks-endpoints-mtgg8\" ","response":"range_response_count:1 size:15241"} {"level":"info","ts":"2026-06-30T18:21:54.615713Z","caller":"traceutil/trace.go:171","msg":"trace[547259550] range","detail":"{range_begin:/registry/pods/openstack/placement-ks-endpoints-mtgg8; range_end:; response_count:1; response_revision:14143; }","duration":"102.270809ms","start":"2026-06-30T18:21:54.513428Z","end":"2026-06-30T18:21:54.615699Z","steps":["trace[547259550] 'agreement among raft nodes before linearized reading' (duration: 102.080553ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:21:54.61575Z","caller":"traceutil/trace.go:171","msg":"trace[955387265] transaction","detail":"{read_only:false; response_revision:14143; number_of_response:1; }","duration":"159.396549ms","start":"2026-06-30T18:21:54.456321Z","end":"2026-06-30T18:21:54.615717Z","steps":["trace[955387265] 'process raft request' (duration: 133.798556ms)","trace[955387265] 'compare' (duration: 24.851204ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:22:38.962197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.248158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-06-30T18:22:38.962236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.147352ms","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-30T18:22:38.962329Z","caller":"traceutil/trace.go:171","msg":"trace[740947481] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:14420; }","duration":"145.436773ms","start":"2026-06-30T18:22:38.816865Z","end":"2026-06-30T18:22:38.962302Z","steps":["trace[740947481] 'range keys from in-memory index tree' (duration: 144.997101ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:38.962351Z","caller":"traceutil/trace.go:171","msg":"trace[803511020] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14420; }","duration":"135.320447ms","start":"2026-06-30T18:22:38.827004Z","end":"2026-06-30T18:22:38.962324Z","steps":["trace[803511020] 'range keys from in-memory index tree' (duration: 134.974548ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:39.090423Z","caller":"traceutil/trace.go:171","msg":"trace[215757084] linearizableReadLoop","detail":"{readStateIndex:14920; appliedIndex:14919; }","duration":"122.621282ms","start":"2026-06-30T18:22:38.967767Z","end":"2026-06-30T18:22:39.090389Z","steps":["trace[215757084] 'read index received' (duration: 122.559331ms)","trace[215757084] 'applied index is now lower than readState.Index' (duration: 60.731µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:22:39.090565Z","caller":"traceutil/trace.go:171","msg":"trace[200318627] transaction","detail":"{read_only:false; response_revision:14421; number_of_response:1; }","duration":"123.106416ms","start":"2026-06-30T18:22:38.967374Z","end":"2026-06-30T18:22:39.090481Z","steps":["trace[200318627] 'process raft request' (duration: 122.710655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:39.091253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.460856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:62 size:582556"} {"level":"info","ts":"2026-06-30T18:22:39.091341Z","caller":"traceutil/trace.go:171","msg":"trace[1891566457] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:62; response_revision:14421; }","duration":"123.585008ms","start":"2026-06-30T18:22:38.967735Z","end":"2026-06-30T18:22:39.09132Z","steps":["trace[1891566457] 'agreement among raft nodes before linearized reading' (duration: 122.789188ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:39.15823Z","caller":"traceutil/trace.go:171","msg":"trace[1606995530] transaction","detail":"{read_only:false; response_revision:14423; number_of_response:1; }","duration":"139.966939ms","start":"2026-06-30T18:22:39.018198Z","end":"2026-06-30T18:22:39.158165Z","steps":["trace[1606995530] 'process raft request' (duration: 139.631621ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:39.158293Z","caller":"traceutil/trace.go:171","msg":"trace[2069115866] transaction","detail":"{read_only:false; response_revision:14422; number_of_response:1; }","duration":"170.891801ms","start":"2026-06-30T18:22:38.987359Z","end":"2026-06-30T18:22:39.158251Z","steps":["trace[2069115866] 'process raft request' (duration: 170.279005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:39.158251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.624778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-06-30T18:22:39.158385Z","caller":"traceutil/trace.go:171","msg":"trace[1185174237] transaction","detail":"{read_only:false; response_revision:14424; number_of_response:1; }","duration":"108.238905ms","start":"2026-06-30T18:22:39.050082Z","end":"2026-06-30T18:22:39.158321Z","steps":["trace[1185174237] 'process raft request' (duration: 107.827155ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:39.158514Z","caller":"traceutil/trace.go:171","msg":"trace[226589064] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14425; }","duration":"177.986689ms","start":"2026-06-30T18:22:38.980502Z","end":"2026-06-30T18:22:39.158489Z","steps":["trace[226589064] 'agreement among raft nodes before linearized reading' (duration: 177.536357ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:55.317387Z","caller":"traceutil/trace.go:171","msg":"trace[66140875] linearizableReadLoop","detail":"{readStateIndex:15022; appliedIndex:15021; }","duration":"139.617631ms","start":"2026-06-30T18:22:55.177748Z","end":"2026-06-30T18:22:55.317365Z","steps":["trace[66140875] 'read index received' (duration: 139.516917ms)","trace[66140875] 'applied index is now lower than readState.Index' (duration: 99.944µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:22:55.317429Z","caller":"traceutil/trace.go:171","msg":"trace[249804344] transaction","detail":"{read_only:false; response_revision:14517; number_of_response:1; }","duration":"504.10001ms","start":"2026-06-30T18:22:54.813312Z","end":"2026-06-30T18:22:55.317412Z","steps":["trace[249804344] 'process raft request' (duration: 503.926925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:55.317543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.805255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T18:22:55.317543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:22:54.813295Z","time spent":"504.179833ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:22:55.317579Z","caller":"traceutil/trace.go:171","msg":"trace[465576600] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:14517; }","duration":"139.894597ms","start":"2026-06-30T18:22:55.177673Z","end":"2026-06-30T18:22:55.317567Z","steps":["trace[465576600] 'agreement among raft nodes before linearized reading' (duration: 139.803075ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:22:55.319533Z","caller":"traceutil/trace.go:171","msg":"trace[1828244922] transaction","detail":"{read_only:false; response_revision:14518; number_of_response:1; }","duration":"100.138382ms","start":"2026-06-30T18:22:55.219366Z","end":"2026-06-30T18:22:55.319504Z","steps":["trace[1828244922] 'process raft request' (duration: 99.945626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:55.319838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.862976ms","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-30T18:22:55.319894Z","caller":"traceutil/trace.go:171","msg":"trace[226470723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14521; }","duration":"139.942298ms","start":"2026-06-30T18:22:55.179936Z","end":"2026-06-30T18:22:55.319879Z","steps":["trace[226470723] 'agreement among raft nodes before linearized reading' (duration: 139.774084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:55.320014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.378004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-30T18:22:55.32008Z","caller":"traceutil/trace.go:171","msg":"trace[287113423] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:14521; }","duration":"101.500327ms","start":"2026-06-30T18:22:55.218565Z","end":"2026-06-30T18:22:55.320065Z","steps":["trace[287113423] 'agreement among raft nodes before linearized reading' (duration: 101.290382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:55.320058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.169993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:22:55.320236Z","caller":"traceutil/trace.go:171","msg":"trace[18303206] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:14521; }","duration":"135.39711ms","start":"2026-06-30T18:22:55.184814Z","end":"2026-06-30T18:22:55.320211Z","steps":["trace[18303206] 'agreement among raft nodes before linearized reading' (duration: 135.151933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:56.958128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.039745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:22:56.958206Z","caller":"traceutil/trace.go:171","msg":"trace[1183825579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14531; }","duration":"287.173008ms","start":"2026-06-30T18:22:56.671014Z","end":"2026-06-30T18:22:56.958187Z","steps":["trace[1183825579] 'range keys from in-memory index tree' (duration: 286.976653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:22:56.958603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.385753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:22:56.958837Z","caller":"traceutil/trace.go:171","msg":"trace[849559170] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:14531; }","duration":"158.68318ms","start":"2026-06-30T18:22:56.80012Z","end":"2026-06-30T18:22:56.958803Z","steps":["trace[849559170] 'count revisions from in-memory index tree' (duration: 158.233739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:23:17.045848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.910639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f266bc95-9d8e-4156-871a-477514dba337\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-30T18:23:17.045926Z","caller":"traceutil/trace.go:171","msg":"trace[437159037] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f266bc95-9d8e-4156-871a-477514dba337; range_end:; response_count:1; response_revision:14828; }","duration":"169.064913ms","start":"2026-06-30T18:23:16.876846Z","end":"2026-06-30T18:23:17.045911Z","steps":["trace[437159037] 'range keys from in-memory index tree' (duration: 168.701924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:23:17.046184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.056864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-06-30T18:23:17.046556Z","caller":"traceutil/trace.go:171","msg":"trace[47501851] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:14828; }","duration":"185.439434ms","start":"2026-06-30T18:23:16.861091Z","end":"2026-06-30T18:23:17.046531Z","steps":["trace[47501851] 'range keys from in-memory index tree' (duration: 184.860539ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.656024Z","caller":"traceutil/trace.go:171","msg":"trace[1325141221] transaction","detail":"{read_only:false; response_revision:14829; number_of_response:1; }","duration":"260.009775ms","start":"2026-06-30T18:23:17.39599Z","end":"2026-06-30T18:23:17.656Z","steps":["trace[1325141221] 'process raft request' (duration: 259.85002ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.667486Z","caller":"traceutil/trace.go:171","msg":"trace[2048770169] transaction","detail":"{read_only:false; response_revision:14830; number_of_response:1; }","duration":"268.802665ms","start":"2026-06-30T18:23:17.398666Z","end":"2026-06-30T18:23:17.667469Z","steps":["trace[2048770169] 'process raft request' (duration: 268.549579ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.667502Z","caller":"traceutil/trace.go:171","msg":"trace[722062274] transaction","detail":"{read_only:false; response_revision:14831; number_of_response:1; }","duration":"263.943927ms","start":"2026-06-30T18:23:17.403526Z","end":"2026-06-30T18:23:17.66747Z","steps":["trace[722062274] 'process raft request' (duration: 263.831254ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.667623Z","caller":"traceutil/trace.go:171","msg":"trace[648362993] linearizableReadLoop","detail":"{readStateIndex:15351; appliedIndex:15347; }","duration":"259.446599ms","start":"2026-06-30T18:23:17.408144Z","end":"2026-06-30T18:23:17.66759Z","steps":["trace[648362993] 'read index received' (duration: 247.718641ms)","trace[648362993] 'applied index is now lower than readState.Index' (duration: 11.725908ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:23:17.667857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.704166ms","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-30T18:23:17.6679Z","caller":"traceutil/trace.go:171","msg":"trace[1347163541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14832; }","duration":"259.787339ms","start":"2026-06-30T18:23:17.408104Z","end":"2026-06-30T18:23:17.667891Z","steps":["trace[1347163541] 'agreement among raft nodes before linearized reading' (duration: 259.650654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:23:17.667893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.152918ms","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-30T18:23:17.667863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.917322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f266bc95-9d8e-4156-871a-477514dba337\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-30T18:23:17.667937Z","caller":"traceutil/trace.go:171","msg":"trace[2010613718] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14832; }","duration":"244.24686ms","start":"2026-06-30T18:23:17.423675Z","end":"2026-06-30T18:23:17.667922Z","steps":["trace[2010613718] 'agreement among raft nodes before linearized reading' (duration: 244.085855ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.667939Z","caller":"traceutil/trace.go:171","msg":"trace[475308695] transaction","detail":"{read_only:false; response_revision:14832; number_of_response:1; }","duration":"262.50497ms","start":"2026-06-30T18:23:17.405423Z","end":"2026-06-30T18:23:17.667928Z","steps":["trace[475308695] 'process raft request' (duration: 261.972485ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.667966Z","caller":"traceutil/trace.go:171","msg":"trace[1448070182] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f266bc95-9d8e-4156-871a-477514dba337; range_end:; response_count:1; response_revision:14832; }","duration":"139.042025ms","start":"2026-06-30T18:23:17.528906Z","end":"2026-06-30T18:23:17.667948Z","steps":["trace[1448070182] 'agreement among raft nodes before linearized reading' (duration: 138.88004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:23:17.668103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.84352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ls65g\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-30T18:23:17.668129Z","caller":"traceutil/trace.go:171","msg":"trace[2093190072] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ls65g; range_end:; response_count:1; response_revision:14832; }","duration":"154.915521ms","start":"2026-06-30T18:23:17.513208Z","end":"2026-06-30T18:23:17.668123Z","steps":["trace[2093190072] 'agreement among raft nodes before linearized reading' (duration: 154.84226ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.860851Z","caller":"traceutil/trace.go:171","msg":"trace[2011442475] linearizableReadLoop","detail":"{readStateIndex:15353; appliedIndex:15351; }","duration":"186.735878ms","start":"2026-06-30T18:23:17.674084Z","end":"2026-06-30T18:23:17.86082Z","steps":["trace[2011442475] 'read index received' (duration: 1.757816ms)","trace[2011442475] 'applied index is now lower than readState.Index' (duration: 184.976412ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:23:17.860902Z","caller":"traceutil/trace.go:171","msg":"trace[1184155829] transaction","detail":"{read_only:false; response_revision:14834; number_of_response:1; }","duration":"187.470808ms","start":"2026-06-30T18:23:17.673396Z","end":"2026-06-30T18:23:17.860867Z","steps":["trace[1184155829] 'process raft request' (duration: 187.140379ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:17.861034Z","caller":"traceutil/trace.go:171","msg":"trace[1040359648] transaction","detail":"{read_only:false; response_revision:14835; number_of_response:1; }","duration":"185.993499ms","start":"2026-06-30T18:23:17.675026Z","end":"2026-06-30T18:23:17.86102Z","steps":["trace[1040359648] 'process raft request' (duration: 185.716171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:23:17.861831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.719286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:66 size:630554"} {"level":"info","ts":"2026-06-30T18:23:17.861923Z","caller":"traceutil/trace.go:171","msg":"trace[616259749] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:66; response_revision:14835; }","duration":"187.856038ms","start":"2026-06-30T18:23:17.674052Z","end":"2026-06-30T18:23:17.861908Z","steps":["trace[616259749] 'agreement among raft nodes before linearized reading' (duration: 186.883942ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:23:21.860151Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12710} {"level":"info","ts":"2026-06-30T18:23:21.937307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12710,"took":"74.55871ms","hash":3876830570,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":28016640,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-30T18:23:21.937385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3876830570,"revision":12710,"compact-revision":10491} {"level":"info","ts":"2026-06-30T18:24:28.033977Z","caller":"traceutil/trace.go:171","msg":"trace[436470513] transaction","detail":"{read_only:false; response_revision:15558; number_of_response:1; }","duration":"110.012682ms","start":"2026-06-30T18:24:27.923941Z","end":"2026-06-30T18:24:28.033953Z","steps":["trace[436470513] 'process raft request' (duration: 109.878779ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:24:28.03694Z","caller":"traceutil/trace.go:171","msg":"trace[551004505] transaction","detail":"{read_only:false; response_revision:15559; number_of_response:1; }","duration":"109.108028ms","start":"2026-06-30T18:24:27.927808Z","end":"2026-06-30T18:24:28.036916Z","steps":["trace[551004505] 'process raft request' (duration: 108.935784ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:24:28.037117Z","caller":"traceutil/trace.go:171","msg":"trace[875229508] linearizableReadLoop","detail":"{readStateIndex:16101; appliedIndex:16097; }","duration":"107.109766ms","start":"2026-06-30T18:24:27.929988Z","end":"2026-06-30T18:24:28.037097Z","steps":["trace[875229508] 'read index received' (duration: 103.873961ms)","trace[875229508] 'applied index is now lower than readState.Index' (duration: 3.234834ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:24:28.037196Z","caller":"traceutil/trace.go:171","msg":"trace[1395011969] transaction","detail":"{read_only:false; response_revision:15560; number_of_response:1; }","duration":"108.983015ms","start":"2026-06-30T18:24:27.928145Z","end":"2026-06-30T18:24:28.037128Z","steps":["trace[1395011969] 'process raft request' (duration: 108.727987ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:24:28.037195Z","caller":"traceutil/trace.go:171","msg":"trace[1913091274] transaction","detail":"{read_only:false; response_revision:15561; number_of_response:1; }","duration":"109.001896ms","start":"2026-06-30T18:24:27.928164Z","end":"2026-06-30T18:24:28.037166Z","steps":["trace[1913091274] 'process raft request' (duration: 108.870181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:28.037415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.411714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-rhjvm\" ","response":"range_response_count:1 size:22099"} {"level":"info","ts":"2026-06-30T18:24:28.037733Z","caller":"traceutil/trace.go:171","msg":"trace[459912164] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-rhjvm; range_end:; response_count:1; response_revision:15561; }","duration":"107.778913ms","start":"2026-06-30T18:24:27.929941Z","end":"2026-06-30T18:24:28.03772Z","steps":["trace[459912164] 'agreement among raft nodes before linearized reading' (duration: 107.312862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:34.845452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.040023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T18:24:34.845543Z","caller":"traceutil/trace.go:171","msg":"trace[592689887] linearizableReadLoop","detail":"{readStateIndex:16139; appliedIndex:16138; }","duration":"277.284559ms","start":"2026-06-30T18:24:34.568244Z","end":"2026-06-30T18:24:34.845528Z","steps":["trace[592689887] 'read index received' (duration: 119.051379ms)","trace[592689887] 'applied index is now lower than readState.Index' (duration: 158.23202ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:24:34.845606Z","caller":"traceutil/trace.go:171","msg":"trace[1227540283] transaction","detail":"{read_only:false; response_revision:15597; number_of_response:1; }","duration":"306.013353ms","start":"2026-06-30T18:24:34.539582Z","end":"2026-06-30T18:24:34.845596Z","steps":["trace[1227540283] 'process raft request' (duration: 147.768534ms)","trace[1227540283] 'compare' (duration: 157.846148ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:24:34.845645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:24:34.539555Z","time spent":"306.070726ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:24:34.845774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.531746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-06-30T18:24:34.845795Z","caller":"traceutil/trace.go:171","msg":"trace[124799454] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:15597; }","duration":"277.596077ms","start":"2026-06-30T18:24:34.568193Z","end":"2026-06-30T18:24:34.845789Z","steps":["trace[124799454] 'agreement among raft nodes before linearized reading' (duration: 277.507435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:34.845867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.02067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T18:24:34.845887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.410113ms","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-30T18:24:34.845957Z","caller":"traceutil/trace.go:171","msg":"trace[1140797234] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15597; }","duration":"274.507305ms","start":"2026-06-30T18:24:34.571434Z","end":"2026-06-30T18:24:34.845941Z","steps":["trace[1140797234] 'agreement among raft nodes before linearized reading' (duration: 274.31856ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:24:34.845956Z","caller":"traceutil/trace.go:171","msg":"trace[1035319687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15597; }","duration":"175.140423ms","start":"2026-06-30T18:24:34.670795Z","end":"2026-06-30T18:24:34.845935Z","steps":["trace[1035319687] 'agreement among raft nodes before linearized reading' (duration: 174.988619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:34.845909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.774488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:24:34.846114Z","caller":"traceutil/trace.go:171","msg":"trace[74961656] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:15597; }","duration":"190.038135ms","start":"2026-06-30T18:24:34.656054Z","end":"2026-06-30T18:24:34.846092Z","steps":["trace[74961656] 'agreement among raft nodes before linearized reading' (duration: 189.739317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:35.141391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.38736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-06-30T18:24:35.141427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.647346ms","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-30T18:24:35.141463Z","caller":"traceutil/trace.go:171","msg":"trace[1155188658] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:15597; }","duration":"191.512874ms","start":"2026-06-30T18:24:34.949933Z","end":"2026-06-30T18:24:35.141446Z","steps":["trace[1155188658] 'range keys from in-memory index tree' (duration: 191.255387ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:24:35.141515Z","caller":"traceutil/trace.go:171","msg":"trace[2077194169] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15597; }","duration":"189.766559ms","start":"2026-06-30T18:24:34.951719Z","end":"2026-06-30T18:24:35.141486Z","steps":["trace[2077194169] 'range keys from in-memory index tree' (duration: 189.581074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:35.141527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.83582ms","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-30T18:24:35.141636Z","caller":"traceutil/trace.go:171","msg":"trace[187087773] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15597; }","duration":"189.961333ms","start":"2026-06-30T18:24:34.951649Z","end":"2026-06-30T18:24:35.14161Z","steps":["trace[187087773] 'range keys from in-memory index tree' (duration: 189.729758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:35.141633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.188834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-30T18:24:35.141699Z","caller":"traceutil/trace.go:171","msg":"trace[1980486846] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15597; }","duration":"186.293358ms","start":"2026-06-30T18:24:34.955389Z","end":"2026-06-30T18:24:35.141682Z","steps":["trace[1980486846] 'range keys from in-memory index tree' (duration: 186.03108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:24:35.141676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.04579ms","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-30T18:24:35.141812Z","caller":"traceutil/trace.go:171","msg":"trace[1612567760] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15597; }","duration":"189.189525ms","start":"2026-06-30T18:24:34.952569Z","end":"2026-06-30T18:24:35.141759Z","steps":["trace[1612567760] 'range keys from in-memory index tree' (duration: 188.942036ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:28:21.866925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14868} {"level":"info","ts":"2026-06-30T18:28:21.957943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14868,"took":"88.108226ms","hash":3731025857,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":30343168,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-30T18:28:21.95805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3731025857,"revision":14868,"compact-revision":12710} {"level":"info","ts":"2026-06-30T18:33:21.873262Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17327} {"level":"info","ts":"2026-06-30T18:33:21.966837Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17327,"took":"90.335482ms","hash":2967689883,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":29679616,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-30T18:33:21.966902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2967689883,"revision":17327,"compact-revision":14868} {"level":"info","ts":"2026-06-30T18:34:05.324929Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T18:34:05.333034Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-30T18:34:05.333263Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-30T18:38:21.880991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19098} {"level":"info","ts":"2026-06-30T18:38:21.966978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19098,"took":"83.350839ms","hash":81501637,"current-db-size-bytes":58540032,"current-db-size":"58 MB","current-db-size-in-use-bytes":23793664,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-30T18:38:21.967043Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":81501637,"revision":19098,"compact-revision":17327}