{"level":"warn","ts":"2026-04-23T21:44:47.956523Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-23T21:44:47.956651Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-04-23T21:44:47.956799Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-23T21:44:47.956816Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-23T21:44:47.956851Z","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-04-23T21:44:47.957984Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-04-23T21:44:47.958087Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-04-23T21:44:47.962518Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.142295ms"} {"level":"info","ts":"2026-04-23T21:44:47.970534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-04-23T21:44:47.970658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T21:44:47.970691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-04-23T21:44:47.970708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T21:44:47.970721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-04-23T21:44:47.970769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-04-23T21:44:47.976687Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T21:44:47.979195Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T21:44:47.980603Z","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-04-23T21:44:47.982835Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T21:44:47.983042Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T21:44:47.983209Z","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-04-23T21:44:47.98328Z","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-04-23T21:44:47.983291Z","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-04-23T21:44:47.987498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-04-23T21:44:47.987988Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-23T21:44:47.990552Z","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-04-23T21:44:47.990595Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-23T21:44:47.990651Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-23T21:44:47.99094Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T21:44:47.990904Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T21:44:48.570946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T21:44:48.571031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T21:44:48.571086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-04-23T21:44:48.57111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-04-23T21:44:48.571123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-23T21:44:48.571142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-04-23T21:44:48.571224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-23T21:44:48.572169Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T21:44:48.572801Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T21:44:48.57292Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T21:44:48.572952Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T21:44:48.573233Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T21:44:48.573251Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T21:44:48.574482Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T21:44:48.574731Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T21:44:48.574867Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T21:44:48.576068Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T21:44:48.577886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-04-23T21:45:02.305663Z","caller":"traceutil/trace.go:171","msg":"trace[250773417] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"176.836212ms","start":"2026-04-23T21:45:02.128802Z","end":"2026-04-23T21:45:02.305639Z","steps":["trace[250773417] 'process raft request' (duration: 176.487859ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:08.086154Z","caller":"traceutil/trace.go:171","msg":"trace[417624706] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"153.341336ms","start":"2026-04-23T21:45:07.932778Z","end":"2026-04-23T21:45:08.086119Z","steps":["trace[417624706] 'process raft request' (duration: 152.701384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:09.507669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.309825524s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:09.507938Z","caller":"traceutil/trace.go:171","msg":"trace[1508748771] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:410; }","duration":"1.310112604s","start":"2026-04-23T21:45:08.197805Z","end":"2026-04-23T21:45:09.507918Z","steps":["trace[1508748771] 'range keys from in-memory index tree' (duration: 1.309800153s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:09.508045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178173492s","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-04-23T21:45:09.508057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129952407s","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-04-23T21:45:09.50816Z","caller":"traceutil/trace.go:171","msg":"trace[1215248637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:410; }","duration":"1.17835622s","start":"2026-04-23T21:45:08.329786Z","end":"2026-04-23T21:45:09.508142Z","steps":["trace[1215248637] 'range keys from in-memory index tree' (duration: 1.178051858s)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:09.508184Z","caller":"traceutil/trace.go:171","msg":"trace[109256920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:410; }","duration":"1.130137124s","start":"2026-04-23T21:45:08.378024Z","end":"2026-04-23T21:45:09.508161Z","steps":["trace[109256920] 'range keys from in-memory index tree' (duration: 1.129843072s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:09.508202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:08.329761Z","time spent":"1.178435064s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T21:45:09.50824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:08.377998Z","time spent":"1.130221977s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T21:45:09.508245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.89987ms","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-04-23T21:45:09.508447Z","caller":"traceutil/trace.go:171","msg":"trace[1903020319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:410; }","duration":"500.108688ms","start":"2026-04-23T21:45:09.008249Z","end":"2026-04-23T21:45:09.508357Z","steps":["trace[1903020319] 'range keys from in-memory index tree' (duration: 499.700094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:09.508545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:09.008232Z","time spent":"500.297715ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T21:45:09.808813Z","caller":"traceutil/trace.go:171","msg":"trace[1360655092] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"295.689503ms","start":"2026-04-23T21:45:09.51307Z","end":"2026-04-23T21:45:09.808759Z","steps":["trace[1360655092] 'process raft request' (duration: 295.455425ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:09.901036Z","caller":"traceutil/trace.go:171","msg":"trace[1351625930] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"387.506192ms","start":"2026-04-23T21:45:09.513483Z","end":"2026-04-23T21:45:09.900989Z","steps":["trace[1351625930] 'process raft request' (duration: 351.182022ms)","trace[1351625930] 'compare' (duration: 36.117332ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:45:09.90118Z","caller":"traceutil/trace.go:171","msg":"trace[12777777] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"386.88383ms","start":"2026-04-23T21:45:09.514265Z","end":"2026-04-23T21:45:09.901149Z","steps":["trace[12777777] 'process raft request' (duration: 386.668943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:09.902196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:09.51347Z","time spent":"388.020171ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:45:09.902387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:09.514256Z","time spent":"387.365618ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:45:19.185342Z","caller":"traceutil/trace.go:171","msg":"trace[395673987] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"252.197897ms","start":"2026-04-23T21:45:18.933003Z","end":"2026-04-23T21:45:19.185201Z","steps":["trace[395673987] 'process raft request' (duration: 251.965409ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.191971Z","caller":"traceutil/trace.go:171","msg":"trace[981310118] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"247.14933ms","start":"2026-04-23T21:45:18.944786Z","end":"2026-04-23T21:45:19.191935Z","steps":["trace[981310118] 'process raft request' (duration: 246.130641ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.192144Z","caller":"traceutil/trace.go:171","msg":"trace[1539505874] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"247.259803ms","start":"2026-04-23T21:45:18.944874Z","end":"2026-04-23T21:45:19.192134Z","steps":["trace[1539505874] 'process raft request' (duration: 246.180232ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.193403Z","caller":"traceutil/trace.go:171","msg":"trace[992450226] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"202.266741ms","start":"2026-04-23T21:45:18.991092Z","end":"2026-04-23T21:45:19.193359Z","steps":["trace[992450226] 'process raft request' (duration: 200.235335ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.193626Z","caller":"traceutil/trace.go:171","msg":"trace[678003562] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"208.210703ms","start":"2026-04-23T21:45:18.985346Z","end":"2026-04-23T21:45:19.193556Z","steps":["trace[678003562] 'process raft request' (duration: 205.847475ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.193775Z","caller":"traceutil/trace.go:171","msg":"trace[1564482957] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"187.52177ms","start":"2026-04-23T21:45:19.00624Z","end":"2026-04-23T21:45:19.193762Z","steps":["trace[1564482957] 'process raft request' (duration: 185.139331ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.193866Z","caller":"traceutil/trace.go:171","msg":"trace[192968202] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"175.706157ms","start":"2026-04-23T21:45:19.018152Z","end":"2026-04-23T21:45:19.193858Z","steps":["trace[192968202] 'process raft request' (duration: 173.297877ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.193843Z","caller":"traceutil/trace.go:171","msg":"trace[1692829705] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"220.733151ms","start":"2026-04-23T21:45:18.973044Z","end":"2026-04-23T21:45:19.193777Z","steps":["trace[1692829705] 'process raft request' (duration: 218.062871ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.194346Z","caller":"traceutil/trace.go:171","msg":"trace[1699875348] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"211.811418ms","start":"2026-04-23T21:45:18.982525Z","end":"2026-04-23T21:45:19.194336Z","steps":["trace[1699875348] 'process raft request' (duration: 208.625199ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.193674Z","caller":"traceutil/trace.go:171","msg":"trace[710329523] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"203.863071ms","start":"2026-04-23T21:45:18.9898Z","end":"2026-04-23T21:45:19.193663Z","steps":["trace[710329523] 'process raft request' (duration: 201.438451ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:19.194849Z","caller":"traceutil/trace.go:171","msg":"trace[1744637529] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"203.904832ms","start":"2026-04-23T21:45:18.98979Z","end":"2026-04-23T21:45:19.193695Z","steps":["trace[1744637529] 'process raft request' (duration: 201.490452ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:25.472721Z","caller":"traceutil/trace.go:171","msg":"trace[1224545731] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"132.763832ms","start":"2026-04-23T21:45:25.339922Z","end":"2026-04-23T21:45:25.472685Z","steps":["trace[1224545731] 'process raft request' (duration: 132.170079ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:25.788637Z","caller":"traceutil/trace.go:171","msg":"trace[1675144146] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"257.088766ms","start":"2026-04-23T21:45:25.531438Z","end":"2026-04-23T21:45:25.788527Z","steps":["trace[1675144146] 'process raft request' (duration: 224.212967ms)","trace[1675144146] 'compare' (duration: 32.712003ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:45:26.309446Z","caller":"traceutil/trace.go:171","msg":"trace[1031404812] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"353.159147ms","start":"2026-04-23T21:45:25.956205Z","end":"2026-04-23T21:45:26.309364Z","steps":["trace[1031404812] 'read index received' (duration: 341.610931ms)","trace[1031404812] 'applied index is now lower than readState.Index' (duration: 11.546336ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:45:26.309793Z","caller":"traceutil/trace.go:171","msg":"trace[1623696846] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"503.855674ms","start":"2026-04-23T21:45:25.80587Z","end":"2026-04-23T21:45:26.309726Z","steps":["trace[1623696846] 'process raft request' (duration: 491.861862ms)","trace[1623696846] 'compare' (duration: 11.420521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:45:26.309995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:25.80584Z","time spent":"504.037292ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:45:26.310755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.528358ms","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-04-23T21:45:26.310848Z","caller":"traceutil/trace.go:171","msg":"trace[1717949038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"354.672064ms","start":"2026-04-23T21:45:25.95614Z","end":"2026-04-23T21:45:26.310812Z","steps":["trace[1717949038] 'agreement among raft nodes before linearized reading' (duration: 353.965847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:26.310885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:25.956109Z","time spent":"354.767198ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-23T21:45:26.351738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.272448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-23T21:45:26.351765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.427277ms","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-04-23T21:45:26.351842Z","caller":"traceutil/trace.go:171","msg":"trace[817596841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"171.457076ms","start":"2026-04-23T21:45:26.18036Z","end":"2026-04-23T21:45:26.351817Z","steps":["trace[817596841] 'agreement among raft nodes before linearized reading' (duration: 171.172705ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:26.351864Z","caller":"traceutil/trace.go:171","msg":"trace[100146915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"358.615015ms","start":"2026-04-23T21:45:25.993218Z","end":"2026-04-23T21:45:26.351833Z","steps":["trace[100146915] 'agreement among raft nodes before linearized reading' (duration: 358.299643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:26.351911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:25.993187Z","time spent":"358.714609ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T21:45:26.352078Z","caller":"traceutil/trace.go:171","msg":"trace[202818423] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"147.565295ms","start":"2026-04-23T21:45:26.204499Z","end":"2026-04-23T21:45:26.352064Z","steps":["trace[202818423] 'process raft request' (duration: 146.252146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:26.352196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.889217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:26.352236Z","caller":"traceutil/trace.go:171","msg":"trace[1229660239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"287.964179ms","start":"2026-04-23T21:45:26.06426Z","end":"2026-04-23T21:45:26.352224Z","steps":["trace[1229660239] 'agreement among raft nodes before linearized reading' (duration: 287.902017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:26.352329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.71719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-23T21:45:26.352438Z","caller":"traceutil/trace.go:171","msg":"trace[598139552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"353.898326ms","start":"2026-04-23T21:45:25.998506Z","end":"2026-04-23T21:45:26.352404Z","steps":["trace[598139552] 'agreement among raft nodes before linearized reading' (duration: 353.572984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:26.352485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:25.998477Z","time spent":"353.997099ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T21:45:27.360024Z","caller":"traceutil/trace.go:171","msg":"trace[966064626] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.002540552s","start":"2026-04-23T21:45:26.357451Z","end":"2026-04-23T21:45:27.359991Z","steps":["trace[966064626] 'process raft request' (duration: 952.71836ms)","trace[966064626] 'compare' (duration: 49.453847ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:45:27.360202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:26.357416Z","time spent":"1.002688817s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:45:27.369834Z","caller":"traceutil/trace.go:171","msg":"trace[1895755864] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.005789195s","start":"2026-04-23T21:45:26.364021Z","end":"2026-04-23T21:45:27.36981Z","steps":["trace[1895755864] 'process raft request' (duration: 1.005476003s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.369906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:26.363988Z","time spent":"1.005882568s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:45:27.370387Z","caller":"traceutil/trace.go:171","msg":"trace[220921920] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"956.720294ms","start":"2026-04-23T21:45:26.413658Z","end":"2026-04-23T21:45:27.370378Z","steps":["trace[220921920] 'process raft request' (duration: 956.536367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.370436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:26.413621Z","time spent":"956.794296ms","remote":"127.0.0.1:51122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T21:45:27.370638Z","caller":"traceutil/trace.go:171","msg":"trace[1025364841] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.006120186s","start":"2026-04-23T21:45:26.364299Z","end":"2026-04-23T21:45:27.37042Z","steps":["trace[1025364841] 'process raft request' (duration: 1.005351208s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.370929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:26.364038Z","time spent":"1.006683108s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:45:27.379417Z","caller":"traceutil/trace.go:171","msg":"trace[2054354676] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:604; }","duration":"437.980561ms","start":"2026-04-23T21:45:26.941398Z","end":"2026-04-23T21:45:27.379378Z","steps":["trace[2054354676] 'read index received' (duration: 368.796619ms)","trace[2054354676] 'applied index is now lower than readState.Index' (duration: 69.181832ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:45:27.379579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.156267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:27.379665Z","caller":"traceutil/trace.go:171","msg":"trace[373066740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"438.291812ms","start":"2026-04-23T21:45:26.941353Z","end":"2026-04-23T21:45:27.379645Z","steps":["trace[373066740] 'agreement among raft nodes before linearized reading' (duration: 438.127536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.379716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:26.941329Z","time spent":"438.381176ms","remote":"127.0.0.1:34570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T21:45:27.379715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.994497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:27.379769Z","caller":"traceutil/trace.go:171","msg":"trace[1673314054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"312.050709ms","start":"2026-04-23T21:45:27.067704Z","end":"2026-04-23T21:45:27.379755Z","steps":["trace[1673314054] 'agreement among raft nodes before linearized reading' (duration: 311.962226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.379809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:27.067615Z","time spent":"312.187284ms","remote":"127.0.0.1:34572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T21:45:27.37994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.208413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:27.380011Z","caller":"traceutil/trace.go:171","msg":"trace[1129785177] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"127.328756ms","start":"2026-04-23T21:45:27.252667Z","end":"2026-04-23T21:45:27.379996Z","steps":["trace[1129785177] 'agreement among raft nodes before linearized reading' (duration: 127.195371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.380025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.68969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:27.380068Z","caller":"traceutil/trace.go:171","msg":"trace[184157193] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"127.772982ms","start":"2026-04-23T21:45:27.252283Z","end":"2026-04-23T21:45:27.380056Z","steps":["trace[184157193] 'agreement among raft nodes before linearized reading' (duration: 127.70301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:27.380207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.940099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:45:27.380246Z","caller":"traceutil/trace.go:171","msg":"trace[1718456925] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"127.999771ms","start":"2026-04-23T21:45:27.252235Z","end":"2026-04-23T21:45:27.380235Z","steps":["trace[1718456925] 'agreement among raft nodes before linearized reading' (duration: 127.925848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:40.744955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.388402ms","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-04-23T21:45:40.745067Z","caller":"traceutil/trace.go:171","msg":"trace[2052749080] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:725; }","duration":"108.569638ms","start":"2026-04-23T21:45:40.636473Z","end":"2026-04-23T21:45:40.745043Z","steps":["trace[2052749080] 'range keys from in-memory index tree' (duration: 108.170143ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:43.02823Z","caller":"traceutil/trace.go:171","msg":"trace[619536073] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:770; }","duration":"152.987478ms","start":"2026-04-23T21:45:42.875204Z","end":"2026-04-23T21:45:43.028191Z","steps":["trace[619536073] 'read index received' (duration: 152.648416ms)","trace[619536073] 'applied index is now lower than readState.Index' (duration: 337.552µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:45:43.028299Z","caller":"traceutil/trace.go:171","msg":"trace[1262919218] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"225.801536ms","start":"2026-04-23T21:45:42.802444Z","end":"2026-04-23T21:45:43.028246Z","steps":["trace[1262919218] 'process raft request' (duration: 225.531736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:43.028691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.428405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jtf6f\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-23T21:45:43.028815Z","caller":"traceutil/trace.go:171","msg":"trace[561660688] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jtf6f; range_end:; response_count:1; response_revision:741; }","duration":"153.636543ms","start":"2026-04-23T21:45:42.875149Z","end":"2026-04-23T21:45:43.028785Z","steps":["trace[561660688] 'agreement among raft nodes before linearized reading' (duration: 153.206667ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:43.594896Z","caller":"traceutil/trace.go:171","msg":"trace[1658982338] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"557.696307ms","start":"2026-04-23T21:45:43.037166Z","end":"2026-04-23T21:45:43.594862Z","steps":["trace[1658982338] 'process raft request' (duration: 557.418946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:43.59513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.749355ms","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-04-23T21:45:43.595202Z","caller":"traceutil/trace.go:171","msg":"trace[1357031383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:742; }","duration":"150.903461ms","start":"2026-04-23T21:45:43.444287Z","end":"2026-04-23T21:45:43.59519Z","steps":["trace[1357031383] 'agreement among raft nodes before linearized reading' (duration: 150.654702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:45:43.595128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:45:43.037133Z","time spent":"557.886404ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:45:43.594886Z","caller":"traceutil/trace.go:171","msg":"trace[1238281472] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:771; }","duration":"150.467386ms","start":"2026-04-23T21:45:43.444359Z","end":"2026-04-23T21:45:43.594827Z","steps":["trace[1238281472] 'read index received' (duration: 150.107551ms)","trace[1238281472] 'applied index is now lower than readState.Index' (duration: 358.485µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:45:43.59686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.936124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-23T21:45:43.597021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.992286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-23T21:45:43.5972Z","caller":"traceutil/trace.go:171","msg":"trace[1272582911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:742; }","duration":"151.205294ms","start":"2026-04-23T21:45:43.445965Z","end":"2026-04-23T21:45:43.597171Z","steps":["trace[1272582911] 'agreement among raft nodes before linearized reading' (duration: 150.979455ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:45:43.596901Z","caller":"traceutil/trace.go:171","msg":"trace[1592095046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:742; }","duration":"151.026006ms","start":"2026-04-23T21:45:43.445863Z","end":"2026-04-23T21:45:43.596889Z","steps":["trace[1592095046] 'agreement among raft nodes before linearized reading' (duration: 150.908482ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:46:17.574024Z","caller":"traceutil/trace.go:171","msg":"trace[1549682821] linearizableReadLoop","detail":"{readStateIndex:1198; appliedIndex:1197; }","duration":"317.616848ms","start":"2026-04-23T21:46:17.256375Z","end":"2026-04-23T21:46:17.573991Z","steps":["trace[1549682821] 'read index received' (duration: 292.427661ms)","trace[1549682821] 'applied index is now lower than readState.Index' (duration: 25.187687ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:46:17.57426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.25659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T21:46:17.574305Z","caller":"traceutil/trace.go:171","msg":"trace[1668468714] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1160; }","duration":"310.366501ms","start":"2026-04-23T21:46:17.263928Z","end":"2026-04-23T21:46:17.574294Z","steps":["trace[1668468714] 'agreement among raft nodes before linearized reading' (duration: 310.24834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:46:17.574356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:46:17.263909Z","time spent":"310.436872ms","remote":"127.0.0.1:51370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":2,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-23T21:46:17.574759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.341765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-23T21:46:17.574875Z","caller":"traceutil/trace.go:171","msg":"trace[1513842274] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1160; }","duration":"318.536698ms","start":"2026-04-23T21:46:17.256315Z","end":"2026-04-23T21:46:17.574852Z","steps":["trace[1513842274] 'agreement among raft nodes before linearized reading' (duration: 317.815341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:46:17.574928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:46:17.256286Z","time spent":"318.632859ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-23T21:47:07.471434Z","caller":"traceutil/trace.go:171","msg":"trace[1437243926] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"104.461807ms","start":"2026-04-23T21:47:07.366886Z","end":"2026-04-23T21:47:07.471347Z","steps":["trace[1437243926] 'process raft request' (duration: 104.236102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.08767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.200875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T21:47:08.087851Z","caller":"traceutil/trace.go:171","msg":"trace[1607577321] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"601.728146ms","start":"2026-04-23T21:47:07.486105Z","end":"2026-04-23T21:47:08.087833Z","steps":["trace[1607577321] 'process raft request' (duration: 497.158552ms)","trace[1607577321] 'compare' (duration: 103.905038ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:47:08.088007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:07.486088Z","time spent":"601.842708ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:47:08.150719Z","caller":"traceutil/trace.go:171","msg":"trace[669263872] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1922; }","duration":"280.528362ms","start":"2026-04-23T21:47:07.870155Z","end":"2026-04-23T21:47:08.150684Z","steps":["trace[669263872] 'read index received' (duration: 113.122852ms)","trace[669263872] 'applied index is now lower than readState.Index' (duration: 167.40382ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:47:08.150747Z","caller":"traceutil/trace.go:171","msg":"trace[1880763888] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"573.519981ms","start":"2026-04-23T21:47:07.577191Z","end":"2026-04-23T21:47:08.150711Z","steps":["trace[1880763888] 'process raft request' (duration: 573.220583ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:08.150858Z","caller":"traceutil/trace.go:171","msg":"trace[329062759] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"472.70943ms","start":"2026-04-23T21:47:07.678086Z","end":"2026-04-23T21:47:08.150796Z","steps":["trace[329062759] 'process raft request' (duration: 472.533886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.151052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:07.678048Z","time spent":"472.902204ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:47:08.151138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.942411ms","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-04-23T21:47:08.151221Z","caller":"traceutil/trace.go:171","msg":"trace[344126700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1849; }","duration":"281.122745ms","start":"2026-04-23T21:47:07.870084Z","end":"2026-04-23T21:47:08.151207Z","steps":["trace[344126700] 'agreement among raft nodes before linearized reading' (duration: 280.758497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.151131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:07.577159Z","time spent":"573.667834ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:47:08.582656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.335302ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:47:08.582797Z","caller":"traceutil/trace.go:171","msg":"trace[95493653] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1849; }","duration":"385.494056ms","start":"2026-04-23T21:47:08.197283Z","end":"2026-04-23T21:47:08.582777Z","steps":["trace[95493653] 'range keys from in-memory index tree' (duration: 385.316732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.583112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.040781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T21:47:08.584401Z","caller":"traceutil/trace.go:171","msg":"trace[1723980897] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"489.05301ms","start":"2026-04-23T21:47:08.095313Z","end":"2026-04-23T21:47:08.584366Z","steps":["trace[1723980897] 'process raft request' (duration: 303.658747ms)","trace[1723980897] 'compare' (duration: 183.427146ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:47:08.584657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.095297Z","time spent":"489.175342ms","remote":"127.0.0.1:51150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:47:08.585293Z","caller":"traceutil/trace.go:171","msg":"trace[1518405041] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"489.93875ms","start":"2026-04-23T21:47:08.095323Z","end":"2026-04-23T21:47:08.585262Z","steps":["trace[1518405041] 'process raft request' (duration: 488.980668ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:08.585696Z","caller":"traceutil/trace.go:171","msg":"trace[910638025] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"428.178021ms","start":"2026-04-23T21:47:08.157503Z","end":"2026-04-23T21:47:08.585681Z","steps":["trace[910638025] 'process raft request' (duration: 428.12412ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:08.585719Z","caller":"traceutil/trace.go:171","msg":"trace[899237658] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"490.247738ms","start":"2026-04-23T21:47:08.095455Z","end":"2026-04-23T21:47:08.585703Z","steps":["trace[899237658] 'process raft request' (duration: 490.042243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.58583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.157484Z","time spent":"428.256634ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:47:08.586009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.095313Z","time spent":"490.066965ms","remote":"127.0.0.1:34746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:47:08.585908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.095433Z","time spent":"490.32237ms","remote":"127.0.0.1:34746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:47:08.586087Z","caller":"traceutil/trace.go:171","msg":"trace[448618696] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1925; }","duration":"435.26472ms","start":"2026-04-23T21:47:08.150808Z","end":"2026-04-23T21:47:08.586073Z","steps":["trace[448618696] 'read index received' (duration: 248.27909ms)","trace[448618696] 'applied index is now lower than readState.Index' (duration: 186.98409ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:47:08.58626Z","caller":"traceutil/trace.go:171","msg":"trace[1900922460] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"490.852993ms","start":"2026-04-23T21:47:08.095392Z","end":"2026-04-23T21:47:08.586245Z","steps":["trace[1900922460] 'process raft request' (duration: 489.742696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.586305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.206719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-23T21:47:08.586324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.095365Z","time spent":"490.921924ms","remote":"127.0.0.1:51150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:47:08.586339Z","caller":"traceutil/trace.go:171","msg":"trace[165226379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1854; }","duration":"530.260771ms","start":"2026-04-23T21:47:08.05607Z","end":"2026-04-23T21:47:08.58633Z","steps":["trace[165226379] 'agreement among raft nodes before linearized reading' (duration: 530.157749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.586363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.056057Z","time spent":"530.301492ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T21:47:08.586449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.877914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T21:47:08.586399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.424824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:47:08.586473Z","caller":"traceutil/trace.go:171","msg":"trace[204943072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1854; }","duration":"519.951126ms","start":"2026-04-23T21:47:08.066516Z","end":"2026-04-23T21:47:08.586467Z","steps":["trace[204943072] 'agreement among raft nodes before linearized reading' (duration: 519.918485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.586489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.066486Z","time spent":"519.999567ms","remote":"127.0.0.1:34570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T21:47:08.586487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.32605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-23T21:47:08.586498Z","caller":"traceutil/trace.go:171","msg":"trace[995416306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1854; }","duration":"464.571207ms","start":"2026-04-23T21:47:08.121906Z","end":"2026-04-23T21:47:08.586477Z","steps":["trace[995416306] 'agreement among raft nodes before linearized reading' (duration: 464.440484ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:08.58654Z","caller":"traceutil/trace.go:171","msg":"trace[2130455665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1854; }","duration":"532.424992ms","start":"2026-04-23T21:47:08.054101Z","end":"2026-04-23T21:47:08.586526Z","steps":["trace[2130455665] 'agreement among raft nodes before linearized reading' (duration: 532.249478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.586551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.121877Z","time spent":"464.655878ms","remote":"127.0.0.1:60128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-23T21:47:08.586583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.054074Z","time spent":"532.497763ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T21:47:08.586641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.129737ms","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-04-23T21:47:08.586659Z","caller":"traceutil/trace.go:171","msg":"trace[926106347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1854; }","duration":"527.190248ms","start":"2026-04-23T21:47:08.059463Z","end":"2026-04-23T21:47:08.586653Z","steps":["trace[926106347] 'agreement among raft nodes before linearized reading' (duration: 527.123587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.586678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:08.059443Z","time spent":"527.231179ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T21:47:08.586752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.765019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:47:08.586769Z","caller":"traceutil/trace.go:171","msg":"trace[1263812739] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1854; }","duration":"709.902853ms","start":"2026-04-23T21:47:07.87686Z","end":"2026-04-23T21:47:08.586763Z","steps":["trace[1263812739] 'agreement among raft nodes before linearized reading' (duration: 709.866272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:08.58676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.793349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b19fde81-3a73-4810-a164-cb80807a1128\" ","response":"range_response_count:1 size:3747"} {"level":"warn","ts":"2026-04-23T21:47:08.586766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.466932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T21:47:08.586788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:07.876826Z","time spent":"709.956373ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-04-23T21:47:08.586761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.536359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-23T21:47:08.586971Z","caller":"traceutil/trace.go:171","msg":"trace[943974553] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1854; }","duration":"220.808786ms","start":"2026-04-23T21:47:08.366144Z","end":"2026-04-23T21:47:08.586953Z","steps":["trace[943974553] 'agreement among raft nodes before linearized reading' (duration: 220.421266ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:08.586807Z","caller":"traceutil/trace.go:171","msg":"trace[66296790] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1854; }","duration":"124.534684ms","start":"2026-04-23T21:47:08.462262Z","end":"2026-04-23T21:47:08.586797Z","steps":["trace[66296790] 'agreement among raft nodes before linearized reading' (duration: 124.458313ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:08.586805Z","caller":"traceutil/trace.go:171","msg":"trace[2071650362] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b19fde81-3a73-4810-a164-cb80807a1128; range_end:; response_count:1; response_revision:1854; }","duration":"100.85465ms","start":"2026-04-23T21:47:08.485938Z","end":"2026-04-23T21:47:08.586793Z","steps":["trace[2071650362] 'agreement among raft nodes before linearized reading' (duration: 100.707186ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:21.025517Z","caller":"traceutil/trace.go:171","msg":"trace[6383400] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"182.134214ms","start":"2026-04-23T21:47:20.843349Z","end":"2026-04-23T21:47:21.025483Z","steps":["trace[6383400] 'process raft request' (duration: 180.101031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:21.694934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.703439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T21:47:21.695029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.30039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-04-23T21:47:21.695107Z","caller":"traceutil/trace.go:171","msg":"trace[248038852] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1959; }","duration":"398.420754ms","start":"2026-04-23T21:47:21.296666Z","end":"2026-04-23T21:47:21.695087Z","steps":["trace[248038852] 'range keys from in-memory index tree' (duration: 398.094236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:21.695154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:21.296647Z","time spent":"398.497326ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12011,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-23T21:47:21.695056Z","caller":"traceutil/trace.go:171","msg":"trace[1116104994] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1959; }","duration":"151.884563ms","start":"2026-04-23T21:47:21.543147Z","end":"2026-04-23T21:47:21.695032Z","steps":["trace[1116104994] 'count revisions from in-memory index tree' (duration: 151.591066ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:42.936345Z","caller":"traceutil/trace.go:171","msg":"trace[2047225197] linearizableReadLoop","detail":"{readStateIndex:2173; appliedIndex:2172; }","duration":"144.733506ms","start":"2026-04-23T21:47:42.791586Z","end":"2026-04-23T21:47:42.93632Z","steps":["trace[2047225197] 'read index received' (duration: 144.605582ms)","trace[2047225197] 'applied index is now lower than readState.Index' (duration: 126.474µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:47:42.936406Z","caller":"traceutil/trace.go:171","msg":"trace[1025876769] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"148.256536ms","start":"2026-04-23T21:47:42.788116Z","end":"2026-04-23T21:47:42.936373Z","steps":["trace[1025876769] 'process raft request' (duration: 148.033379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:42.936597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.390636ms","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-04-23T21:47:42.936635Z","caller":"traceutil/trace.go:171","msg":"trace[1933344394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2090; }","duration":"144.489498ms","start":"2026-04-23T21:47:42.792134Z","end":"2026-04-23T21:47:42.936624Z","steps":["trace[1933344394] 'agreement among raft nodes before linearized reading' (duration: 144.333404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:42.936661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.044734ms","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-04-23T21:47:42.936738Z","caller":"traceutil/trace.go:171","msg":"trace[1727402598] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2090; }","duration":"145.177068ms","start":"2026-04-23T21:47:42.791541Z","end":"2026-04-23T21:47:42.936718Z","steps":["trace[1727402598] 'agreement among raft nodes before linearized reading' (duration: 144.919091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:42.936811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.710693ms","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-04-23T21:47:42.93686Z","caller":"traceutil/trace.go:171","msg":"trace[1378659119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2090; }","duration":"138.788575ms","start":"2026-04-23T21:47:42.798049Z","end":"2026-04-23T21:47:42.936838Z","steps":["trace[1378659119] 'agreement among raft nodes before linearized reading' (duration: 138.558869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:42.936906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.954978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-23T21:47:42.936989Z","caller":"traceutil/trace.go:171","msg":"trace[368761388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2090; }","duration":"141.064001ms","start":"2026-04-23T21:47:42.795907Z","end":"2026-04-23T21:47:42.936971Z","steps":["trace[368761388] 'agreement among raft nodes before linearized reading' (duration: 140.844674ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:43.416959Z","caller":"traceutil/trace.go:171","msg":"trace[1005663046] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2177; }","duration":"196.132128ms","start":"2026-04-23T21:47:43.220804Z","end":"2026-04-23T21:47:43.416936Z","steps":["trace[1005663046] 'read index received' (duration: 179.627604ms)","trace[1005663046] 'applied index is now lower than readState.Index' (duration: 16.503114ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:47:43.417423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.588582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-23T21:47:43.417514Z","caller":"traceutil/trace.go:171","msg":"trace[483189256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2096; }","duration":"196.737496ms","start":"2026-04-23T21:47:43.220761Z","end":"2026-04-23T21:47:43.417499Z","steps":["trace[483189256] 'agreement among raft nodes before linearized reading' (duration: 196.393516ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:43.417451Z","caller":"traceutil/trace.go:171","msg":"trace[141753086] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"258.065439ms","start":"2026-04-23T21:47:43.159349Z","end":"2026-04-23T21:47:43.417415Z","steps":["trace[141753086] 'process raft request' (duration: 241.265586ms)","trace[141753086] 'compare' (duration: 15.590588ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:47:43.417584Z","caller":"traceutil/trace.go:171","msg":"trace[1066095241] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"240.158854ms","start":"2026-04-23T21:47:43.177385Z","end":"2026-04-23T21:47:43.417544Z","steps":["trace[1066095241] 'process raft request' (duration: 239.459714ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:44.738771Z","caller":"traceutil/trace.go:171","msg":"trace[508850950] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"306.895204ms","start":"2026-04-23T21:47:44.431789Z","end":"2026-04-23T21:47:44.738685Z","steps":["trace[508850950] 'process raft request' (duration: 245.377369ms)","trace[508850950] 'compare' (duration: 61.089633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:47:44.739056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:44.431759Z","time spent":"307.179153ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:47:45.244908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.732491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T21:47:45.245336Z","caller":"traceutil/trace.go:171","msg":"trace[2106869093] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2182; }","duration":"292.676719ms","start":"2026-04-23T21:47:44.952637Z","end":"2026-04-23T21:47:45.245314Z","steps":["trace[2106869093] 'read index received' (duration: 128.297709ms)","trace[2106869093] 'applied index is now lower than readState.Index' (duration: 164.37718ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:47:45.245496Z","caller":"traceutil/trace.go:171","msg":"trace[598830674] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"301.524285ms","start":"2026-04-23T21:47:44.943958Z","end":"2026-04-23T21:47:45.245482Z","steps":["trace[598830674] 'process raft request' (duration: 137.075543ms)","trace[598830674] 'compare' (duration: 163.454484ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:47:45.24599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:47:44.943909Z","time spent":"302.035951ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:47:45.246081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.891036ms","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-04-23T21:47:45.245783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.128912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-23T21:47:45.246292Z","caller":"traceutil/trace.go:171","msg":"trace[1512899271] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2100; }","duration":"293.699859ms","start":"2026-04-23T21:47:44.952566Z","end":"2026-04-23T21:47:45.246266Z","steps":["trace[1512899271] 'agreement among raft nodes before linearized reading' (duration: 292.947797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:45.245803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.016398ms","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-04-23T21:47:45.246591Z","caller":"traceutil/trace.go:171","msg":"trace[862313087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2100; }","duration":"204.833642ms","start":"2026-04-23T21:47:45.041731Z","end":"2026-04-23T21:47:45.246565Z","steps":["trace[862313087] 'agreement among raft nodes before linearized reading' (duration: 203.792661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:45.245882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.06467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-23T21:47:45.246791Z","caller":"traceutil/trace.go:171","msg":"trace[529262210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2100; }","duration":"204.989827ms","start":"2026-04-23T21:47:45.041791Z","end":"2026-04-23T21:47:45.246781Z","steps":["trace[529262210] 'agreement among raft nodes before linearized reading' (duration: 203.943276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:47:45.245888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.997658ms","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-04-23T21:47:45.246934Z","caller":"traceutil/trace.go:171","msg":"trace[95066412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2100; }","duration":"205.10314ms","start":"2026-04-23T21:47:45.04182Z","end":"2026-04-23T21:47:45.246923Z","steps":["trace[95066412] 'agreement among raft nodes before linearized reading' (duration: 203.882544ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:47:45.246206Z","caller":"traceutil/trace.go:171","msg":"trace[2059216900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2100; }","duration":"203.06461ms","start":"2026-04-23T21:47:45.043109Z","end":"2026-04-23T21:47:45.246174Z","steps":["trace[2059216900] 'agreement among raft nodes before linearized reading' (duration: 202.663669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:48:41.792584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.418807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T21:48:41.792686Z","caller":"traceutil/trace.go:171","msg":"trace[1462055445] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:2456; }","duration":"124.604624ms","start":"2026-04-23T21:48:41.668058Z","end":"2026-04-23T21:48:41.792663Z","steps":["trace[1462055445] 'range keys from in-memory index tree' (duration: 124.16519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:48:41.792678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.424146ms","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-04-23T21:48:41.792831Z","caller":"traceutil/trace.go:171","msg":"trace[2064110756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2456; }","duration":"102.596053ms","start":"2026-04-23T21:48:41.690186Z","end":"2026-04-23T21:48:41.792782Z","steps":["trace[2064110756] 'range keys from in-memory index tree' (duration: 102.069306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:48:50.744401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.768482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1315"} {"level":"info","ts":"2026-04-23T21:48:50.744493Z","caller":"traceutil/trace.go:171","msg":"trace[2015454275] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2558; }","duration":"334.900926ms","start":"2026-04-23T21:48:50.409572Z","end":"2026-04-23T21:48:50.744473Z","steps":["trace[2015454275] 'range keys from in-memory index tree' (duration: 334.582036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:48:50.744542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:48:50.409561Z","time spent":"334.972688ms","remote":"127.0.0.1:34774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1338,"request content":"key:\"/registry/services/specs/auth-system/keycloak\" "} {"level":"info","ts":"2026-04-23T21:48:50.768506Z","caller":"traceutil/trace.go:171","msg":"trace[1894019770] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"121.513026ms","start":"2026-04-23T21:48:50.646953Z","end":"2026-04-23T21:48:50.768466Z","steps":["trace[1894019770] 'process raft request' (duration: 121.300289ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:49:23.200548Z","caller":"traceutil/trace.go:171","msg":"trace[1046558901] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"107.42585ms","start":"2026-04-23T21:49:23.093091Z","end":"2026-04-23T21:49:23.200517Z","steps":["trace[1046558901] 'process raft request' (duration: 107.258075ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:49:23.846612Z","caller":"traceutil/trace.go:171","msg":"trace[5058719] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"190.398989ms","start":"2026-04-23T21:49:23.656186Z","end":"2026-04-23T21:49:23.846585Z","steps":["trace[5058719] 'process raft request' (duration: 190.225293ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:49:23.847303Z","caller":"traceutil/trace.go:171","msg":"trace[1995991261] linearizableReadLoop","detail":"{readStateIndex:2844; appliedIndex:2844; }","duration":"141.555784ms","start":"2026-04-23T21:49:23.705734Z","end":"2026-04-23T21:49:23.84729Z","steps":["trace[1995991261] 'read index received' (duration: 141.551004ms)","trace[1995991261] 'applied index is now lower than readState.Index' (duration: 3.9µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:49:23.847998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.248958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a91ac0e21331c5\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-04-23T21:49:23.848046Z","caller":"traceutil/trace.go:171","msg":"trace[1123850127] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a91ac0e21331c5; range_end:; response_count:1; response_revision:2738; }","duration":"142.362171ms","start":"2026-04-23T21:49:23.705672Z","end":"2026-04-23T21:49:23.848034Z","steps":["trace[1123850127] 'agreement among raft nodes before linearized reading' (duration: 142.185985ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:49:24.10978Z","caller":"traceutil/trace.go:171","msg":"trace[1797794493] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"334.7076ms","start":"2026-04-23T21:49:23.77503Z","end":"2026-04-23T21:49:24.109737Z","steps":["trace[1797794493] 'process raft request' (duration: 273.272135ms)","trace[1797794493] 'compare' (duration: 60.41772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:49:24.109965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:49:23.77499Z","time spent":"334.868525ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:49:24.110067Z","caller":"traceutil/trace.go:171","msg":"trace[1662150054] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"317.202184ms","start":"2026-04-23T21:49:23.792848Z","end":"2026-04-23T21:49:24.110051Z","steps":["trace[1662150054] 'process raft request' (duration: 316.834492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:49:24.11023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:49:23.792812Z","time spent":"317.310327ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:49:24.110493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.449166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-23T21:49:24.110543Z","caller":"traceutil/trace.go:171","msg":"trace[107046605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2740; }","duration":"264.555849ms","start":"2026-04-23T21:49:23.845974Z","end":"2026-04-23T21:49:24.11053Z","steps":["trace[107046605] 'agreement among raft nodes before linearized reading' (duration: 264.345892ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:49:24.109924Z","caller":"traceutil/trace.go:171","msg":"trace[117486207] linearizableReadLoop","detail":"{readStateIndex:2846; appliedIndex:2844; }","duration":"262.071364ms","start":"2026-04-23T21:49:23.847811Z","end":"2026-04-23T21:49:24.109882Z","steps":["trace[117486207] 'read index received' (duration: 200.513515ms)","trace[117486207] 'applied index is now lower than readState.Index' (duration: 61.556489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:49:24.110861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.515483ms","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-04-23T21:49:24.110893Z","caller":"traceutil/trace.go:171","msg":"trace[951869900] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2740; }","duration":"280.590415ms","start":"2026-04-23T21:49:23.830293Z","end":"2026-04-23T21:49:24.110884Z","steps":["trace[951869900] 'agreement among raft nodes before linearized reading' (duration: 280.505642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:49:24.111248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.163215ms","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-04-23T21:49:24.111295Z","caller":"traceutil/trace.go:171","msg":"trace[252403639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2740; }","duration":"269.234559ms","start":"2026-04-23T21:49:23.842051Z","end":"2026-04-23T21:49:24.111285Z","steps":["trace[252403639] 'agreement among raft nodes before linearized reading' (duration: 268.68896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:49:24.121471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.361965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T21:49:24.12153Z","caller":"traceutil/trace.go:171","msg":"trace[1343234646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2741; }","duration":"267.436857ms","start":"2026-04-23T21:49:23.85408Z","end":"2026-04-23T21:49:24.121517Z","steps":["trace[1343234646] 'agreement among raft nodes before linearized reading' (duration: 267.079405ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:49:24.121687Z","caller":"traceutil/trace.go:171","msg":"trace[1967435339] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"270.14006ms","start":"2026-04-23T21:49:23.850995Z","end":"2026-04-23T21:49:24.121135Z","steps":["trace[1967435339] 'process raft request' (duration: 270.023966ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:50:25.300796Z","caller":"traceutil/trace.go:171","msg":"trace[565277787] transaction","detail":"{read_only:false; response_revision:3065; number_of_response:1; }","duration":"144.869593ms","start":"2026-04-23T21:50:25.155894Z","end":"2026-04-23T21:50:25.300764Z","steps":["trace[565277787] 'process raft request' (duration: 144.624345ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:52:06.348162Z","caller":"traceutil/trace.go:171","msg":"trace[999310280] transaction","detail":"{read_only:false; response_revision:3689; number_of_response:1; }","duration":"178.277251ms","start":"2026-04-23T21:52:06.16985Z","end":"2026-04-23T21:52:06.348127Z","steps":["trace[999310280] 'process raft request' (duration: 178.095107ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:12.440279Z","caller":"traceutil/trace.go:171","msg":"trace[611355619] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4564; }","duration":"136.643862ms","start":"2026-04-23T21:53:12.303598Z","end":"2026-04-23T21:53:12.440241Z","steps":["trace[611355619] 'process raft request' (duration: 129.969466ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:15.541346Z","caller":"traceutil/trace.go:171","msg":"trace[909348872] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"125.991997ms","start":"2026-04-23T21:53:15.415326Z","end":"2026-04-23T21:53:15.541317Z","steps":["trace[909348872] 'process raft request' (duration: 125.770732ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:15.546892Z","caller":"traceutil/trace.go:171","msg":"trace[1551998229] linearizableReadLoop","detail":"{readStateIndex:4834; appliedIndex:4831; }","duration":"114.855387ms","start":"2026-04-23T21:53:15.432003Z","end":"2026-04-23T21:53:15.546859Z","steps":["trace[1551998229] 'read index received' (duration: 109.137004ms)","trace[1551998229] 'applied index is now lower than readState.Index' (duration: 5.715953ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:53:15.546933Z","caller":"traceutil/trace.go:171","msg":"trace[918053909] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"130.927262ms","start":"2026-04-23T21:53:15.415989Z","end":"2026-04-23T21:53:15.546916Z","steps":["trace[918053909] 'process raft request' (duration: 130.672956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:15.548321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.296983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"} {"level":"info","ts":"2026-04-23T21:53:15.548382Z","caller":"traceutil/trace.go:171","msg":"trace[800011529] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4654; }","duration":"116.415866ms","start":"2026-04-23T21:53:15.431951Z","end":"2026-04-23T21:53:15.548366Z","steps":["trace[800011529] 'agreement among raft nodes before linearized reading' (duration: 115.032291ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:15.546809Z","caller":"traceutil/trace.go:171","msg":"trace[1991936783] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"130.809079ms","start":"2026-04-23T21:53:15.415941Z","end":"2026-04-23T21:53:15.54675Z","steps":["trace[1991936783] 'process raft request' (duration: 130.258315ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:22.029391Z","caller":"traceutil/trace.go:171","msg":"trace[1571206526] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"456.460077ms","start":"2026-04-23T21:53:21.572901Z","end":"2026-04-23T21:53:22.029361Z","steps":["trace[1571206526] 'process raft request' (duration: 456.17277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.029851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:21.572878Z","time spent":"456.765764ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:53:22.375629Z","caller":"traceutil/trace.go:171","msg":"trace[1677948724] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"798.832214ms","start":"2026-04-23T21:53:21.576766Z","end":"2026-04-23T21:53:22.375598Z","steps":["trace[1677948724] 'process raft request' (duration: 798.736391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.375837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:21.576761Z","time spent":"798.979367ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:53:22.375921Z","caller":"traceutil/trace.go:171","msg":"trace[1721588135] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"391.754787ms","start":"2026-04-23T21:53:21.984132Z","end":"2026-04-23T21:53:22.375887Z","steps":["trace[1721588135] 'process raft request' (duration: 391.426759ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:22.375935Z","caller":"traceutil/trace.go:171","msg":"trace[1271651266] linearizableReadLoop","detail":"{readStateIndex:4885; appliedIndex:4882; }","duration":"686.684538ms","start":"2026-04-23T21:53:21.689219Z","end":"2026-04-23T21:53:22.375903Z","steps":["trace[1271651266] 'read index received' (duration: 339.927229ms)","trace[1271651266] 'applied index is now lower than readState.Index' (duration: 346.754009ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:53:22.376Z","caller":"traceutil/trace.go:171","msg":"trace[2041943772] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"147.777322ms","start":"2026-04-23T21:53:22.228191Z","end":"2026-04-23T21:53:22.375969Z","steps":["trace[2041943772] 'process raft request' (duration: 147.69605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.376103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:21.9841Z","time spent":"391.91055ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T21:53:22.376115Z","caller":"traceutil/trace.go:171","msg":"trace[836090028] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"799.399928ms","start":"2026-04-23T21:53:21.5767Z","end":"2026-04-23T21:53:22.3761Z","steps":["trace[836090028] 'process raft request' (duration: 767.944645ms)","trace[836090028] 'compare' (duration: 30.18684ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T21:53:22.376275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:21.576684Z","time spent":"799.562022ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T21:53:22.376304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.064478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T21:53:22.376346Z","caller":"traceutil/trace.go:171","msg":"trace[339097952] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:4706; }","duration":"687.17616ms","start":"2026-04-23T21:53:21.689156Z","end":"2026-04-23T21:53:22.376332Z","steps":["trace[339097952] 'agreement among raft nodes before linearized reading' (duration: 686.933245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.376387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:21.68913Z","time spent":"687.247522ms","remote":"127.0.0.1:34610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" "} {"level":"info","ts":"2026-04-23T21:53:22.376511Z","caller":"traceutil/trace.go:171","msg":"trace[1099639354] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"298.659071ms","start":"2026-04-23T21:53:22.077806Z","end":"2026-04-23T21:53:22.376465Z","steps":["trace[1099639354] 'process raft request' (duration: 297.958953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.376604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.121989ms","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-04-23T21:53:22.376642Z","caller":"traceutil/trace.go:171","msg":"trace[1271743425] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4706; }","duration":"623.199651ms","start":"2026-04-23T21:53:21.753431Z","end":"2026-04-23T21:53:22.37663Z","steps":["trace[1271743425] 'agreement among raft nodes before linearized reading' (duration: 623.026776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.376683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:21.753414Z","time spent":"623.261473ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-23T21:53:22.376781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.810752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T21:53:22.37681Z","caller":"traceutil/trace.go:171","msg":"trace[1179390899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4706; }","duration":"310.894644ms","start":"2026-04-23T21:53:22.065907Z","end":"2026-04-23T21:53:22.376802Z","steps":["trace[1179390899] 'agreement among raft nodes before linearized reading' (duration: 310.851673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.37684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T21:53:22.065885Z","time spent":"310.950196ms","remote":"127.0.0.1:34570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T21:53:22.765535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.237845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T21:53:22.765703Z","caller":"traceutil/trace.go:171","msg":"trace[1251747534] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"214.221057ms","start":"2026-04-23T21:53:22.55146Z","end":"2026-04-23T21:53:22.765681Z","steps":["trace[1251747534] 'process raft request' (duration: 61.758566ms)","trace[1251747534] 'compare' (duration: 151.887226ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:53:22.766192Z","caller":"traceutil/trace.go:171","msg":"trace[2123718698] linearizableReadLoop","detail":"{readStateIndex:4901; appliedIndex:4897; }","duration":"213.504809ms","start":"2026-04-23T21:53:22.552659Z","end":"2026-04-23T21:53:22.766163Z","steps":["trace[2123718698] 'read index received' (duration: 6.748722ms)","trace[2123718698] 'applied index is now lower than readState.Index' (duration: 206.754527ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:53:22.766495Z","caller":"traceutil/trace.go:171","msg":"trace[1580418098] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"214.973316ms","start":"2026-04-23T21:53:22.551509Z","end":"2026-04-23T21:53:22.766483Z","steps":["trace[1580418098] 'process raft request' (duration: 214.118755ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:22.766716Z","caller":"traceutil/trace.go:171","msg":"trace[13366710] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"215.155441ms","start":"2026-04-23T21:53:22.551551Z","end":"2026-04-23T21:53:22.766707Z","steps":["trace[13366710] 'process raft request' (duration: 214.342269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.766937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.241847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9427"} {"level":"info","ts":"2026-04-23T21:53:22.766977Z","caller":"traceutil/trace.go:171","msg":"trace[648829701] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4718; }","duration":"214.34082ms","start":"2026-04-23T21:53:22.552627Z","end":"2026-04-23T21:53:22.766968Z","steps":["trace[648829701] 'agreement among raft nodes before linearized reading' (duration: 214.156626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:22.767309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.478222ms","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-04-23T21:53:22.767356Z","caller":"traceutil/trace.go:171","msg":"trace[331350664] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4718; }","duration":"212.664286ms","start":"2026-04-23T21:53:22.554677Z","end":"2026-04-23T21:53:22.767342Z","steps":["trace[331350664] 'agreement among raft nodes before linearized reading' (duration: 212.463871ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:24.165036Z","caller":"traceutil/trace.go:171","msg":"trace[900001132] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"126.220054ms","start":"2026-04-23T21:53:24.038778Z","end":"2026-04-23T21:53:24.164998Z","steps":["trace[900001132] 'process raft request' (duration: 125.749582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:29.831363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.450651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-6s5kw.18a91afb72021f94\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-23T21:53:29.83148Z","caller":"traceutil/trace.go:171","msg":"trace[723736818] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-6s5kw.18a91afb72021f94; range_end:; response_count:1; response_revision:4872; }","duration":"182.630437ms","start":"2026-04-23T21:53:29.648826Z","end":"2026-04-23T21:53:29.831456Z","steps":["trace[723736818] 'range keys from in-memory index tree' (duration: 182.249116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:29.831785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.389367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1294db49-4650-4d75-9e6e-d96a6556203e\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-23T21:53:29.831886Z","caller":"traceutil/trace.go:171","msg":"trace[1233333105] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1294db49-4650-4d75-9e6e-d96a6556203e; range_end:; response_count:1; response_revision:4872; }","duration":"105.52951ms","start":"2026-04-23T21:53:29.726335Z","end":"2026-04-23T21:53:29.831864Z","steps":["trace[1233333105] 'range keys from in-memory index tree' (duration: 104.668138ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:30.450881Z","caller":"traceutil/trace.go:171","msg":"trace[38765731] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"149.145337ms","start":"2026-04-23T21:53:30.301711Z","end":"2026-04-23T21:53:30.450857Z","steps":["trace[38765731] 'process raft request' (duration: 148.982723ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:41.637961Z","caller":"traceutil/trace.go:171","msg":"trace[609511738] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"129.585747ms","start":"2026-04-23T21:53:41.508346Z","end":"2026-04-23T21:53:41.637931Z","steps":["trace[609511738] 'process raft request' (duration: 101.783542ms)","trace[609511738] 'compare' (duration: 27.364854ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:53:41.638309Z","caller":"traceutil/trace.go:171","msg":"trace[1345868293] transaction","detail":"{read_only:false; response_revision:4987; number_of_response:1; }","duration":"129.720611ms","start":"2026-04-23T21:53:41.508564Z","end":"2026-04-23T21:53:41.638284Z","steps":["trace[1345868293] 'process raft request' (duration: 129.615399ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:41.63832Z","caller":"traceutil/trace.go:171","msg":"trace[970605788] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"129.819284ms","start":"2026-04-23T21:53:41.50846Z","end":"2026-04-23T21:53:41.638279Z","steps":["trace[970605788] 'process raft request' (duration: 129.402404ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:41.638632Z","caller":"traceutil/trace.go:171","msg":"trace[2132524415] linearizableReadLoop","detail":"{readStateIndex:5178; appliedIndex:5173; }","duration":"105.079409ms","start":"2026-04-23T21:53:41.533534Z","end":"2026-04-23T21:53:41.638614Z","steps":["trace[2132524415] 'read index received' (duration: 76.486143ms)","trace[2132524415] 'applied index is now lower than readState.Index' (duration: 28.591876ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:53:41.63866Z","caller":"traceutil/trace.go:171","msg":"trace[822328699] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"130.094051ms","start":"2026-04-23T21:53:41.508549Z","end":"2026-04-23T21:53:41.638643Z","steps":["trace[822328699] 'process raft request' (duration: 129.68876ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:53:41.638744Z","caller":"traceutil/trace.go:171","msg":"trace[1803259751] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"130.054701ms","start":"2026-04-23T21:53:41.508656Z","end":"2026-04-23T21:53:41.638711Z","steps":["trace[1803259751] 'process raft request' (duration: 129.788914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:53:41.638875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.329075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-23T21:53:41.638927Z","caller":"traceutil/trace.go:171","msg":"trace[878915934] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4989; }","duration":"105.435598ms","start":"2026-04-23T21:53:41.53348Z","end":"2026-04-23T21:53:41.638915Z","steps":["trace[878915934] 'agreement among raft nodes before linearized reading' (duration: 105.239253ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:54:21.371357Z","caller":"traceutil/trace.go:171","msg":"trace[238753508] linearizableReadLoop","detail":"{readStateIndex:5515; appliedIndex:5514; }","duration":"108.718816ms","start":"2026-04-23T21:54:21.262571Z","end":"2026-04-23T21:54:21.37129Z","steps":["trace[238753508] 'read index received' (duration: 108.49545ms)","trace[238753508] 'applied index is now lower than readState.Index' (duration: 221.736µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T21:54:21.371637Z","caller":"traceutil/trace.go:171","msg":"trace[186118855] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"110.723312ms","start":"2026-04-23T21:54:21.260876Z","end":"2026-04-23T21:54:21.371599Z","steps":["trace[186118855] 'process raft request' (duration: 110.136676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T21:54:21.371793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.182289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-23T21:54:21.371853Z","caller":"traceutil/trace.go:171","msg":"trace[824782298] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5317; }","duration":"109.315602ms","start":"2026-04-23T21:54:21.26252Z","end":"2026-04-23T21:54:21.371835Z","steps":["trace[824782298] 'agreement among raft nodes before linearized reading' (duration: 108.938681ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:54:48.605447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-04-23T21:54:48.691524Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"83.95146ms","hash":731055370,"current-db-size-bytes":54235136,"current-db-size":"54 MB","current-db-size-in-use-bytes":29093888,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-23T21:54:48.691617Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":731055370,"revision":2872,"compact-revision":-1} {"level":"info","ts":"2026-04-23T21:57:39.981942Z","caller":"traceutil/trace.go:171","msg":"trace[1872896120] transaction","detail":"{read_only:false; response_revision:6722; number_of_response:1; }","duration":"101.807811ms","start":"2026-04-23T21:57:39.880105Z","end":"2026-04-23T21:57:39.981913Z","steps":["trace[1872896120] 'process raft request' (duration: 100.993006ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:57:39.990301Z","caller":"traceutil/trace.go:171","msg":"trace[971743644] transaction","detail":"{read_only:false; response_revision:6723; number_of_response:1; }","duration":"108.742859ms","start":"2026-04-23T21:57:39.881544Z","end":"2026-04-23T21:57:39.990287Z","steps":["trace[971743644] 'process raft request' (duration: 108.684058ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T21:59:48.612938Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5535} {"level":"info","ts":"2026-04-23T21:59:48.700287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5535,"took":"85.218997ms","hash":2448571064,"current-db-size-bytes":54235136,"current-db-size":"54 MB","current-db-size-in-use-bytes":18292736,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-23T21:59:48.70036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2448571064,"revision":5535,"compact-revision":2872}