{"level":"warn","ts":"2026-06-18T15:07:03.491762Z","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-18T15:07:03.491862Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-18T15:07:03.491934Z","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-18T15:07:03.491943Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-06-18T15:07:03.491963Z","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-18T15:07:03.494953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-06-18T15:07:03.495242Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-18T15:07:03.498367Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.644025ms"} {"level":"info","ts":"2026-06-18T15:07:03.503509Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-06-18T15:07:03.503611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-06-18T15:07:03.503653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-06-18T15:07:03.503681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-18T15:07:03.503712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.503795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-06-18T15:07:03.508611Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-18T15:07:03.511404Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-18T15:07:03.512534Z","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-18T15:07:03.514634Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-18T15:07:03.514973Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-18T15:07:03.515226Z","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-18T15:07:03.515377Z","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-18T15:07:03.515391Z","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-18T15:07:03.515909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-06-18T15:07:03.516041Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-06-18T15:07:03.517953Z","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-18T15:07:03.518248Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-18T15:07:03.518212Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-06-18T15:07:03.518287Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-18T15:07:03.518328Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-06-18T15:07:03.704086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.704152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.704202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.704225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.704242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.704265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.704282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.705513Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.70647Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-06-18T15:07:03.706547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T15:07:03.7065Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T15:07:03.707005Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-18T15:07:03.707052Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-18T15:07:03.70719Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.70738Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.707431Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.710334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-06-18T15:07:03.710372Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-18T15:07:49.138286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.726035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:07:49.138455Z","caller":"traceutil/trace.go:171","msg":"trace[1831697634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"182.974741ms","start":"2026-06-18T15:07:48.955455Z","end":"2026-06-18T15:07:49.138429Z","steps":["trace[1831697634] 'range keys from in-memory index tree' (duration: 182.602543ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:49.149593Z","caller":"traceutil/trace.go:171","msg":"trace[1268841569] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"133.260509ms","start":"2026-06-18T15:07:49.016289Z","end":"2026-06-18T15:07:49.14955Z","steps":["trace[1268841569] 'process raft request' (duration: 132.615463ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:05.74103Z","caller":"traceutil/trace.go:171","msg":"trace[1476465813] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"221.584693ms","start":"2026-06-18T15:08:05.51942Z","end":"2026-06-18T15:08:05.741005Z","steps":["trace[1476465813] 'process raft request' (duration: 221.433768ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:34.032988Z","caller":"traceutil/trace.go:171","msg":"trace[234033018] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"122.115138ms","start":"2026-06-18T15:08:33.910835Z","end":"2026-06-18T15:08:34.03295Z","steps":["trace[234033018] 'process raft request' (duration: 121.859022ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:52.420757Z","caller":"traceutil/trace.go:171","msg":"trace[1979505057] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"103.247251ms","start":"2026-06-18T15:08:52.317485Z","end":"2026-06-18T15:08:52.420732Z","steps":["trace[1979505057] 'process raft request' (duration: 103.129828ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:54.388012Z","caller":"traceutil/trace.go:171","msg":"trace[1357532836] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"101.94902ms","start":"2026-06-18T15:08:54.28603Z","end":"2026-06-18T15:08:54.387979Z","steps":["trace[1357532836] 'process raft request' (duration: 89.669712ms)","trace[1357532836] 'compare' (duration: 12.166295ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:08:56.499776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.058928ms","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-18T15:08:56.499882Z","caller":"traceutil/trace.go:171","msg":"trace[1509675381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1441; }","duration":"108.222272ms","start":"2026-06-18T15:08:56.39164Z","end":"2026-06-18T15:08:56.499862Z","steps":["trace[1509675381] 'range keys from in-memory index tree' (duration: 107.803372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:10:05.493008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.528479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-18T15:10:05.49314Z","caller":"traceutil/trace.go:171","msg":"trace[973081507] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2085; }","duration":"145.716013ms","start":"2026-06-18T15:10:05.347404Z","end":"2026-06-18T15:10:05.49312Z","steps":["trace[973081507] 'range keys from in-memory index tree' (duration: 145.416106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:10:05.493136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.368335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:110087"} {"level":"info","ts":"2026-06-18T15:10:05.493229Z","caller":"traceutil/trace.go:171","msg":"trace[1893686804] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2085; }","duration":"145.486257ms","start":"2026-06-18T15:10:05.347719Z","end":"2026-06-18T15:10:05.493205Z","steps":["trace[1893686804] 'range keys from in-memory index tree' (duration: 145.12987ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:38.820537Z","caller":"traceutil/trace.go:171","msg":"trace[657178350] transaction","detail":"{read_only:false; response_revision:2275; number_of_response:1; }","duration":"106.862119ms","start":"2026-06-18T15:10:38.713628Z","end":"2026-06-18T15:10:38.82049Z","steps":["trace[657178350] 'process raft request' (duration: 106.556962ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:44.134936Z","caller":"traceutil/trace.go:171","msg":"trace[1526452055] transaction","detail":"{read_only:false; response_revision:2306; number_of_response:1; }","duration":"132.950696ms","start":"2026-06-18T15:10:44.001953Z","end":"2026-06-18T15:10:44.134903Z","steps":["trace[1526452055] 'process raft request' (duration: 132.745152ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:44.436102Z","caller":"traceutil/trace.go:171","msg":"trace[1104674362] transaction","detail":"{read_only:false; response_revision:2308; number_of_response:1; }","duration":"154.924754ms","start":"2026-06-18T15:10:44.281145Z","end":"2026-06-18T15:10:44.43607Z","steps":["trace[1104674362] 'process raft request' (duration: 150.164741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:10:44.917844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.830958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:10:44.917982Z","caller":"traceutil/trace.go:171","msg":"trace[994719914] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2308; }","duration":"216.037953ms","start":"2026-06-18T15:10:44.701916Z","end":"2026-06-18T15:10:44.917954Z","steps":["trace[994719914] 'count revisions from in-memory index tree' (duration: 215.721786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:10:44.918416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.965312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:10:44.918598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.651911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ba357d3fc944cd\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-18T15:10:44.918787Z","caller":"traceutil/trace.go:171","msg":"trace[1207270014] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ba357d3fc944cd; range_end:; response_count:1; response_revision:2308; }","duration":"308.873336ms","start":"2026-06-18T15:10:44.609881Z","end":"2026-06-18T15:10:44.918755Z","steps":["trace[1207270014] 'range keys from in-memory index tree' (duration: 308.108678ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:44.918702Z","caller":"traceutil/trace.go:171","msg":"trace[1280415955] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2308; }","duration":"253.355331ms","start":"2026-06-18T15:10:44.665316Z","end":"2026-06-18T15:10:44.918671Z","steps":["trace[1280415955] 'count revisions from in-memory index tree' (duration: 252.84226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:10:44.918868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:10:44.609861Z","time spent":"308.989449ms","remote":"127.0.0.1:49524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":870,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ba357d3fc944cd\" "} {"level":"warn","ts":"2026-06-18T15:11:47.575724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.006306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:11:47.575827Z","caller":"traceutil/trace.go:171","msg":"trace[1561965122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2850; }","duration":"129.15105ms","start":"2026-06-18T15:11:47.446649Z","end":"2026-06-18T15:11:47.575801Z","steps":["trace[1561965122] 'range keys from in-memory index tree' (duration: 128.902894ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:11:47.575991Z","caller":"traceutil/trace.go:171","msg":"trace[908554624] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"105.951631ms","start":"2026-06-18T15:11:47.470008Z","end":"2026-06-18T15:11:47.57596Z","steps":["trace[908554624] 'process raft request' (duration: 55.297932ms)","trace[908554624] 'compare' (duration: 50.524696ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:11:47.881084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.802324ms","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-18T15:11:47.881175Z","caller":"traceutil/trace.go:171","msg":"trace[354139041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2852; }","duration":"114.962298ms","start":"2026-06-18T15:11:47.766194Z","end":"2026-06-18T15:11:47.881156Z","steps":["trace[354139041] 'range keys from in-memory index tree' (duration: 114.607729ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:11:48.090237Z","caller":"traceutil/trace.go:171","msg":"trace[562950578] linearizableReadLoop","detail":"{readStateIndex:2962; appliedIndex:2961; }","duration":"183.630832ms","start":"2026-06-18T15:11:47.906581Z","end":"2026-06-18T15:11:48.090212Z","steps":["trace[562950578] 'read index received' (duration: 183.400537ms)","trace[562950578] 'applied index is now lower than readState.Index' (duration: 229.085µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:11:48.090293Z","caller":"traceutil/trace.go:171","msg":"trace[650905318] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"204.866223ms","start":"2026-06-18T15:11:47.885391Z","end":"2026-06-18T15:11:48.090257Z","steps":["trace[650905318] 'process raft request' (duration: 204.669068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:11:48.09039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.182835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:11:48.090431Z","caller":"traceutil/trace.go:171","msg":"trace[784517576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2853; }","duration":"135.272957ms","start":"2026-06-18T15:11:47.955145Z","end":"2026-06-18T15:11:48.090418Z","steps":["trace[784517576] 'agreement among raft nodes before linearized reading' (duration: 135.197066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:11:48.090434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.819517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:11:48.090525Z","caller":"traceutil/trace.go:171","msg":"trace[565113833] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2853; }","duration":"183.958329ms","start":"2026-06-18T15:11:47.906547Z","end":"2026-06-18T15:11:48.090505Z","steps":["trace[565113833] 'agreement among raft nodes before linearized reading' (duration: 183.780275ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:11:53.50364Z","caller":"traceutil/trace.go:171","msg":"trace[888881417] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"145.915803ms","start":"2026-06-18T15:11:53.357692Z","end":"2026-06-18T15:11:53.503607Z","steps":["trace[888881417] 'process raft request' (duration: 64.81058ms)","trace[888881417] 'compare' (duration: 80.636722ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:11:53.719271Z","caller":"traceutil/trace.go:171","msg":"trace[1884707243] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"212.301622ms","start":"2026-06-18T15:11:53.506935Z","end":"2026-06-18T15:11:53.719237Z","steps":["trace[1884707243] 'process raft request' (duration: 138.618788ms)","trace[1884707243] 'compare' (duration: 73.264904ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:11:53.719584Z","caller":"traceutil/trace.go:171","msg":"trace[1129716116] transaction","detail":"{read_only:false; response_revision:2883; number_of_response:1; }","duration":"123.181666ms","start":"2026-06-18T15:11:53.596354Z","end":"2026-06-18T15:11:53.719536Z","steps":["trace[1129716116] 'process raft request' (duration: 122.784307ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:11:53.719985Z","caller":"traceutil/trace.go:171","msg":"trace[1274872781] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"112.887938ms","start":"2026-06-18T15:11:53.607069Z","end":"2026-06-18T15:11:53.719956Z","steps":["trace[1274872781] 'process raft request' (duration: 112.326095ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:16:02.528687Z","caller":"traceutil/trace.go:171","msg":"trace[182218437] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"100.273409ms","start":"2026-06-18T15:16:02.428385Z","end":"2026-06-18T15:16:02.528659Z","steps":["trace[182218437] 'process raft request' (duration: 100.076925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:16:08.25615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.64035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:16:08.256255Z","caller":"traceutil/trace.go:171","msg":"trace[1818280925] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5159; }","duration":"265.794984ms","start":"2026-06-18T15:16:07.990439Z","end":"2026-06-18T15:16:08.256234Z","steps":["trace[1818280925] 'count revisions from in-memory index tree' (duration: 265.559968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:16:08.256201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.133906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"warn","ts":"2026-06-18T15:16:08.256343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.429257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e61ab85-bd43-416b-aea9-7eaefe069d28\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-06-18T15:16:08.256414Z","caller":"traceutil/trace.go:171","msg":"trace[2587010] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e61ab85-bd43-416b-aea9-7eaefe069d28; range_end:; response_count:1; response_revision:5159; }","duration":"171.55923ms","start":"2026-06-18T15:16:08.084836Z","end":"2026-06-18T15:16:08.256395Z","steps":["trace[2587010] 'range keys from in-memory index tree' (duration: 171.243783ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:16:08.256388Z","caller":"traceutil/trace.go:171","msg":"trace[952475673] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5159; }","duration":"233.334321ms","start":"2026-06-18T15:16:08.023012Z","end":"2026-06-18T15:16:08.256347Z","steps":["trace[952475673] 'range keys from in-memory index tree' (duration: 232.979593ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:16:16.895153Z","caller":"traceutil/trace.go:171","msg":"trace[672972884] linearizableReadLoop","detail":"{readStateIndex:5531; appliedIndex:5527; }","duration":"159.034216ms","start":"2026-06-18T15:16:16.736089Z","end":"2026-06-18T15:16:16.895124Z","steps":["trace[672972884] 'read index received' (duration: 9.945159ms)","trace[672972884] 'applied index is now lower than readState.Index' (duration: 149.088227ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:16:16.8953Z","caller":"traceutil/trace.go:171","msg":"trace[862072354] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"161.582448ms","start":"2026-06-18T15:16:16.733706Z","end":"2026-06-18T15:16:16.895289Z","steps":["trace[862072354] 'process raft request' (duration: 161.311352ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:16:16.895528Z","caller":"traceutil/trace.go:171","msg":"trace[1233808556] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"161.946168ms","start":"2026-06-18T15:16:16.733557Z","end":"2026-06-18T15:16:16.895503Z","steps":["trace[1233808556] 'process raft request' (duration: 127.549118ms)","trace[1233808556] 'compare' (duration: 33.713803ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:16:16.895596Z","caller":"traceutil/trace.go:171","msg":"trace[1420490938] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"161.144549ms","start":"2026-06-18T15:16:16.734438Z","end":"2026-06-18T15:16:16.895582Z","steps":["trace[1420490938] 'process raft request' (duration: 160.641686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:16:16.895853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.739135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-18T15:16:16.895899Z","caller":"traceutil/trace.go:171","msg":"trace[697666744] 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:5330; }","duration":"159.838206ms","start":"2026-06-18T15:16:16.736047Z","end":"2026-06-18T15:16:16.895885Z","steps":["trace[697666744] 'agreement among raft nodes before linearized reading' (duration: 159.655832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:16:16.910704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.888557ms","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-18T15:16:16.910773Z","caller":"traceutil/trace.go:171","msg":"trace[1223693905] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5332; }","duration":"150.00486ms","start":"2026-06-18T15:16:16.760751Z","end":"2026-06-18T15:16:16.910756Z","steps":["trace[1223693905] 'agreement among raft nodes before linearized reading' (duration: 149.792755ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:16:21.334706Z","caller":"traceutil/trace.go:171","msg":"trace[419755117] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"163.71431ms","start":"2026-06-18T15:16:21.170971Z","end":"2026-06-18T15:16:21.334685Z","steps":["trace[419755117] 'process raft request' (duration: 163.547306ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:04.080973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2940} {"level":"info","ts":"2026-06-18T15:17:04.153822Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2940,"took":"71.511005ms","hash":2251645008,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":32727040,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-18T15:17:04.153876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2251645008,"revision":2940,"compact-revision":-1} {"level":"warn","ts":"2026-06-18T15:17:22.45032Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313096638084417090,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-18T15:17:22.635245Z","caller":"traceutil/trace.go:171","msg":"trace[1396702007] transaction","detail":"{read_only:false; response_revision:6071; number_of_response:1; }","duration":"705.166318ms","start":"2026-06-18T15:17:21.930053Z","end":"2026-06-18T15:17:22.635219Z","steps":["trace[1396702007] 'process raft request' (duration: 705.033415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:22.63626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:21.930021Z","time spent":"705.293061ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:22.906407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.087438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:17:22.906762Z","caller":"traceutil/trace.go:171","msg":"trace[2097216078] transaction","detail":"{read_only:false; response_revision:6072; number_of_response:1; }","duration":"735.719956ms","start":"2026-06-18T15:17:22.171006Z","end":"2026-06-18T15:17:22.906726Z","steps":["trace[2097216078] 'process raft request' (duration: 574.131927ms)","trace[2097216078] 'compare' (duration: 161.000495ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:22.906995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:22.170976Z","time spent":"735.856349ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:22.990045Z","caller":"traceutil/trace.go:171","msg":"trace[265472529] transaction","detail":"{read_only:false; response_revision:6073; number_of_response:1; }","duration":"656.663778ms","start":"2026-06-18T15:17:22.333352Z","end":"2026-06-18T15:17:22.990016Z","steps":["trace[265472529] 'process raft request' (duration: 656.358151ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:22.99004Z","caller":"traceutil/trace.go:171","msg":"trace[827651338] transaction","detail":"{read_only:false; response_revision:6074; number_of_response:1; }","duration":"292.851467ms","start":"2026-06-18T15:17:22.697163Z","end":"2026-06-18T15:17:22.990014Z","steps":["trace[827651338] 'process raft request' (duration: 292.793076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:22.990275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040481281s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-06-18T15:17:22.990347Z","caller":"traceutil/trace.go:171","msg":"trace[1393717251] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:6074; }","duration":"1.040585443s","start":"2026-06-18T15:17:21.949742Z","end":"2026-06-18T15:17:22.990327Z","steps":["trace[1393717251] 'agreement among raft nodes before linearized reading' (duration: 1.040359988s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:22.9904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:21.949721Z","time spent":"1.040667246s","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3708,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-06-18T15:17:22.990273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:22.333324Z","time spent":"656.833851ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:22.990045Z","caller":"traceutil/trace.go:171","msg":"trace[1149199651] linearizableReadLoop","detail":"{readStateIndex:6295; appliedIndex:6291; }","duration":"1.040213835s","start":"2026-06-18T15:17:21.949794Z","end":"2026-06-18T15:17:22.990008Z","steps":["trace[1149199651] 'read index received' (duration: 685.375981ms)","trace[1149199651] 'applied index is now lower than readState.Index' (duration: 354.834204ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:22.99063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.468233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:22.990634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037795086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:22.990652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.101061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6157"} {"level":"info","ts":"2026-06-18T15:17:22.990697Z","caller":"traceutil/trace.go:171","msg":"trace[1580271465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6074; }","duration":"1.037904199s","start":"2026-06-18T15:17:21.952778Z","end":"2026-06-18T15:17:22.990682Z","steps":["trace[1580271465] 'agreement among raft nodes before linearized reading' (duration: 1.037787496s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:22.990738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:21.952756Z","time spent":"1.037973491s","remote":"127.0.0.1:49456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-18T15:17:22.990717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.528455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:17:22.990795Z","caller":"traceutil/trace.go:171","msg":"trace[385255441] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6074; }","duration":"298.662068ms","start":"2026-06-18T15:17:22.692115Z","end":"2026-06-18T15:17:22.990777Z","steps":["trace[385255441] 'agreement among raft nodes before linearized reading' (duration: 298.512934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:22.990782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.287297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:22.990778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.385467ms","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":"info","ts":"2026-06-18T15:17:22.990868Z","caller":"traceutil/trace.go:171","msg":"trace[1576437622] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:6074; }","duration":"934.433872ms","start":"2026-06-18T15:17:22.056414Z","end":"2026-06-18T15:17:22.990848Z","steps":["trace[1576437622] 'agreement among raft nodes before linearized reading' (duration: 934.286878ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:22.990902Z","caller":"traceutil/trace.go:171","msg":"trace[686336971] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:6074; }","duration":"684.557821ms","start":"2026-06-18T15:17:22.306328Z","end":"2026-06-18T15:17:22.990886Z","steps":["trace[686336971] 'agreement among raft nodes before linearized reading' (duration: 684.345676ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:22.990919Z","caller":"traceutil/trace.go:171","msg":"trace[1658877365] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6074; }","duration":"298.570135ms","start":"2026-06-18T15:17:22.692098Z","end":"2026-06-18T15:17:22.990668Z","steps":["trace[1658877365] 'agreement among raft nodes before linearized reading' (duration: 298.478873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:22.99093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:22.056392Z","time spent":"934.521673ms","remote":"127.0.0.1:41032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-06-18T15:17:22.991011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:22.306301Z","time spent":"684.670644ms","remote":"127.0.0.1:45000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":31,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"info","ts":"2026-06-18T15:17:22.991038Z","caller":"traceutil/trace.go:171","msg":"trace[471100140] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:6074; }","duration":"297.448259ms","start":"2026-06-18T15:17:22.693519Z","end":"2026-06-18T15:17:22.990968Z","steps":["trace[471100140] 'agreement among raft nodes before linearized reading' (duration: 297.07106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.230123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.032718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-06-18T15:17:23.230229Z","caller":"traceutil/trace.go:171","msg":"trace[1354058978] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:6074; }","duration":"222.155571ms","start":"2026-06-18T15:17:23.008044Z","end":"2026-06-18T15:17:23.2302Z","steps":["trace[1354058978] 'range keys from in-memory index tree' (duration: 221.867575ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:23.540749Z","caller":"traceutil/trace.go:171","msg":"trace[1648204825] transaction","detail":"{read_only:false; response_revision:6075; number_of_response:1; }","duration":"380.059782ms","start":"2026-06-18T15:17:23.160668Z","end":"2026-06-18T15:17:23.540727Z","steps":["trace[1648204825] 'process raft request' (duration: 379.925619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.54089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.160636Z","time spent":"380.180596ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:23.899233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.370426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:17:23.899362Z","caller":"traceutil/trace.go:171","msg":"trace[274336500] transaction","detail":"{read_only:false; response_revision:6077; number_of_response:1; }","duration":"126.019252ms","start":"2026-06-18T15:17:23.773328Z","end":"2026-06-18T15:17:23.899347Z","steps":["trace[274336500] 'process raft request' (duration: 125.980751ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:23.899487Z","caller":"traceutil/trace.go:171","msg":"trace[2007775021] linearizableReadLoop","detail":"{readStateIndex:6298; appliedIndex:6297; }","duration":"666.28877ms","start":"2026-06-18T15:17:23.233175Z","end":"2026-06-18T15:17:23.899464Z","steps":["trace[2007775021] 'read index received' (duration: 307.537392ms)","trace[2007775021] 'applied index is now lower than readState.Index' (duration: 358.748668ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:17:23.899512Z","caller":"traceutil/trace.go:171","msg":"trace[954344257] transaction","detail":"{read_only:false; response_revision:6076; number_of_response:1; }","duration":"737.044338ms","start":"2026-06-18T15:17:23.162411Z","end":"2026-06-18T15:17:23.899455Z","steps":["trace[954344257] 'process raft request' (duration: 519.385355ms)","trace[954344257] 'compare' (duration: 217.269894ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:23.899646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.162389Z","time spent":"737.185901ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:23.899713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.546817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-06-18T15:17:23.899753Z","caller":"traceutil/trace.go:171","msg":"trace[725858026] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:6077; }","duration":"666.604978ms","start":"2026-06-18T15:17:23.233135Z","end":"2026-06-18T15:17:23.89974Z","steps":["trace[725858026] 'agreement among raft nodes before linearized reading' (duration: 666.450164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.899769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.357036ms","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-18T15:17:23.89979Z","caller":"traceutil/trace.go:171","msg":"trace[810722037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6077; }","duration":"597.415828ms","start":"2026-06-18T15:17:23.302368Z","end":"2026-06-18T15:17:23.899784Z","steps":["trace[810722037] 'agreement among raft nodes before linearized reading' (duration: 597.355236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.89979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.233121Z","time spent":"666.65951ms","remote":"127.0.0.1:49624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":1017,"request content":"key:\"/registry/services/specs/monitoring/prometheus-operated\" "} {"level":"warn","ts":"2026-06-18T15:17:23.899814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.302343Z","time spent":"597.46482ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-18T15:17:23.899803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.758645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:23.899843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.546111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-18T15:17:23.899844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.897802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:17:23.899898Z","caller":"traceutil/trace.go:171","msg":"trace[874299327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6077; }","duration":"430.637533ms","start":"2026-06-18T15:17:23.469247Z","end":"2026-06-18T15:17:23.899885Z","steps":["trace[874299327] 'agreement among raft nodes before linearized reading' (duration: 430.518921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.899886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.342991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:17:23.899925Z","caller":"traceutil/trace.go:171","msg":"trace[2103103528] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:6077; }","duration":"364.034536ms","start":"2026-06-18T15:17:23.53587Z","end":"2026-06-18T15:17:23.899904Z","steps":["trace[2103103528] 'agreement among raft nodes before linearized reading' (duration: 363.890242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.899936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.469226Z","time spent":"430.700954ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-18T15:17:23.899965Z","caller":"traceutil/trace.go:171","msg":"trace[266611409] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:6077; }","duration":"187.559017ms","start":"2026-06-18T15:17:23.712383Z","end":"2026-06-18T15:17:23.899942Z","steps":["trace[266611409] 'agreement among raft nodes before linearized reading' (duration: 187.397713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.89998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.729673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-18T15:17:23.899984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.070062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-18T15:17:23.899861Z","caller":"traceutil/trace.go:171","msg":"trace[436029312] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:6077; }","duration":"495.858687ms","start":"2026-06-18T15:17:23.403989Z","end":"2026-06-18T15:17:23.899848Z","steps":["trace[436029312] 'agreement among raft nodes before linearized reading' (duration: 495.756605ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:23.900009Z","caller":"traceutil/trace.go:171","msg":"trace[332171356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6077; }","duration":"572.789874ms","start":"2026-06-18T15:17:23.327213Z","end":"2026-06-18T15:17:23.900003Z","steps":["trace[332171356] 'agreement among raft nodes before linearized reading' (duration: 572.727813ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:23.900016Z","caller":"traceutil/trace.go:171","msg":"trace[837008664] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:6077; }","duration":"479.136753ms","start":"2026-06-18T15:17:23.420871Z","end":"2026-06-18T15:17:23.900008Z","steps":["trace[837008664] 'agreement among raft nodes before linearized reading' (duration: 479.01238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.900024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.327197Z","time spent":"572.823056ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-18T15:17:23.900028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.403966Z","time spent":"496.051311ms","remote":"127.0.0.1:51904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "} {"level":"warn","ts":"2026-06-18T15:17:23.900037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.458956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:6134"} {"level":"warn","ts":"2026-06-18T15:17:23.899977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.535848Z","time spent":"364.116507ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "} {"level":"warn","ts":"2026-06-18T15:17:23.900048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.983627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:23.900027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.696461ms","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-18T15:17:23.900083Z","caller":"traceutil/trace.go:171","msg":"trace[367970244] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:6077; }","duration":"526.502717ms","start":"2026-06-18T15:17:23.373564Z","end":"2026-06-18T15:17:23.900067Z","steps":["trace[367970244] 'agreement among raft nodes before linearized reading' (duration: 526.363363ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:23.900095Z","caller":"traceutil/trace.go:171","msg":"trace[1850551985] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:6077; }","duration":"280.061979ms","start":"2026-06-18T15:17:23.620016Z","end":"2026-06-18T15:17:23.900078Z","steps":["trace[1850551985] 'agreement among raft nodes before linearized reading' (duration: 279.991177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.900113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.373513Z","time spent":"526.59242ms","remote":"127.0.0.1:49616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":6158,"request content":"key:\"/registry/pods/monitoring/loki-0\" "} {"level":"warn","ts":"2026-06-18T15:17:23.900125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.55474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jvllw\" ","response":"range_response_count:1 size:6518"} {"level":"info","ts":"2026-06-18T15:17:23.900121Z","caller":"traceutil/trace.go:171","msg":"trace[755444373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6077; }","duration":"572.848125ms","start":"2026-06-18T15:17:23.327252Z","end":"2026-06-18T15:17:23.9001Z","steps":["trace[755444373] 'agreement among raft nodes before linearized reading' (duration: 572.584299ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:23.900142Z","caller":"traceutil/trace.go:171","msg":"trace[2143173296] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jvllw; range_end:; response_count:1; response_revision:6077; }","duration":"570.620662ms","start":"2026-06-18T15:17:23.329516Z","end":"2026-06-18T15:17:23.900137Z","steps":["trace[2143173296] 'agreement among raft nodes before linearized reading' (duration: 570.563181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.900162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.329502Z","time spent":"570.656993ms","remote":"127.0.0.1:49616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6542,"request content":"key:\"/registry/pods/openstack/keepalived-jvllw\" "} {"level":"warn","ts":"2026-06-18T15:17:23.900046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.420831Z","time spent":"479.208775ms","remote":"127.0.0.1:49590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1805,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"warn","ts":"2026-06-18T15:17:23.900179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.327226Z","time spent":"572.938708ms","remote":"127.0.0.1:49706","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-18T15:17:23.90073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.499231ms","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-18T15:17:23.900783Z","caller":"traceutil/trace.go:171","msg":"trace[177838122] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6077; }","duration":"595.592553ms","start":"2026-06-18T15:17:23.305177Z","end":"2026-06-18T15:17:23.90077Z","steps":["trace[177838122] 'agreement among raft nodes before linearized reading' (duration: 595.398329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:23.900819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:23.305159Z","time spent":"595.651545ms","remote":"127.0.0.1:49616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-18T15:17:24.189794Z","caller":"traceutil/trace.go:171","msg":"trace[1704690344] transaction","detail":"{read_only:false; response_revision:6080; number_of_response:1; }","duration":"285.026838ms","start":"2026-06-18T15:17:23.904739Z","end":"2026-06-18T15:17:24.189766Z","steps":["trace[1704690344] 'process raft request' (duration: 284.937196ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:24.190105Z","caller":"traceutil/trace.go:171","msg":"trace[1006408200] linearizableReadLoop","detail":"{readStateIndex:6303; appliedIndex:6299; }","duration":"285.091929ms","start":"2026-06-18T15:17:23.90499Z","end":"2026-06-18T15:17:24.190082Z","steps":["trace[1006408200] 'read index received' (duration: 62.309033ms)","trace[1006408200] 'applied index is now lower than readState.Index' (duration: 222.781926ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:17:24.190232Z","caller":"traceutil/trace.go:171","msg":"trace[209106996] transaction","detail":"{read_only:false; response_revision:6082; number_of_response:1; }","duration":"281.053584ms","start":"2026-06-18T15:17:23.909167Z","end":"2026-06-18T15:17:24.190221Z","steps":["trace[209106996] 'process raft request' (duration: 280.818687ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:24.190129Z","caller":"traceutil/trace.go:171","msg":"trace[1712953883] transaction","detail":"{read_only:false; response_revision:6079; number_of_response:1; }","duration":"285.380397ms","start":"2026-06-18T15:17:23.904737Z","end":"2026-06-18T15:17:24.190117Z","steps":["trace[1712953883] 'process raft request' (duration: 284.753921ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:24.190335Z","caller":"traceutil/trace.go:171","msg":"trace[1434520340] transaction","detail":"{read_only:false; response_revision:6081; number_of_response:1; }","duration":"285.365067ms","start":"2026-06-18T15:17:23.904959Z","end":"2026-06-18T15:17:24.190324Z","steps":["trace[1434520340] 'process raft request' (duration: 284.758082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:24.190525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.604098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:17:24.190581Z","caller":"traceutil/trace.go:171","msg":"trace[2031684906] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:6082; }","duration":"134.722681ms","start":"2026-06-18T15:17:24.055845Z","end":"2026-06-18T15:17:24.190568Z","steps":["trace[2031684906] 'agreement among raft nodes before linearized reading' (duration: 134.611148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:24.190604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.789583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-06-18T15:17:24.190678Z","caller":"traceutil/trace.go:171","msg":"trace[1509688629] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:6082; }","duration":"284.893456ms","start":"2026-06-18T15:17:23.905767Z","end":"2026-06-18T15:17:24.190661Z","steps":["trace[1509688629] 'agreement among raft nodes before linearized reading' (duration: 284.692311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:24.190682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.618044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19685"} {"level":"info","ts":"2026-06-18T15:17:24.190797Z","caller":"traceutil/trace.go:171","msg":"trace[1945859603] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:6082; }","duration":"285.788317ms","start":"2026-06-18T15:17:23.904998Z","end":"2026-06-18T15:17:24.190786Z","steps":["trace[1945859603] 'agreement among raft nodes before linearized reading' (duration: 285.429979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:24.190804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.785168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:11 size:101752"} {"level":"info","ts":"2026-06-18T15:17:24.190937Z","caller":"traceutil/trace.go:171","msg":"trace[1922677717] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:11; response_revision:6082; }","duration":"285.947591ms","start":"2026-06-18T15:17:23.904967Z","end":"2026-06-18T15:17:24.190915Z","steps":["trace[1922677717] 'agreement among raft nodes before linearized reading' (duration: 285.47001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:24.480233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.890415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:17:24.480354Z","caller":"traceutil/trace.go:171","msg":"trace[878140029] transaction","detail":"{read_only:false; response_revision:6083; number_of_response:1; }","duration":"284.375153ms","start":"2026-06-18T15:17:24.195958Z","end":"2026-06-18T15:17:24.480333Z","steps":["trace[878140029] 'process raft request' (duration: 183.293873ms)","trace[878140029] 'compare' (duration: 100.754172ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:25.380687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.933719ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:17:25.381005Z","caller":"traceutil/trace.go:171","msg":"trace[413779166] transaction","detail":"{read_only:false; response_revision:6085; number_of_response:1; }","duration":"1.183888193s","start":"2026-06-18T15:17:24.197066Z","end":"2026-06-18T15:17:25.380954Z","steps":["trace[413779166] 'process raft request' (duration: 1.183719909s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.381115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.197041Z","time spent":"1.184038776s","remote":"127.0.0.1:49720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:25.381348Z","caller":"traceutil/trace.go:171","msg":"trace[2027261859] transaction","detail":"{read_only:false; response_revision:6086; number_of_response:1; }","duration":"1.18378233s","start":"2026-06-18T15:17:24.197536Z","end":"2026-06-18T15:17:25.381318Z","steps":["trace[2027261859] 'process raft request' (duration: 1.183323649s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.381503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.197527Z","time spent":"1.183894123s","remote":"127.0.0.1:49592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1484,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:25.381452Z","caller":"traceutil/trace.go:171","msg":"trace[843091687] transaction","detail":"{read_only:false; response_revision:6087; number_of_response:1; }","duration":"1.18376832s","start":"2026-06-18T15:17:24.197666Z","end":"2026-06-18T15:17:25.381435Z","steps":["trace[843091687] 'process raft request' (duration: 1.183498003s)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:25.381738Z","caller":"traceutil/trace.go:171","msg":"trace[174808296] transaction","detail":"{read_only:false; response_revision:6088; number_of_response:1; }","duration":"1.184011226s","start":"2026-06-18T15:17:24.197713Z","end":"2026-06-18T15:17:25.381724Z","steps":["trace[174808296] 'process raft request' (duration: 1.183681578s)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:25.381795Z","caller":"traceutil/trace.go:171","msg":"trace[930371399] transaction","detail":"{read_only:false; response_revision:6089; number_of_response:1; }","duration":"1.179348003s","start":"2026-06-18T15:17:24.202434Z","end":"2026-06-18T15:17:25.381782Z","steps":["trace[930371399] 'process raft request' (duration: 1.17921567s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.381864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.202419Z","time spent":"1.179413514s","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:25.3818Z","caller":"traceutil/trace.go:171","msg":"trace[1081330754] linearizableReadLoop","detail":"{readStateIndex:6307; appliedIndex:6304; }","duration":"1.184558499s","start":"2026-06-18T15:17:24.197231Z","end":"2026-06-18T15:17:25.38179Z","steps":["trace[1081330754] 'read index received' (duration: 182.104795ms)","trace[1081330754] 'applied index is now lower than readState.Index' (duration: 1.002453084s)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:17:25.381937Z","caller":"traceutil/trace.go:171","msg":"trace[207022322] transaction","detail":"{read_only:false; response_revision:6090; number_of_response:1; }","duration":"385.774781ms","start":"2026-06-18T15:17:24.996156Z","end":"2026-06-18T15:17:25.381931Z","steps":["trace[207022322] 'process raft request' (duration: 385.587946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.381929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.197708Z","time spent":"1.184068967s","remote":"127.0.0.1:49720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1394,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:25.381999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.996137Z","time spent":"385.837463ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:25.382029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143411565s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:25.382045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.112628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:17:25.382101Z","caller":"traceutil/trace.go:171","msg":"trace[754600793] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:6090; }","duration":"1.143518038s","start":"2026-06-18T15:17:24.238563Z","end":"2026-06-18T15:17:25.382081Z","steps":["trace[754600793] 'agreement among raft nodes before linearized reading' (duration: 1.143405885s)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:25.382107Z","caller":"traceutil/trace.go:171","msg":"trace[1009801333] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:6090; }","duration":"422.22314ms","start":"2026-06-18T15:17:24.959868Z","end":"2026-06-18T15:17:25.382091Z","steps":["trace[1009801333] 'agreement among raft nodes before linearized reading' (duration: 422.115988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.382125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.909898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:25.382153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.331544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:25.382164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.597534ms","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-18T15:17:25.382201Z","caller":"traceutil/trace.go:171","msg":"trace[1011234337] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6090; }","duration":"740.659505ms","start":"2026-06-18T15:17:24.64153Z","end":"2026-06-18T15:17:25.38219Z","steps":["trace[1011234337] 'agreement among raft nodes before linearized reading' (duration: 740.540732ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:25.382225Z","caller":"traceutil/trace.go:171","msg":"trace[1671626456] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6090; }","duration":"387.02342ms","start":"2026-06-18T15:17:24.995156Z","end":"2026-06-18T15:17:25.382179Z","steps":["trace[1671626456] 'agreement among raft nodes before linearized reading' (duration: 386.907158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.382241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.641512Z","time spent":"740.722277ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-18T15:17:25.382146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.238543Z","time spent":"1.143595319s","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-18T15:17:25.382149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.959858Z","time spent":"422.282302ms","remote":"127.0.0.1:41046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-18T15:17:25.382295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.286556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:17:25.382296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056216461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:17:25.382403Z","caller":"traceutil/trace.go:171","msg":"trace[1902630377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6090; }","duration":"428.4411ms","start":"2026-06-18T15:17:24.953929Z","end":"2026-06-18T15:17:25.38237Z","steps":["trace[1902630377] 'agreement among raft nodes before linearized reading' (duration: 428.268026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.382458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.953837Z","time spent":"428.612644ms","remote":"127.0.0.1:49456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-18T15:17:25.382196Z","caller":"traceutil/trace.go:171","msg":"trace[1468295334] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6090; }","duration":"386.427517ms","start":"2026-06-18T15:17:24.995757Z","end":"2026-06-18T15:17:25.382185Z","steps":["trace[1468295334] 'agreement among raft nodes before linearized reading' (duration: 386.331864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.382548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.995745Z","time spent":"386.792205ms","remote":"127.0.0.1:49676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"info","ts":"2026-06-18T15:17:25.382403Z","caller":"traceutil/trace.go:171","msg":"trace[175717362] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:6090; }","duration":"1.056379935s","start":"2026-06-18T15:17:24.326006Z","end":"2026-06-18T15:17:25.382386Z","steps":["trace[175717362] 'agreement among raft nodes before linearized reading' (duration: 1.05614133s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.382278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.995131Z","time spent":"387.136924ms","remote":"127.0.0.1:49676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-06-18T15:17:25.382868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.616631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6157"} {"level":"warn","ts":"2026-06-18T15:17:25.382838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.325982Z","time spent":"1.056761174s","remote":"127.0.0.1:49786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":100,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-06-18T15:17:25.382947Z","caller":"traceutil/trace.go:171","msg":"trace[231629236] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:6090; }","duration":"387.4366ms","start":"2026-06-18T15:17:24.995477Z","end":"2026-06-18T15:17:25.382914Z","steps":["trace[231629236] 'agreement among raft nodes before linearized reading' (duration: 386.534558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.38292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.197661Z","time spent":"1.185160603s","remote":"127.0.0.1:49720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1618,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:25.383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.995466Z","time spent":"387.524563ms","remote":"127.0.0.1:49676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":6181,"request content":"key:\"/registry/jobs/openstack/keystone-credential-setup\" "} {"level":"warn","ts":"2026-06-18T15:17:25.38317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185930202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112169"} {"level":"info","ts":"2026-06-18T15:17:25.380952Z","caller":"traceutil/trace.go:171","msg":"trace[1304967980] transaction","detail":"{read_only:false; response_revision:6084; number_of_response:1; }","duration":"1.184293233s","start":"2026-06-18T15:17:24.196632Z","end":"2026-06-18T15:17:25.380925Z","steps":["trace[1304967980] 'process raft request' (duration: 670.763338ms)","trace[1304967980] 'compare' (duration: 512.823027ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:17:25.383258Z","caller":"traceutil/trace.go:171","msg":"trace[2059940578] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:6090; }","duration":"1.186022444s","start":"2026-06-18T15:17:24.197193Z","end":"2026-06-18T15:17:25.383215Z","steps":["trace[2059940578] 'agreement among raft nodes before linearized reading' (duration: 1.184624301s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.383403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.196607Z","time spent":"1.186628949s","remote":"127.0.0.1:49592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":967,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:17:25.385452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:24.197184Z","time spent":"1.188228877s","remote":"127.0.0.1:49616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":16,"response size":112193,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"warn","ts":"2026-06-18T15:17:25.705482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.808474ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:17:25.705648Z","caller":"traceutil/trace.go:171","msg":"trace[994101327] linearizableReadLoop","detail":"{readStateIndex:6313; appliedIndex:6312; }","duration":"314.752146ms","start":"2026-06-18T15:17:25.390877Z","end":"2026-06-18T15:17:25.705629Z","steps":["trace[994101327] 'read index received' (duration: 111.799229ms)","trace[994101327] 'applied index is now lower than readState.Index' (duration: 202.951207ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:17:25.705779Z","caller":"traceutil/trace.go:171","msg":"trace[2075356287] transaction","detail":"{read_only:false; response_revision:6091; number_of_response:1; }","duration":"316.116179ms","start":"2026-06-18T15:17:25.389608Z","end":"2026-06-18T15:17:25.705724Z","steps":["trace[2075356287] 'process raft request' (duration: 112.969276ms)","trace[2075356287] 'compare' (duration: 202.543968ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:25.705928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.047384ms","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-18T15:17:25.705997Z","caller":"traceutil/trace.go:171","msg":"trace[206083477] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6091; }","duration":"315.147227ms","start":"2026-06-18T15:17:25.390839Z","end":"2026-06-18T15:17:25.705986Z","steps":["trace[206083477] 'agreement among raft nodes before linearized reading' (duration: 314.86655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.706077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:25.390825Z","time spent":"315.240689ms","remote":"127.0.0.1:49616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-18T15:17:25.706004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:25.389589Z","time spent":"316.283593ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:25.967887Z","caller":"traceutil/trace.go:171","msg":"trace[1319921734] transaction","detail":"{read_only:false; response_revision:6092; number_of_response:1; }","duration":"569.552215ms","start":"2026-06-18T15:17:25.398312Z","end":"2026-06-18T15:17:25.967864Z","steps":["trace[1319921734] 'process raft request' (duration: 540.488734ms)","trace[1319921734] 'compare' (duration: 28.769955ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:25.968013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:25.398298Z","time spent":"569.648847ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7438,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:25.967896Z","caller":"traceutil/trace.go:171","msg":"trace[1718197892] transaction","detail":"{read_only:false; response_revision:6093; number_of_response:1; }","duration":"508.982925ms","start":"2026-06-18T15:17:25.458891Z","end":"2026-06-18T15:17:25.967874Z","steps":["trace[1718197892] 'process raft request' (duration: 508.883182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:25.968164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:25.458864Z","time spent":"509.24841ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:26.033225Z","caller":"traceutil/trace.go:171","msg":"trace[1250618222] transaction","detail":"{read_only:false; response_revision:6094; number_of_response:1; }","duration":"486.271685ms","start":"2026-06-18T15:17:25.546921Z","end":"2026-06-18T15:17:26.033193Z","steps":["trace[1250618222] 'process raft request' (duration: 486.018609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:26.033482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:25.54689Z","time spent":"486.45583ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:17:26.033535Z","caller":"traceutil/trace.go:171","msg":"trace[1751422664] transaction","detail":"{read_only:false; response_revision:6095; number_of_response:1; }","duration":"128.522382ms","start":"2026-06-18T15:17:25.904996Z","end":"2026-06-18T15:17:26.033519Z","steps":["trace[1751422664] 'process raft request' (duration: 128.143032ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:17:26.033736Z","caller":"traceutil/trace.go:171","msg":"trace[1904109317] linearizableReadLoop","detail":"{readStateIndex:6316; appliedIndex:6313; }","duration":"326.0485ms","start":"2026-06-18T15:17:25.707677Z","end":"2026-06-18T15:17:26.033725Z","steps":["trace[1904109317] 'read index received' (duration: 231.21003ms)","trace[1904109317] 'applied index is now lower than readState.Index' (duration: 94.83747ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:17:26.03405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.374347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19685"} {"level":"info","ts":"2026-06-18T15:17:26.034095Z","caller":"traceutil/trace.go:171","msg":"trace[165471363] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:6096; }","duration":"326.453839ms","start":"2026-06-18T15:17:25.70763Z","end":"2026-06-18T15:17:26.034084Z","steps":["trace[165471363] 'agreement among raft nodes before linearized reading' (duration: 326.321726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:17:26.034125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:17:25.707613Z","time spent":"326.505181ms","remote":"127.0.0.1:49604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19709,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-18T15:17:26.034259Z","caller":"traceutil/trace.go:171","msg":"trace[1646395659] transaction","detail":"{read_only:false; response_revision:6096; number_of_response:1; }","duration":"129.261069ms","start":"2026-06-18T15:17:25.904992Z","end":"2026-06-18T15:17:26.034253Z","steps":["trace[1646395659] 'process raft request' (duration: 128.46548ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:04.086568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5875} {"level":"info","ts":"2026-06-18T15:22:04.172707Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5875,"took":"84.003791ms","hash":705746825,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":25608192,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-18T15:22:04.172878Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":705746825,"revision":5875,"compact-revision":2940} {"level":"info","ts":"2026-06-18T15:22:47.335901Z","caller":"traceutil/trace.go:171","msg":"trace[967444948] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"117.118858ms","start":"2026-06-18T15:22:47.218744Z","end":"2026-06-18T15:22:47.335863Z","steps":["trace[967444948] 'process raft request' (duration: 85.307085ms)","trace[967444948] 'compare' (duration: 31.121136ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:22:47.533126Z","caller":"traceutil/trace.go:171","msg":"trace[1793030498] transaction","detail":"{read_only:false; response_revision:8319; number_of_response:1; }","duration":"170.924786ms","start":"2026-06-18T15:22:47.362168Z","end":"2026-06-18T15:22:47.533092Z","steps":["trace[1793030498] 'process raft request' (duration: 108.820736ms)","trace[1793030498] 'compare' (duration: 61.916916ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:22:47.53365Z","caller":"traceutil/trace.go:171","msg":"trace[858315571] transaction","detail":"{read_only:false; response_revision:8320; number_of_response:1; }","duration":"160.503864ms","start":"2026-06-18T15:22:47.373114Z","end":"2026-06-18T15:22:47.533617Z","steps":["trace[858315571] 'process raft request' (duration: 159.936169ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:47.533702Z","caller":"traceutil/trace.go:171","msg":"trace[1182812709] transaction","detail":"{read_only:false; response_revision:8321; number_of_response:1; }","duration":"158.988886ms","start":"2026-06-18T15:22:47.374684Z","end":"2026-06-18T15:22:47.533673Z","steps":["trace[1182812709] 'process raft request' (duration: 158.849853ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:47.563398Z","caller":"traceutil/trace.go:171","msg":"trace[1604657753] linearizableReadLoop","detail":"{readStateIndex:8621; appliedIndex:8617; }","duration":"140.333033ms","start":"2026-06-18T15:22:47.423043Z","end":"2026-06-18T15:22:47.563376Z","steps":["trace[1604657753] 'read index received' (duration: 47.958736ms)","trace[1604657753] 'applied index is now lower than readState.Index' (duration: 92.373417ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:22:47.563488Z","caller":"traceutil/trace.go:171","msg":"trace[1608111743] transaction","detail":"{read_only:false; response_revision:8322; number_of_response:1; }","duration":"153.272098ms","start":"2026-06-18T15:22:47.410185Z","end":"2026-06-18T15:22:47.563457Z","steps":["trace[1608111743] 'process raft request' (duration: 153.061212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:22:47.563754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.688081ms","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-18T15:22:47.563801Z","caller":"traceutil/trace.go:171","msg":"trace[1661274425] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8322; }","duration":"140.776663ms","start":"2026-06-18T15:22:47.423012Z","end":"2026-06-18T15:22:47.563788Z","steps":["trace[1661274425] 'agreement among raft nodes before linearized reading' (duration: 140.494037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:22:47.56377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.303686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:22:47.563865Z","caller":"traceutil/trace.go:171","msg":"trace[400612196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8322; }","duration":"118.44161ms","start":"2026-06-18T15:22:47.445397Z","end":"2026-06-18T15:22:47.563839Z","steps":["trace[400612196] 'agreement among raft nodes before linearized reading' (duration: 118.238845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:22:48.142197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.627761ms","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-18T15:22:48.14231Z","caller":"traceutil/trace.go:171","msg":"trace[1861535966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8325; }","duration":"138.800436ms","start":"2026-06-18T15:22:48.003487Z","end":"2026-06-18T15:22:48.142287Z","steps":["trace[1861535966] 'range keys from in-memory index tree' (duration: 138.425367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:22:48.142304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.157002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-18T15:22:48.142385Z","caller":"traceutil/trace.go:171","msg":"trace[1323721483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8325; }","duration":"127.302266ms","start":"2026-06-18T15:22:48.015063Z","end":"2026-06-18T15:22:48.142366Z","steps":["trace[1323721483] 'range keys from in-memory index tree' (duration: 126.950698ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:07.375852Z","caller":"traceutil/trace.go:171","msg":"trace[1897631170] linearizableReadLoop","detail":"{readStateIndex:8856; appliedIndex:8855; }","duration":"166.768036ms","start":"2026-06-18T15:23:07.209059Z","end":"2026-06-18T15:23:07.375827Z","steps":["trace[1897631170] 'read index received' (duration: 166.582372ms)","trace[1897631170] 'applied index is now lower than readState.Index' (duration: 184.374µs)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:23:07.376087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.007992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-8487dcfdc5-wb99j.18ba362c78a20cbe\" ","response":"range_response_count:1 size:1134"} {"level":"info","ts":"2026-06-18T15:23:07.376125Z","caller":"traceutil/trace.go:171","msg":"trace[1711956040] range","detail":"{range_begin:/registry/events/openstack/barbican-api-8487dcfdc5-wb99j.18ba362c78a20cbe; range_end:; response_count:1; response_revision:8553; }","duration":"167.106234ms","start":"2026-06-18T15:23:07.209005Z","end":"2026-06-18T15:23:07.376112Z","steps":["trace[1711956040] 'agreement among raft nodes before linearized reading' (duration: 166.93267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:08.151981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.482871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:23:08.152126Z","caller":"traceutil/trace.go:171","msg":"trace[1527866536] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:8560; }","duration":"169.675076ms","start":"2026-06-18T15:23:07.982424Z","end":"2026-06-18T15:23:08.152099Z","steps":["trace[1527866536] 'count revisions from in-memory index tree' (duration: 169.355128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:08.152015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.994043ms","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-18T15:23:08.152508Z","caller":"traceutil/trace.go:171","msg":"trace[269462565] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8560; }","duration":"179.428822ms","start":"2026-06-18T15:23:07.972945Z","end":"2026-06-18T15:23:08.152374Z","steps":["trace[269462565] 'range keys from in-memory index tree' (duration: 178.799287ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:37.956638Z","caller":"traceutil/trace.go:171","msg":"trace[874423152] transaction","detail":"{read_only:false; response_revision:8771; number_of_response:1; }","duration":"179.487074ms","start":"2026-06-18T15:23:37.777117Z","end":"2026-06-18T15:23:37.956604Z","steps":["trace[874423152] 'process raft request' (duration: 179.219207ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:41.234316Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002391.wal"} {"level":"info","ts":"2026-06-18T15:23:42.651063Z","caller":"traceutil/trace.go:171","msg":"trace[1276309365] linearizableReadLoop","detail":"{readStateIndex:9110; appliedIndex:9109; }","duration":"157.957861ms","start":"2026-06-18T15:23:42.493076Z","end":"2026-06-18T15:23:42.651034Z","steps":["trace[1276309365] 'read index received' (duration: 157.685585ms)","trace[1276309365] 'applied index is now lower than readState.Index' (duration: 271.336µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:23:42.651191Z","caller":"traceutil/trace.go:171","msg":"trace[911325951] transaction","detail":"{read_only:false; response_revision:8798; number_of_response:1; }","duration":"264.788139ms","start":"2026-06-18T15:23:42.386355Z","end":"2026-06-18T15:23:42.651143Z","steps":["trace[911325951] 'process raft request' (duration: 264.470401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:42.65134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.245428ms","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-18T15:23:42.651393Z","caller":"traceutil/trace.go:171","msg":"trace[1290554039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8798; }","duration":"158.34726ms","start":"2026-06-18T15:23:42.493029Z","end":"2026-06-18T15:23:42.651376Z","steps":["trace[1290554039] 'agreement among raft nodes before linearized reading' (duration: 158.155726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:42.651828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.343113ms","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-18T15:23:42.651952Z","caller":"traceutil/trace.go:171","msg":"trace[467962941] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8798; }","duration":"154.513177ms","start":"2026-06-18T15:23:42.497402Z","end":"2026-06-18T15:23:42.651915Z","steps":["trace[467962941] 'agreement among raft nodes before linearized reading' (duration: 154.075067ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:51.710973Z","caller":"traceutil/trace.go:171","msg":"trace[620371224] transaction","detail":"{read_only:false; response_revision:8887; number_of_response:1; }","duration":"140.964388ms","start":"2026-06-18T15:23:51.569965Z","end":"2026-06-18T15:23:51.710929Z","steps":["trace[620371224] 'process raft request' (duration: 140.500687ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:52.145643Z","caller":"traceutil/trace.go:171","msg":"trace[1734414651] transaction","detail":"{read_only:false; response_revision:8890; number_of_response:1; }","duration":"115.255432ms","start":"2026-06-18T15:23:52.030362Z","end":"2026-06-18T15:23:52.145618Z","steps":["trace[1734414651] 'process raft request' (duration: 78.596941ms)","trace[1734414651] 'compare' (duration: 36.497997ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:23:52.145822Z","caller":"traceutil/trace.go:171","msg":"trace[1392816008] linearizableReadLoop","detail":"{readStateIndex:9207; appliedIndex:9204; }","duration":"107.556604ms","start":"2026-06-18T15:23:52.038236Z","end":"2026-06-18T15:23:52.145793Z","steps":["trace[1392816008] 'read index received' (duration: 19.637067ms)","trace[1392816008] 'applied index is now lower than readState.Index' (duration: 87.917287ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:23:52.145937Z","caller":"traceutil/trace.go:171","msg":"trace[527976165] transaction","detail":"{read_only:false; response_revision:8891; number_of_response:1; }","duration":"115.239672ms","start":"2026-06-18T15:23:52.030685Z","end":"2026-06-18T15:23:52.145925Z","steps":["trace[527976165] 'process raft request' (duration: 114.888723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:52.14618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.920453ms","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-18T15:23:52.146197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.491097ms","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-18T15:23:52.146242Z","caller":"traceutil/trace.go:171","msg":"trace[188943304] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8891; }","duration":"108.020706ms","start":"2026-06-18T15:23:52.038208Z","end":"2026-06-18T15:23:52.146229Z","steps":["trace[188943304] 'agreement among raft nodes before linearized reading' (duration: 107.76637ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:52.146271Z","caller":"traceutil/trace.go:171","msg":"trace[558614595] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:8891; }","duration":"101.615ms","start":"2026-06-18T15:23:52.044633Z","end":"2026-06-18T15:23:52.146248Z","steps":["trace[558614595] 'agreement among raft nodes before linearized reading' (duration: 101.485687ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:25:11.418289Z","caller":"traceutil/trace.go:171","msg":"trace[2043262283] transaction","detail":"{read_only:false; response_revision:9655; number_of_response:1; }","duration":"236.957811ms","start":"2026-06-18T15:25:11.181307Z","end":"2026-06-18T15:25:11.418265Z","steps":["trace[2043262283] 'process raft request' (duration: 236.801208ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:25:11.451056Z","caller":"traceutil/trace.go:171","msg":"trace[197137655] transaction","detail":"{read_only:false; response_revision:9656; number_of_response:1; }","duration":"267.887876ms","start":"2026-06-18T15:25:11.183143Z","end":"2026-06-18T15:25:11.45103Z","steps":["trace[197137655] 'process raft request' (duration: 267.67072ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:25:11.451411Z","caller":"traceutil/trace.go:171","msg":"trace[595842730] transaction","detail":"{read_only:false; response_revision:9657; number_of_response:1; }","duration":"266.977524ms","start":"2026-06-18T15:25:11.184402Z","end":"2026-06-18T15:25:11.451379Z","steps":["trace[595842730] 'process raft request' (duration: 266.580515ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:25:11.451818Z","caller":"traceutil/trace.go:171","msg":"trace[1687158161] linearizableReadLoop","detail":"{readStateIndex:9997; appliedIndex:9992; }","duration":"135.680557ms","start":"2026-06-18T15:25:11.31611Z","end":"2026-06-18T15:25:11.45179Z","steps":["trace[1687158161] 'read index received' (duration: 102.053685ms)","trace[1687158161] 'applied index is now lower than readState.Index' (duration: 33.625952ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:25:11.451925Z","caller":"traceutil/trace.go:171","msg":"trace[2074464000] transaction","detail":"{read_only:false; response_revision:9659; number_of_response:1; }","duration":"169.114114ms","start":"2026-06-18T15:25:11.282803Z","end":"2026-06-18T15:25:11.451917Z","steps":["trace[2074464000] 'process raft request' (duration: 168.892769ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:25:11.451912Z","caller":"traceutil/trace.go:171","msg":"trace[694858016] transaction","detail":"{read_only:false; response_revision:9658; number_of_response:1; }","duration":"251.349053ms","start":"2026-06-18T15:25:11.200527Z","end":"2026-06-18T15:25:11.451876Z","steps":["trace[694858016] 'process raft request' (duration: 250.754148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:25:11.452194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.063406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jvllw\" ","response":"range_response_count:1 size:6518"} {"level":"info","ts":"2026-06-18T15:25:11.45228Z","caller":"traceutil/trace.go:171","msg":"trace[789594382] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jvllw; range_end:; response_count:1; response_revision:9659; }","duration":"136.203079ms","start":"2026-06-18T15:25:11.316058Z","end":"2026-06-18T15:25:11.452261Z","steps":["trace[789594382] 'agreement among raft nodes before linearized reading' (duration: 135.956263ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:25:12.425685Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-18T15:25:12.43021Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-18T15:25:12.430301Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-18T15:27:04.097829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8024} {"level":"info","ts":"2026-06-18T15:27:04.164879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8024,"took":"64.710669ms","hash":2659981368,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":28110848,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-18T15:27:04.164961Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2659981368,"revision":8024,"compact-revision":5875} {"level":"info","ts":"2026-06-18T15:30:49.960477Z","caller":"traceutil/trace.go:171","msg":"trace[341168590] transaction","detail":"{read_only:false; response_revision:12093; number_of_response:1; }","duration":"148.115072ms","start":"2026-06-18T15:30:49.812326Z","end":"2026-06-18T15:30:49.960441Z","steps":["trace[341168590] 'process raft request' (duration: 141.217534ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:50.912197Z","caller":"traceutil/trace.go:171","msg":"trace[2138529689] linearizableReadLoop","detail":"{readStateIndex:12513; appliedIndex:12512; }","duration":"180.583539ms","start":"2026-06-18T15:30:50.731589Z","end":"2026-06-18T15:30:50.912173Z","steps":["trace[2138529689] 'read index received' (duration: 180.381394ms)","trace[2138529689] 'applied index is now lower than readState.Index' (duration: 200.985µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:30:50.912634Z","caller":"traceutil/trace.go:171","msg":"trace[1594563192] transaction","detail":"{read_only:false; response_revision:12096; number_of_response:1; }","duration":"204.29883ms","start":"2026-06-18T15:30:50.708321Z","end":"2026-06-18T15:30:50.91262Z","steps":["trace[1594563192] 'process raft request' (duration: 203.716646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:30:50.912876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.260985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:30:50.91292Z","caller":"traceutil/trace.go:171","msg":"trace[1006046160] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:12096; }","duration":"181.354848ms","start":"2026-06-18T15:30:50.731552Z","end":"2026-06-18T15:30:50.912906Z","steps":["trace[1006046160] 'agreement among raft nodes before linearized reading' (duration: 181.270046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:30:50.913113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.978158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:30:50.913151Z","caller":"traceutil/trace.go:171","msg":"trace[1565823883] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:12096; }","duration":"108.063909ms","start":"2026-06-18T15:30:50.805078Z","end":"2026-06-18T15:30:50.913142Z","steps":["trace[1565823883] 'agreement among raft nodes before linearized reading' (duration: 108.002938ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:51.273305Z","caller":"traceutil/trace.go:171","msg":"trace[437815964] transaction","detail":"{read_only:false; response_revision:12097; number_of_response:1; }","duration":"102.177356ms","start":"2026-06-18T15:30:51.171077Z","end":"2026-06-18T15:30:51.273254Z","steps":["trace[437815964] 'process raft request' (duration: 101.990542ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:31:58.217174Z","caller":"traceutil/trace.go:171","msg":"trace[956672738] transaction","detail":"{read_only:false; response_revision:12559; number_of_response:1; }","duration":"113.530052ms","start":"2026-06-18T15:31:58.10362Z","end":"2026-06-18T15:31:58.21715Z","steps":["trace[956672738] 'process raft request' (duration: 113.389078ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:31:58.235597Z","caller":"traceutil/trace.go:171","msg":"trace[1008766602] transaction","detail":"{read_only:false; response_revision:12560; number_of_response:1; }","duration":"125.36677ms","start":"2026-06-18T15:31:58.110193Z","end":"2026-06-18T15:31:58.23556Z","steps":["trace[1008766602] 'process raft request' (duration: 124.992151ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:32:04.104605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10425} {"level":"info","ts":"2026-06-18T15:32:04.190983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10425,"took":"83.470818ms","hash":1484110432,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":26800128,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-18T15:32:04.191045Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1484110432,"revision":10425,"compact-revision":8024} {"level":"info","ts":"2026-06-18T15:32:36.317916Z","caller":"traceutil/trace.go:171","msg":"trace[2093564231] transaction","detail":"{read_only:false; response_revision:12790; number_of_response:1; }","duration":"105.166368ms","start":"2026-06-18T15:32:36.212722Z","end":"2026-06-18T15:32:36.317888Z","steps":["trace[2093564231] 'process raft request' (duration: 104.969623ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:35:03.438435Z","caller":"traceutil/trace.go:171","msg":"trace[1819854301] transaction","detail":"{read_only:false; response_revision:13716; number_of_response:1; }","duration":"229.467064ms","start":"2026-06-18T15:35:03.208931Z","end":"2026-06-18T15:35:03.438398Z","steps":["trace[1819854301] 'process raft request' (duration: 228.997093ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:04.113141Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12589} {"level":"info","ts":"2026-06-18T15:37:04.194106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12589,"took":"78.34892ms","hash":1267492421,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":27807744,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-18T15:37:04.194184Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1267492421,"revision":12589,"compact-revision":10425} {"level":"info","ts":"2026-06-18T15:37:11.184296Z","caller":"traceutil/trace.go:171","msg":"trace[2018172559] linearizableReadLoop","detail":"{readStateIndex:15155; appliedIndex:15154; }","duration":"335.974582ms","start":"2026-06-18T15:37:10.848292Z","end":"2026-06-18T15:37:11.184266Z","steps":["trace[2018172559] 'read index received' (duration: 335.739355ms)","trace[2018172559] 'applied index is now lower than readState.Index' (duration: 233.617µs)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:37:11.184522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.197728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:37:11.184571Z","caller":"traceutil/trace.go:171","msg":"trace[1186238569] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:14647; }","duration":"336.30531ms","start":"2026-06-18T15:37:10.848252Z","end":"2026-06-18T15:37:11.184557Z","steps":["trace[1186238569] 'agreement among raft nodes before linearized reading' (duration: 336.203477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:11.184622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:37:10.848236Z","time spent":"336.374832ms","remote":"127.0.0.1:41106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-18T15:37:11.184617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.886871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:37:11.184545Z","caller":"traceutil/trace.go:171","msg":"trace[927670796] transaction","detail":"{read_only:false; response_revision:14647; number_of_response:1; }","duration":"347.555414ms","start":"2026-06-18T15:37:10.836943Z","end":"2026-06-18T15:37:11.184498Z","steps":["trace[927670796] 'process raft request' (duration: 347.086202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:11.184831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.532145ms","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-18T15:37:11.184956Z","caller":"traceutil/trace.go:171","msg":"trace[1827208535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14647; }","duration":"208.72304ms","start":"2026-06-18T15:37:10.976205Z","end":"2026-06-18T15:37:11.184928Z","steps":["trace[1827208535] 'agreement among raft nodes before linearized reading' (duration: 208.366061ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:11.184764Z","caller":"traceutil/trace.go:171","msg":"trace[31095225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14647; }","duration":"229.127087ms","start":"2026-06-18T15:37:10.95562Z","end":"2026-06-18T15:37:11.184747Z","steps":["trace[31095225] 'agreement among raft nodes before linearized reading' (duration: 228.876031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:11.184914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:37:10.836906Z","time spent":"347.907463ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:37:31.473714Z","caller":"traceutil/trace.go:171","msg":"trace[557027675] linearizableReadLoop","detail":"{readStateIndex:15262; appliedIndex:15261; }","duration":"136.108025ms","start":"2026-06-18T15:37:31.337575Z","end":"2026-06-18T15:37:31.473683Z","steps":["trace[557027675] 'read index received' (duration: 135.91448ms)","trace[557027675] 'applied index is now lower than readState.Index' (duration: 192.205µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:37:31.473837Z","caller":"traceutil/trace.go:171","msg":"trace[1791620681] transaction","detail":"{read_only:false; response_revision:14750; number_of_response:1; }","duration":"174.290465ms","start":"2026-06-18T15:37:31.299497Z","end":"2026-06-18T15:37:31.473788Z","steps":["trace[1791620681] 'process raft request' (duration: 174.014778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:31.473947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.34607ms","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-18T15:37:31.473999Z","caller":"traceutil/trace.go:171","msg":"trace[1086588775] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14750; }","duration":"136.446783ms","start":"2026-06-18T15:37:31.33753Z","end":"2026-06-18T15:37:31.473977Z","steps":["trace[1086588775] 'agreement among raft nodes before linearized reading' (duration: 136.266028ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:39.97337Z","caller":"traceutil/trace.go:171","msg":"trace[1637982169] transaction","detail":"{read_only:false; response_revision:14794; number_of_response:1; }","duration":"164.018923ms","start":"2026-06-18T15:37:39.809299Z","end":"2026-06-18T15:37:39.973318Z","steps":["trace[1637982169] 'process raft request' (duration: 154.988353ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:50.160134Z","caller":"traceutil/trace.go:171","msg":"trace[1021614701] linearizableReadLoop","detail":"{readStateIndex:15385; appliedIndex:15384; }","duration":"111.67724ms","start":"2026-06-18T15:37:50.048407Z","end":"2026-06-18T15:37:50.160084Z","steps":["trace[1021614701] 'read index received' (duration: 102.66681ms)","trace[1021614701] 'applied index is now lower than readState.Index' (duration: 9.00894ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:37:50.160291Z","caller":"traceutil/trace.go:171","msg":"trace[483988026] transaction","detail":"{read_only:false; response_revision:14867; number_of_response:1; }","duration":"123.023636ms","start":"2026-06-18T15:37:50.037252Z","end":"2026-06-18T15:37:50.160276Z","steps":["trace[483988026] 'process raft request' (duration: 113.847952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:50.160607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.159252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-18T15:37:50.160625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.195042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-18T15:37:50.160694Z","caller":"traceutil/trace.go:171","msg":"trace[1547773721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14867; }","duration":"112.288724ms","start":"2026-06-18T15:37:50.048387Z","end":"2026-06-18T15:37:50.160676Z","steps":["trace[1547773721] 'agreement among raft nodes before linearized reading' (duration: 112.015057ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:50.160717Z","caller":"traceutil/trace.go:171","msg":"trace[1620885759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14867; }","duration":"112.343386ms","start":"2026-06-18T15:37:50.048352Z","end":"2026-06-18T15:37:50.160695Z","steps":["trace[1620885759] 'agreement among raft nodes before linearized reading' (duration: 112.09613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:57.60618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.376ms","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-18T15:37:57.60637Z","caller":"traceutil/trace.go:171","msg":"trace[1323337385] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15016; }","duration":"101.615295ms","start":"2026-06-18T15:37:57.504727Z","end":"2026-06-18T15:37:57.606342Z","steps":["trace[1323337385] 'range keys from in-memory index tree' (duration: 101.157834ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:57.955477Z","caller":"traceutil/trace.go:171","msg":"trace[1886810025] transaction","detail":"{read_only:false; response_revision:15018; number_of_response:1; }","duration":"243.273475ms","start":"2026-06-18T15:37:57.712151Z","end":"2026-06-18T15:37:57.955425Z","steps":["trace[1886810025] 'process raft request' (duration: 243.031429ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:57.979854Z","caller":"traceutil/trace.go:171","msg":"trace[1595724111] linearizableReadLoop","detail":"{readStateIndex:15541; appliedIndex:15538; }","duration":"158.292335ms","start":"2026-06-18T15:37:57.821524Z","end":"2026-06-18T15:37:57.979817Z","steps":["trace[1595724111] 'read index received' (duration: 133.667865ms)","trace[1595724111] 'applied index is now lower than readState.Index' (duration: 24.62311ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:37:57.979936Z","caller":"traceutil/trace.go:171","msg":"trace[779718017] transaction","detail":"{read_only:false; response_revision:15020; number_of_response:1; }","duration":"164.343822ms","start":"2026-06-18T15:37:57.815525Z","end":"2026-06-18T15:37:57.979869Z","steps":["trace[779718017] 'process raft request' (duration: 164.158548ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:57.980204Z","caller":"traceutil/trace.go:171","msg":"trace[956989088] transaction","detail":"{read_only:false; response_revision:15019; number_of_response:1; }","duration":"173.903675ms","start":"2026-06-18T15:37:57.806268Z","end":"2026-06-18T15:37:57.980172Z","steps":["trace[956989088] 'process raft request' (duration: 173.245929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:57.980237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.719945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c6e84c89-205c-4e92-bf82-44cdbdcbc2ba\" ","response":"range_response_count:1 size:3606"} {"level":"info","ts":"2026-06-18T15:37:57.980404Z","caller":"traceutil/trace.go:171","msg":"trace[843263324] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c6e84c89-205c-4e92-bf82-44cdbdcbc2ba; range_end:; response_count:1; response_revision:15021; }","duration":"158.926201ms","start":"2026-06-18T15:37:57.821424Z","end":"2026-06-18T15:37:57.98035Z","steps":["trace[843263324] 'agreement among raft nodes before linearized reading' (duration: 158.579343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:57.980555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.8346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jvllw\" ","response":"range_response_count:1 size:6518"} {"level":"info","ts":"2026-06-18T15:37:57.980605Z","caller":"traceutil/trace.go:171","msg":"trace[967099549] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jvllw; range_end:; response_count:1; response_revision:15021; }","duration":"156.901251ms","start":"2026-06-18T15:37:57.823689Z","end":"2026-06-18T15:37:57.980591Z","steps":["trace[967099549] 'agreement among raft nodes before linearized reading' (duration: 156.600034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:57.980765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.262218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:37:57.98088Z","caller":"traceutil/trace.go:171","msg":"trace[173042408] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:15021; }","duration":"104.458954ms","start":"2026-06-18T15:37:57.876392Z","end":"2026-06-18T15:37:57.980851Z","steps":["trace[173042408] 'agreement among raft nodes before linearized reading' (duration: 104.201668ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:39:04.186826Z","caller":"traceutil/trace.go:171","msg":"trace[2111992874] transaction","detail":"{read_only:false; response_revision:15931; number_of_response:1; }","duration":"107.538599ms","start":"2026-06-18T15:39:04.079239Z","end":"2026-06-18T15:39:04.186778Z","steps":["trace[2111992874] 'process raft request' (duration: 107.238042ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:39:38.533765Z","caller":"traceutil/trace.go:171","msg":"trace[1556040027] transaction","detail":"{read_only:false; response_revision:16109; number_of_response:1; }","duration":"157.337161ms","start":"2026-06-18T15:39:38.376403Z","end":"2026-06-18T15:39:38.53374Z","steps":["trace[1556040027] 'process raft request' (duration: 157.120056ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:39:38.537504Z","caller":"traceutil/trace.go:171","msg":"trace[687732093] transaction","detail":"{read_only:false; response_revision:16110; number_of_response:1; }","duration":"133.460141ms","start":"2026-06-18T15:39:38.404008Z","end":"2026-06-18T15:39:38.537469Z","steps":["trace[687732093] 'process raft request' (duration: 133.044471ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:39:38.719856Z","caller":"traceutil/trace.go:171","msg":"trace[1252736298] transaction","detail":"{read_only:false; response_revision:16113; number_of_response:1; }","duration":"174.019408ms","start":"2026-06-18T15:39:38.545799Z","end":"2026-06-18T15:39:38.719818Z","steps":["trace[1252736298] 'process raft request' (duration: 173.767852ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:42:04.11885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14609} {"level":"info","ts":"2026-06-18T15:42:04.212423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14609,"took":"90.610655ms","hash":353413729,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":31395840,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-18T15:42:04.212713Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":353413729,"revision":14609,"compact-revision":12589} {"level":"info","ts":"2026-06-18T15:43:35.978558Z","caller":"traceutil/trace.go:171","msg":"trace[471864869] linearizableReadLoop","detail":"{readStateIndex:18479; appliedIndex:18478; }","duration":"118.759419ms","start":"2026-06-18T15:43:35.859767Z","end":"2026-06-18T15:43:35.978526Z","steps":["trace[471864869] 'read index received' (duration: 118.503983ms)","trace[471864869] 'applied index is now lower than readState.Index' (duration: 253.966µs)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:43:35.97926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.452727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-18T15:43:35.979374Z","caller":"traceutil/trace.go:171","msg":"trace[905409767] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:17867; }","duration":"119.631571ms","start":"2026-06-18T15:43:35.859723Z","end":"2026-06-18T15:43:35.979355Z","steps":["trace[905409767] 'agreement among raft nodes before linearized reading' (duration: 119.359534ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:43:35.979359Z","caller":"traceutil/trace.go:171","msg":"trace[856204307] transaction","detail":"{read_only:false; response_revision:17867; number_of_response:1; }","duration":"139.071685ms","start":"2026-06-18T15:43:35.840264Z","end":"2026-06-18T15:43:35.979336Z","steps":["trace[856204307] 'process raft request' (duration: 138.07228ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:22.811825Z","caller":"traceutil/trace.go:171","msg":"trace[904871603] linearizableReadLoop","detail":"{readStateIndex:19200; appliedIndex:19199; }","duration":"104.001711ms","start":"2026-06-18T15:45:22.707791Z","end":"2026-06-18T15:45:22.811793Z","steps":["trace[904871603] 'read index received' (duration: 103.723344ms)","trace[904871603] 'applied index is now lower than readState.Index' (duration: 276.717µs)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:45:22.812024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.199386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-18T15:45:22.812084Z","caller":"traceutil/trace.go:171","msg":"trace[22847900] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:18564; }","duration":"104.287408ms","start":"2026-06-18T15:45:22.707784Z","end":"2026-06-18T15:45:22.812072Z","steps":["trace[22847900] 'agreement among raft nodes before linearized reading' (duration: 104.128414ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:22.812523Z","caller":"traceutil/trace.go:171","msg":"trace[1954542052] transaction","detail":"{read_only:false; response_revision:18564; number_of_response:1; }","duration":"176.185087ms","start":"2026-06-18T15:45:22.636294Z","end":"2026-06-18T15:45:22.812479Z","steps":["trace[1954542052] 'process raft request' (duration: 175.269824ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:22.961372Z","caller":"traceutil/trace.go:171","msg":"trace[478625340] linearizableReadLoop","detail":"{readStateIndex:19201; appliedIndex:19200; }","duration":"125.471373ms","start":"2026-06-18T15:45:22.835878Z","end":"2026-06-18T15:45:22.961349Z","steps":["trace[478625340] 'read index received' (duration: 87.622062ms)","trace[478625340] 'applied index is now lower than readState.Index' (duration: 37.848181ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:45:22.961511Z","caller":"traceutil/trace.go:171","msg":"trace[1834321905] transaction","detail":"{read_only:false; response_revision:18565; number_of_response:1; }","duration":"128.525518ms","start":"2026-06-18T15:45:22.832971Z","end":"2026-06-18T15:45:22.961497Z","steps":["trace[1834321905] 'process raft request' (duration: 90.562414ms)","trace[1834321905] 'compare' (duration: 37.441991ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:45:22.961706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.445246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-18T15:45:22.961783Z","caller":"traceutil/trace.go:171","msg":"trace[1571500518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18566; }","duration":"112.584099ms","start":"2026-06-18T15:45:22.849179Z","end":"2026-06-18T15:45:22.961763Z","steps":["trace[1571500518] 'agreement among raft nodes before linearized reading' (duration: 112.415735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:45:22.961987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.194243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-18T15:45:22.962028Z","caller":"traceutil/trace.go:171","msg":"trace[1551940205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18566; }","duration":"108.273895ms","start":"2026-06-18T15:45:22.853742Z","end":"2026-06-18T15:45:22.962015Z","steps":["trace[1551940205] 'agreement among raft nodes before linearized reading' (duration: 108.182333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:45:22.962018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.101138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-18T15:45:22.962108Z","caller":"traceutil/trace.go:171","msg":"trace[1208174932] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18566; }","duration":"126.228701ms","start":"2026-06-18T15:45:22.835858Z","end":"2026-06-18T15:45:22.962086Z","steps":["trace[1208174932] 'agreement among raft nodes before linearized reading' (duration: 125.941494ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:23.564914Z","caller":"traceutil/trace.go:171","msg":"trace[1436810251] transaction","detail":"{read_only:false; response_revision:18568; number_of_response:1; }","duration":"595.471867ms","start":"2026-06-18T15:45:22.9694Z","end":"2026-06-18T15:45:23.564872Z","steps":["trace[1436810251] 'process raft request' (duration: 594.985046ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:23.565048Z","caller":"traceutil/trace.go:171","msg":"trace[1364852078] transaction","detail":"{read_only:false; response_revision:18570; number_of_response:1; }","duration":"582.581515ms","start":"2026-06-18T15:45:22.982435Z","end":"2026-06-18T15:45:23.565016Z","steps":["trace[1364852078] 'process raft request' (duration: 582.414311ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:23.565075Z","caller":"traceutil/trace.go:171","msg":"trace[1150905204] linearizableReadLoop","detail":"{readStateIndex:19207; appliedIndex:19203; }","duration":"481.495865ms","start":"2026-06-18T15:45:23.083558Z","end":"2026-06-18T15:45:23.565054Z","steps":["trace[1150905204] 'read index received' (duration: 480.825159ms)","trace[1150905204] 'applied index is now lower than readState.Index' (duration: 669.906µs)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:45:23.565107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:45:22.969391Z","time spent":"595.614031ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:45:23.565235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:45:22.982399Z","time spent":"582.727979ms","remote":"127.0.0.1:49616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20853,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:45:23.565093Z","caller":"traceutil/trace.go:171","msg":"trace[1419158737] transaction","detail":"{read_only:false; response_revision:18569; number_of_response:1; }","duration":"595.57114ms","start":"2026-06-18T15:45:22.969449Z","end":"2026-06-18T15:45:23.565021Z","steps":["trace[1419158737] 'process raft request' (duration: 595.303744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:45:23.565502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.942066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-18T15:45:23.565497Z","caller":"traceutil/trace.go:171","msg":"trace[487425403] transaction","detail":"{read_only:false; response_revision:18571; number_of_response:1; }","duration":"582.173844ms","start":"2026-06-18T15:45:22.983212Z","end":"2026-06-18T15:45:23.565386Z","steps":["trace[487425403] 'process raft request' (duration: 581.742073ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:23.565561Z","caller":"traceutil/trace.go:171","msg":"trace[1897754961] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:18571; }","duration":"482.05711ms","start":"2026-06-18T15:45:23.083489Z","end":"2026-06-18T15:45:23.565546Z","steps":["trace[1897754961] 'agreement among raft nodes before linearized reading' (duration: 481.967186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:45:23.565601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:45:23.083469Z","time spent":"482.120461ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-18T15:45:23.565618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:45:22.983176Z","time spent":"582.38608ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:45:23.565617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:45:22.969421Z","time spent":"596.066081ms","remote":"127.0.0.1:49706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:45:23.810847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.911771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"warn","ts":"2026-06-18T15:45:23.810848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.515584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-18T15:45:23.810857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.991763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-18T15:45:23.810915Z","caller":"traceutil/trace.go:171","msg":"trace[1722956013] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18571; }","duration":"158.054655ms","start":"2026-06-18T15:45:23.652846Z","end":"2026-06-18T15:45:23.8109Z","steps":["trace[1722956013] 'range keys from in-memory index tree' (duration: 157.714296ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:23.810935Z","caller":"traceutil/trace.go:171","msg":"trace[1454439011] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18571; }","duration":"236.665308ms","start":"2026-06-18T15:45:23.57425Z","end":"2026-06-18T15:45:23.810916Z","steps":["trace[1454439011] 'range keys from in-memory index tree' (duration: 236.297738ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:45:23.810959Z","caller":"traceutil/trace.go:171","msg":"trace[281116505] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:18571; }","duration":"137.146137ms","start":"2026-06-18T15:45:23.673787Z","end":"2026-06-18T15:45:23.810933Z","steps":["trace[281116505] 'count revisions from in-memory index tree' (duration: 136.878831ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:47:04.127701Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17078} {"level":"info","ts":"2026-06-18T15:47:04.2252Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17078,"took":"92.790677ms","hash":2113324971,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":31027200,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-18T15:47:04.225283Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2113324971,"revision":17078,"compact-revision":14609} {"level":"info","ts":"2026-06-18T15:47:16.195662Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-18T15:47:16.201089Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-18T15:47:16.201235Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-18T15:52:04.133282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19267} {"level":"info","ts":"2026-06-18T15:52:04.241438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19267,"took":"105.114525ms","hash":735710505,"current-db-size-bytes":57696256,"current-db-size":"58 MB","current-db-size-in-use-bytes":25579520,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-18T15:52:04.241545Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":735710505,"revision":19267,"compact-revision":17078}