{"level":"warn","ts":"2026-04-10T18:02:38.962459Z","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-10T18:02:38.962541Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.191: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.19.213.191:2380","--initial-cluster=instance=https://199.19.213.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.191: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-10T18:02:38.962603Z","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-10T18:02:38.962614Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-04-10T18:02:38.962631Z","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-10T18:02:38.963288Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"]} {"level":"info","ts":"2026-04-10T18:02:38.963387Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.191: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-10T18:02:38.967672Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.077142ms"} {"level":"info","ts":"2026-04-10T18:02:38.975861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e892d50a3a4fc0f4","cluster-id":"21eccdda20ff4e92"} {"level":"info","ts":"2026-04-10T18:02:38.97598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T18:02:38.976019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 0"} {"level":"info","ts":"2026-04-10T18:02:38.976045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e892d50a3a4fc0f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T18:02:38.976069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 1"} {"level":"info","ts":"2026-04-10T18:02:38.976158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"warn","ts":"2026-04-10T18:02:38.984109Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T18:02:38.986393Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T18:02:38.987872Z","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-10T18:02:38.991934Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e892d50a3a4fc0f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T18:02:38.992202Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e892d50a3a4fc0f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T18:02:38.992293Z","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-10T18:02:38.992493Z","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-10T18:02:38.992543Z","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-10T18:02:38.995276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"info","ts":"2026-04-10T18:02:38.995702Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","added-peer-id":"e892d50a3a4fc0f4","added-peer-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-04-10T18:02:38.999548Z","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-10T18:02:38.999646Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-04-10T18:02:38.999722Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-04-10T18:02:39.000074Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e892d50a3a4fc0f4","initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T18:02:39.000223Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T18:02:39.17704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T18:02:39.177118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T18:02:39.177161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgPreVoteResp from e892d50a3a4fc0f4 at term 1"} {"level":"info","ts":"2026-04-10T18:02:39.177181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became candidate at term 2"} {"level":"info","ts":"2026-04-10T18:02:39.177194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgVoteResp from e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-04-10T18:02:39.177212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became leader at term 2"} {"level":"info","ts":"2026-04-10T18:02:39.177233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e892d50a3a4fc0f4 elected leader e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-04-10T18:02:39.178188Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:39.178873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e892d50a3a4fc0f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.191:2379]}","request-path":"/0/members/e892d50a3a4fc0f4/attributes","cluster-id":"21eccdda20ff4e92","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T18:02:39.179079Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T18:02:39.179109Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T18:02:39.179263Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T18:02:39.179292Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T18:02:39.179541Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:39.1797Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:39.179744Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:39.181058Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T18:02:39.184136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.191:2379"} {"level":"info","ts":"2026-04-10T18:03:07.070448Z","caller":"traceutil/trace.go:171","msg":"trace[1111962912] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"116.818321ms","start":"2026-04-10T18:03:06.953594Z","end":"2026-04-10T18:03:07.070413Z","steps":["trace[1111962912] 'process raft request' (duration: 116.25487ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:09.142235Z","caller":"traceutil/trace.go:171","msg":"trace[370587284] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"117.967294ms","start":"2026-04-10T18:03:09.024241Z","end":"2026-04-10T18:03:09.142208Z","steps":["trace[370587284] 'process raft request' (duration: 117.7646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.710806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.71092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:03:09.711067Z","caller":"traceutil/trace.go:171","msg":"trace[2023356235] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"315.756751ms","start":"2026-04-10T18:03:09.395294Z","end":"2026-04-10T18:03:09.71105Z","steps":["trace[2023356235] 'process raft request' (duration: 315.71927ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:09.711089Z","caller":"traceutil/trace.go:171","msg":"trace[572291849] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"319.785033ms","start":"2026-04-10T18:03:09.391247Z","end":"2026-04-10T18:03:09.711032Z","steps":["trace[572291849] 'process raft request' (duration: 54.38275ms)","trace[572291849] 'compare' (duration: 264.566846ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:09.711428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.391211Z","time spent":"320.114891ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T18:03:09.711134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.395267Z","time spent":"315.840512ms","remote":"127.0.0.1:35600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T18:03:09.711239Z","caller":"traceutil/trace.go:171","msg":"trace[1843384683] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"317.436206ms","start":"2026-04-10T18:03:09.393732Z","end":"2026-04-10T18:03:09.711168Z","steps":["trace[1843384683] 'process raft request' (duration: 317.225421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.712066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.393706Z","time spent":"318.231422ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T18:03:09.726213Z","caller":"traceutil/trace.go:171","msg":"trace[2131820319] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"326.986529ms","start":"2026-04-10T18:03:09.399198Z","end":"2026-04-10T18:03:09.726184Z","steps":["trace[2131820319] 'process raft request' (duration: 326.726113ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:09.726286Z","caller":"traceutil/trace.go:171","msg":"trace[766199156] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"325.601471ms","start":"2026-04-10T18:03:09.40064Z","end":"2026-04-10T18:03:09.726242Z","steps":["trace[766199156] 'process raft request' (duration: 325.404137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.726362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.399183Z","time spent":"327.108772ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T18:03:09.726574Z","caller":"traceutil/trace.go:171","msg":"trace[1007129583] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"319.110529ms","start":"2026-04-10T18:03:09.40743Z","end":"2026-04-10T18:03:09.72654Z","steps":["trace[1007129583] 'process raft request' (duration: 318.869584ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:09.72657Z","caller":"traceutil/trace.go:171","msg":"trace[752953103] transaction","detail":"{read_only:false; number_of_response:1; response_revision:523; }","duration":"324.762314ms","start":"2026-04-10T18:03:09.401745Z","end":"2026-04-10T18:03:09.726507Z","steps":["trace[752953103] 'process raft request' (duration: 324.374306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.726652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.407413Z","time spent":"319.210061ms","remote":"127.0.0.1:35600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T18:03:09.726646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.40063Z","time spent":"325.720583ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:03:09.726707Z","caller":"traceutil/trace.go:171","msg":"trace[1433882740] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"319.194291ms","start":"2026-04-10T18:03:09.407493Z","end":"2026-04-10T18:03:09.726687Z","steps":["trace[1433882740] 'process raft request' (duration: 318.906625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.726792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.407488Z","time spent":"319.273662ms","remote":"127.0.0.1:35600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T18:03:09.726833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.401736Z","time spent":"324.947747ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:03:09.726918Z","caller":"traceutil/trace.go:171","msg":"trace[41689926] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"319.276022ms","start":"2026-04-10T18:03:09.407602Z","end":"2026-04-10T18:03:09.726878Z","steps":["trace[41689926] 'process raft request' (duration: 318.954036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.727037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.407596Z","time spent":"319.385194ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T18:03:09.727117Z","caller":"traceutil/trace.go:171","msg":"trace[1052112413] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"319.455606ms","start":"2026-04-10T18:03:09.407649Z","end":"2026-04-10T18:03:09.727105Z","steps":["trace[1052112413] 'process raft request' (duration: 319.127589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.727188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.407639Z","time spent":"319.520867ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T18:03:09.727401Z","caller":"traceutil/trace.go:171","msg":"trace[611680700] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"315.75148ms","start":"2026-04-10T18:03:09.411621Z","end":"2026-04-10T18:03:09.727372Z","steps":["trace[611680700] 'process raft request' (duration: 315.366722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.727492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.41161Z","time spent":"315.838763ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:03:09.727671Z","caller":"traceutil/trace.go:171","msg":"trace[1149307692] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"305.758ms","start":"2026-04-10T18:03:09.421891Z","end":"2026-04-10T18:03:09.727649Z","steps":["trace[1149307692] 'process raft request' (duration: 305.526045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.727734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:09.421861Z","time spent":"305.846061ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T18:03:09.728223Z","caller":"traceutil/trace.go:171","msg":"trace[851056006] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:538; }","duration":"280.156172ms","start":"2026-04-10T18:03:09.448009Z","end":"2026-04-10T18:03:09.728165Z","steps":["trace[851056006] 'read index received' (duration: 277.994968ms)","trace[851056006] 'applied index is now lower than readState.Index' (duration: 2.159974ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:09.728393Z","caller":"traceutil/trace.go:171","msg":"trace[995470204] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"288.131053ms","start":"2026-04-10T18:03:09.440241Z","end":"2026-04-10T18:03:09.728372Z","steps":["trace[995470204] 'process raft request' (duration: 287.400308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:09.728589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.526419ms","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-10T18:03:09.728638Z","caller":"traceutil/trace.go:171","msg":"trace[1952095618] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"280.660883ms","start":"2026-04-10T18:03:09.447965Z","end":"2026-04-10T18:03:09.728625Z","steps":["trace[1952095618] 'agreement among raft nodes before linearized reading' (duration: 280.344057ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:09.73476Z","caller":"traceutil/trace.go:171","msg":"trace[1710213653] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"284.832847ms","start":"2026-04-10T18:03:09.449904Z","end":"2026-04-10T18:03:09.734736Z","steps":["trace[1710213653] 'process raft request' (duration: 283.714894ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:09.734932Z","caller":"traceutil/trace.go:171","msg":"trace[849524325] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"176.448106ms","start":"2026-04-10T18:03:09.558475Z","end":"2026-04-10T18:03:09.734924Z","steps":["trace[849524325] 'process raft request' (duration: 175.303373ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.317996Z","caller":"traceutil/trace.go:171","msg":"trace[1713390413] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"126.941074ms","start":"2026-04-10T18:03:11.191013Z","end":"2026-04-10T18:03:11.317954Z","steps":["trace[1713390413] 'process raft request' (duration: 81.214201ms)","trace[1713390413] 'compare' (duration: 45.55897ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:11.342521Z","caller":"traceutil/trace.go:171","msg":"trace[1470405190] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"149.004571ms","start":"2026-04-10T18:03:11.19349Z","end":"2026-04-10T18:03:11.342494Z","steps":["trace[1470405190] 'process raft request' (duration: 148.856348ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:15.351371Z","caller":"traceutil/trace.go:171","msg":"trace[262831448] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"116.542176ms","start":"2026-04-10T18:03:15.234802Z","end":"2026-04-10T18:03:15.351344Z","steps":["trace[262831448] 'read index received' (duration: 115.689639ms)","trace[262831448] 'applied index is now lower than readState.Index' (duration: 851.537µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:15.35143Z","caller":"traceutil/trace.go:171","msg":"trace[1574495534] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"151.747657ms","start":"2026-04-10T18:03:15.199644Z","end":"2026-04-10T18:03:15.351391Z","steps":["trace[1574495534] 'process raft request' (duration: 151.117784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:15.351694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.864522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vcg62\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-10T18:03:15.351762Z","caller":"traceutil/trace.go:171","msg":"trace[470212023] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vcg62; range_end:; response_count:1; response_revision:619; }","duration":"116.978755ms","start":"2026-04-10T18:03:15.234767Z","end":"2026-04-10T18:03:15.351746Z","steps":["trace[470212023] 'agreement among raft nodes before linearized reading' (duration: 116.718929ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:15.587572Z","caller":"traceutil/trace.go:171","msg":"trace[2009565511] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"228.238632ms","start":"2026-04-10T18:03:15.359306Z","end":"2026-04-10T18:03:15.587545Z","steps":["trace[2009565511] 'process raft request' (duration: 224.969076ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:15.587838Z","caller":"traceutil/trace.go:171","msg":"trace[1415484988] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"220.487735ms","start":"2026-04-10T18:03:15.367315Z","end":"2026-04-10T18:03:15.587803Z","steps":["trace[1415484988] 'process raft request' (duration: 220.169379ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:15.59282Z","caller":"traceutil/trace.go:171","msg":"trace[548884917] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"182.472727ms","start":"2026-04-10T18:03:15.410288Z","end":"2026-04-10T18:03:15.592761Z","steps":["trace[548884917] 'process raft request' (duration: 182.314394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:16.227096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.326507ms","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-10T18:03:16.227329Z","caller":"traceutil/trace.go:171","msg":"trace[269270427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"432.571471ms","start":"2026-04-10T18:03:15.794723Z","end":"2026-04-10T18:03:16.227294Z","steps":["trace[269270427] 'range keys from in-memory index tree' (duration: 432.122763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:16.227457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:15.794664Z","time spent":"432.771266ms","remote":"127.0.0.1:35344","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-10T18:03:16.227681Z","caller":"traceutil/trace.go:171","msg":"trace[936053593] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"216.493995ms","start":"2026-04-10T18:03:16.011151Z","end":"2026-04-10T18:03:16.227645Z","steps":["trace[936053593] 'process raft request' (duration: 213.989455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:17.503766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.798767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:17.503871Z","caller":"traceutil/trace.go:171","msg":"trace[1532088386] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"104.92145ms","start":"2026-04-10T18:03:17.398926Z","end":"2026-04-10T18:03:17.503848Z","steps":["trace[1532088386] 'count revisions from in-memory index tree' (duration: 104.698295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:17.504266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.319207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:17.50435Z","caller":"traceutil/trace.go:171","msg":"trace[148447310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"105.43152ms","start":"2026-04-10T18:03:17.398899Z","end":"2026-04-10T18:03:17.504331Z","steps":["trace[148447310] 'range keys from in-memory index tree' (duration: 105.240006ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.473456Z","caller":"traceutil/trace.go:171","msg":"trace[2123660266] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"109.776318ms","start":"2026-04-10T18:03:18.363636Z","end":"2026-04-10T18:03:18.473413Z","steps":["trace[2123660266] 'process raft request' (duration: 91.819726ms)","trace[2123660266] 'compare' (duration: 17.635476ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:18.604039Z","caller":"traceutil/trace.go:171","msg":"trace[1060990040] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"130.538299ms","start":"2026-04-10T18:03:18.473464Z","end":"2026-04-10T18:03:18.604002Z","steps":["trace[1060990040] 'read index received' (duration: 114.826751ms)","trace[1060990040] 'applied index is now lower than readState.Index' (duration: 15.710348ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.604221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.390678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.604263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.090975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.604311Z","caller":"traceutil/trace.go:171","msg":"trace[1020830284] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:664; }","duration":"191.565301ms","start":"2026-04-10T18:03:18.412728Z","end":"2026-04-10T18:03:18.604294Z","steps":["trace[1020830284] 'agreement among raft nodes before linearized reading' (duration: 191.324606ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.604331Z","caller":"traceutil/trace.go:171","msg":"trace[849229150] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:664; }","duration":"208.219158ms","start":"2026-04-10T18:03:18.396088Z","end":"2026-04-10T18:03:18.604307Z","steps":["trace[849229150] 'agreement among raft nodes before linearized reading' (duration: 208.051355ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.604369Z","caller":"traceutil/trace.go:171","msg":"trace[1450685077] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"186.020599ms","start":"2026-04-10T18:03:18.418302Z","end":"2026-04-10T18:03:18.604323Z","steps":["trace[1450685077] 'process raft request' (duration: 169.860212ms)","trace[1450685077] 'compare' (duration: 15.680718ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.604385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.865735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.604318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.210575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.604446Z","caller":"traceutil/trace.go:171","msg":"trace[615702988] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:664; }","duration":"228.939177ms","start":"2026-04-10T18:03:18.375478Z","end":"2026-04-10T18:03:18.604418Z","steps":["trace[615702988] 'agreement among raft nodes before linearized reading' (duration: 228.881496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.604251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.123756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.604432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.009136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.604492Z","caller":"traceutil/trace.go:171","msg":"trace[1169894532] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:664; }","duration":"192.47444ms","start":"2026-04-10T18:03:18.411998Z","end":"2026-04-10T18:03:18.604473Z","steps":["trace[1169894532] 'agreement among raft nodes before linearized reading' (duration: 192.198355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.604493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.47536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.604335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.234222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.604553Z","caller":"traceutil/trace.go:171","msg":"trace[352619537] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:664; }","duration":"192.556852ms","start":"2026-04-10T18:03:18.411979Z","end":"2026-04-10T18:03:18.604536Z","steps":["trace[352619537] 'agreement among raft nodes before linearized reading' (duration: 192.4661ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.604546Z","caller":"traceutil/trace.go:171","msg":"trace[92366495] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:664; }","duration":"172.19449ms","start":"2026-04-10T18:03:18.432324Z","end":"2026-04-10T18:03:18.604519Z","steps":["trace[92366495] 'agreement among raft nodes before linearized reading' (duration: 171.958506ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.604565Z","caller":"traceutil/trace.go:171","msg":"trace[760243273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:664; }","duration":"208.422223ms","start":"2026-04-10T18:03:18.396062Z","end":"2026-04-10T18:03:18.604484Z","steps":["trace[760243273] 'agreement among raft nodes before linearized reading' (duration: 208.099646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.604584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.727901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.604619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.732712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.604676Z","caller":"traceutil/trace.go:171","msg":"trace[565240938] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:664; }","duration":"172.898125ms","start":"2026-04-10T18:03:18.431757Z","end":"2026-04-10T18:03:18.604655Z","steps":["trace[565240938] 'agreement among raft nodes before linearized reading' (duration: 172.680861ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.604677Z","caller":"traceutil/trace.go:171","msg":"trace[1082710763] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:664; }","duration":"172.824113ms","start":"2026-04-10T18:03:18.431837Z","end":"2026-04-10T18:03:18.604661Z","steps":["trace[1082710763] 'agreement among raft nodes before linearized reading' (duration: 172.746262ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.604663Z","caller":"traceutil/trace.go:171","msg":"trace[786861252] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:664; }","duration":"228.506407ms","start":"2026-04-10T18:03:18.376069Z","end":"2026-04-10T18:03:18.604575Z","steps":["trace[786861252] 'agreement among raft nodes before linearized reading' (duration: 228.216872ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.608231Z","caller":"traceutil/trace.go:171","msg":"trace[759197833] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"127.70439ms","start":"2026-04-10T18:03:18.480499Z","end":"2026-04-10T18:03:18.608203Z","steps":["trace[759197833] 'process raft request' (duration: 127.417635ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.608319Z","caller":"traceutil/trace.go:171","msg":"trace[1548634096] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"125.324442ms","start":"2026-04-10T18:03:18.482976Z","end":"2026-04-10T18:03:18.6083Z","steps":["trace[1548634096] 'process raft request' (duration: 125.117868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:35.574291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.881009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:03:35.574425Z","caller":"traceutil/trace.go:171","msg":"trace[1147654536] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"232.476668ms","start":"2026-04-10T18:03:35.34193Z","end":"2026-04-10T18:03:35.574406Z","steps":["trace[1147654536] 'read index received' (duration: 37.365215ms)","trace[1147654536] 'applied index is now lower than readState.Index' (duration: 195.110363ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:35.574479Z","caller":"traceutil/trace.go:171","msg":"trace[1832216566] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"286.49131ms","start":"2026-04-10T18:03:35.287948Z","end":"2026-04-10T18:03:35.57444Z","steps":["trace[1832216566] 'process raft request' (duration: 91.371016ms)","trace[1832216566] 'compare' (duration: 194.734766ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:35.574639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.752803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-vbpp6\" ","response":"range_response_count:1 size:4741"} {"level":"info","ts":"2026-04-10T18:03:35.574692Z","caller":"traceutil/trace.go:171","msg":"trace[1440379739] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-vbpp6; range_end:; response_count:1; response_revision:780; }","duration":"232.852536ms","start":"2026-04-10T18:03:35.341828Z","end":"2026-04-10T18:03:35.57468Z","steps":["trace[1440379739] 'agreement among raft nodes before linearized reading' (duration: 232.685052ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:35.824136Z","caller":"traceutil/trace.go:171","msg":"trace[142864334] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"105.508712ms","start":"2026-04-10T18:03:35.718599Z","end":"2026-04-10T18:03:35.824108Z","steps":["trace[142864334] 'read index received' (duration: 88.438557ms)","trace[142864334] 'applied index is now lower than readState.Index' (duration: 17.069045ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:35.824259Z","caller":"traceutil/trace.go:171","msg":"trace[1147308461] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"133.463657ms","start":"2026-04-10T18:03:35.690758Z","end":"2026-04-10T18:03:35.824221Z","steps":["trace[1147308461] 'process raft request' (duration: 116.27891ms)","trace[1147308461] 'compare' (duration: 16.960433ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:35.824395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.780368ms","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-10T18:03:35.824454Z","caller":"traceutil/trace.go:171","msg":"trace[725598021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"105.89957ms","start":"2026-04-10T18:03:35.718542Z","end":"2026-04-10T18:03:35.824441Z","steps":["trace[725598021] 'agreement among raft nodes before linearized reading' (duration: 105.701976ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:37.693171Z","caller":"traceutil/trace.go:171","msg":"trace[730230823] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"113.952204ms","start":"2026-04-10T18:03:37.579191Z","end":"2026-04-10T18:03:37.693143Z","steps":["trace[730230823] 'read index received' (duration: 52.672195ms)","trace[730230823] 'applied index is now lower than readState.Index' (duration: 61.278309ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:37.693445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.227779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-10T18:03:37.693548Z","caller":"traceutil/trace.go:171","msg":"trace[267911771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"114.386102ms","start":"2026-04-10T18:03:37.579142Z","end":"2026-04-10T18:03:37.693528Z","steps":["trace[267911771] 'agreement among raft nodes before linearized reading' (duration: 114.101667ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:04:08.13667Z","caller":"traceutil/trace.go:171","msg":"trace[866044661] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"106.915208ms","start":"2026-04-10T18:04:08.029729Z","end":"2026-04-10T18:04:08.136644Z","steps":["trace[866044661] 'process raft request' (duration: 106.754545ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:04:08.142773Z","caller":"traceutil/trace.go:171","msg":"trace[50362134] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"110.764375ms","start":"2026-04-10T18:04:08.031983Z","end":"2026-04-10T18:04:08.142747Z","steps":["trace[50362134] 'process raft request' (duration: 110.625013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:08.538052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.067628ms","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-10T18:04:08.538225Z","caller":"traceutil/trace.go:171","msg":"trace[177919345] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1206; }","duration":"190.247802ms","start":"2026-04-10T18:04:08.347951Z","end":"2026-04-10T18:04:08.538199Z","steps":["trace[177919345] 'range keys from in-memory index tree' (duration: 190.050928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:08.538108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.468968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T18:04:08.538426Z","caller":"traceutil/trace.go:171","msg":"trace[1235901222] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1206; }","duration":"315.850316ms","start":"2026-04-10T18:04:08.222555Z","end":"2026-04-10T18:04:08.538405Z","steps":["trace[1235901222] 'count revisions from in-memory index tree' (duration: 315.354586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:08.538501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:04:08.222526Z","time spent":"315.951877ms","remote":"127.0.0.1:35312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":2,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-04-10T18:04:56.991031Z","caller":"traceutil/trace.go:171","msg":"trace[1519574912] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"307.301571ms","start":"2026-04-10T18:04:56.683705Z","end":"2026-04-10T18:04:56.991007Z","steps":["trace[1519574912] 'read index received' (duration: 293.401662ms)","trace[1519574912] 'applied index is now lower than readState.Index' (duration: 13.898389ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:04:56.991085Z","caller":"traceutil/trace.go:171","msg":"trace[1406971443] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"348.516628ms","start":"2026-04-10T18:04:56.642532Z","end":"2026-04-10T18:04:56.991049Z","steps":["trace[1406971443] 'process raft request' (duration: 334.597579ms)","trace[1406971443] 'compare' (duration: 13.503731ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:04:56.991229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:04:56.642511Z","time spent":"348.641291ms","remote":"127.0.0.1:35344","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-10T18:04:56.991274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.561806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d96304d0-d37a-4d94-8923-8280d359d3e9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-10T18:04:56.991317Z","caller":"traceutil/trace.go:171","msg":"trace[2092675388] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d96304d0-d37a-4d94-8923-8280d359d3e9; range_end:; response_count:1; response_revision:1874; }","duration":"307.645808ms","start":"2026-04-10T18:04:56.683657Z","end":"2026-04-10T18:04:56.991303Z","steps":["trace[2092675388] 'agreement among raft nodes before linearized reading' (duration: 307.494375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:56.991314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.290018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:04:56.99142Z","caller":"traceutil/trace.go:171","msg":"trace[1461690106] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1874; }","duration":"279.531703ms","start":"2026-04-10T18:04:56.711865Z","end":"2026-04-10T18:04:56.991396Z","steps":["trace[1461690106] 'agreement among raft nodes before linearized reading' (duration: 279.36278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:56.991359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:04:56.683639Z","time spent":"307.711169ms","remote":"127.0.0.1:35264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d96304d0-d37a-4d94-8923-8280d359d3e9\" "} {"level":"warn","ts":"2026-04-10T18:04:56.99166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.195295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d96304d0-d37a-4d94-8923-8280d359d3e9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-10T18:04:56.991693Z","caller":"traceutil/trace.go:171","msg":"trace[1617470298] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d96304d0-d37a-4d94-8923-8280d359d3e9; range_end:; response_count:1; response_revision:1874; }","duration":"265.272956ms","start":"2026-04-10T18:04:56.72641Z","end":"2026-04-10T18:04:56.991683Z","steps":["trace[1617470298] 'agreement among raft nodes before linearized reading' (duration: 265.183234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:56.991818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.133983ms","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-10T18:04:56.991919Z","caller":"traceutil/trace.go:171","msg":"trace[157448070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1874; }","duration":"153.289566ms","start":"2026-04-10T18:04:56.838608Z","end":"2026-04-10T18:04:56.991897Z","steps":["trace[157448070] 'agreement among raft nodes before linearized reading' (duration: 152.98566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:05:41.736199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.411911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:05:41.736311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.816957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-10T18:05:41.736291Z","caller":"traceutil/trace.go:171","msg":"trace[1550744424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2169; }","duration":"199.543454ms","start":"2026-04-10T18:05:41.536725Z","end":"2026-04-10T18:05:41.736268Z","steps":["trace[1550744424] 'range keys from in-memory index tree' (duration: 199.303599ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:05:41.73635Z","caller":"traceutil/trace.go:171","msg":"trace[1070281594] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2169; }","duration":"171.919329ms","start":"2026-04-10T18:05:41.564421Z","end":"2026-04-10T18:05:41.73634Z","steps":["trace[1070281594] 'range keys from in-memory index tree' (duration: 171.557162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:06:37.009196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.37454ms","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-10T18:06:37.00934Z","caller":"traceutil/trace.go:171","msg":"trace[307181150] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2643; }","duration":"136.603135ms","start":"2026-04-10T18:06:36.87271Z","end":"2026-04-10T18:06:37.009313Z","steps":["trace[307181150] 'range keys from in-memory index tree' (duration: 135.900631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:06:37.009723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.130517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-10T18:06:37.009825Z","caller":"traceutil/trace.go:171","msg":"trace[1902952182] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2643; }","duration":"159.29661ms","start":"2026-04-10T18:06:36.850506Z","end":"2026-04-10T18:06:37.009803Z","steps":["trace[1902952182] 'range keys from in-memory index tree' (duration: 158.902062ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:07:11.327182Z","caller":"traceutil/trace.go:171","msg":"trace[1028906419] linearizableReadLoop","detail":"{readStateIndex:2954; appliedIndex:2953; }","duration":"136.971037ms","start":"2026-04-10T18:07:11.190174Z","end":"2026-04-10T18:07:11.327146Z","steps":["trace[1028906419] 'read index received' (duration: 136.713642ms)","trace[1028906419] 'applied index is now lower than readState.Index' (duration: 255.745µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:07:11.327285Z","caller":"traceutil/trace.go:171","msg":"trace[1602129202] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"147.022539ms","start":"2026-04-10T18:07:11.180212Z","end":"2026-04-10T18:07:11.327235Z","steps":["trace[1602129202] 'process raft request' (duration: 146.704522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:07:11.327494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.294783ms","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-10T18:07:11.327565Z","caller":"traceutil/trace.go:171","msg":"trace[424267399] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2849; }","duration":"137.391045ms","start":"2026-04-10T18:07:11.190155Z","end":"2026-04-10T18:07:11.327546Z","steps":["trace[424267399] 'agreement among raft nodes before linearized reading' (duration: 137.14074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:07:11.620154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.257382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:07:11.620493Z","caller":"traceutil/trace.go:171","msg":"trace[1370793345] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"288.190827ms","start":"2026-04-10T18:07:11.332235Z","end":"2026-04-10T18:07:11.620426Z","steps":["trace[1370793345] 'process raft request' (duration: 153.570798ms)","trace[1370793345] 'compare' (duration: 133.831224ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:09:36.497283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.533502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-10T18:09:36.49741Z","caller":"traceutil/trace.go:171","msg":"trace[2110889442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3815; }","duration":"103.720846ms","start":"2026-04-10T18:09:36.393668Z","end":"2026-04-10T18:09:36.497388Z","steps":["trace[2110889442] 'range keys from in-memory index tree' (duration: 103.318537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.25474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.619106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-04-10T18:11:08.254816Z","caller":"traceutil/trace.go:171","msg":"trace[487480407] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4820; }","duration":"110.740278ms","start":"2026-04-10T18:11:08.144062Z","end":"2026-04-10T18:11:08.254803Z","steps":["trace[487480407] 'range keys from in-memory index tree' (duration: 110.470423ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:08.398147Z","caller":"traceutil/trace.go:171","msg":"trace[139499286] linearizableReadLoop","detail":"{readStateIndex:5001; appliedIndex:5000; }","duration":"137.619532ms","start":"2026-04-10T18:11:08.260497Z","end":"2026-04-10T18:11:08.398116Z","steps":["trace[139499286] 'read index received' (duration: 137.281376ms)","trace[139499286] 'applied index is now lower than readState.Index' (duration: 337.106µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:08.398241Z","caller":"traceutil/trace.go:171","msg":"trace[264399431] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"138.615703ms","start":"2026-04-10T18:11:08.259584Z","end":"2026-04-10T18:11:08.3982Z","steps":["trace[264399431] 'process raft request' (duration: 138.312977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.3985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.975009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-10T18:11:08.398626Z","caller":"traceutil/trace.go:171","msg":"trace[621759321] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4821; }","duration":"138.112792ms","start":"2026-04-10T18:11:08.260491Z","end":"2026-04-10T18:11:08.398603Z","steps":["trace[621759321] 'agreement among raft nodes before linearized reading' (duration: 137.795836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.398662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.429729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:10 size:76383"} {"level":"info","ts":"2026-04-10T18:11:08.398923Z","caller":"traceutil/trace.go:171","msg":"trace[2026926526] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:10; response_revision:4821; }","duration":"137.616563ms","start":"2026-04-10T18:11:08.261176Z","end":"2026-04-10T18:11:08.398792Z","steps":["trace[2026926526] 'agreement among raft nodes before linearized reading' (duration: 137.178954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.613989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.752386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:11:08.614181Z","caller":"traceutil/trace.go:171","msg":"trace[1404068364] linearizableReadLoop","detail":"{readStateIndex:5003; appliedIndex:5002; }","duration":"152.02946ms","start":"2026-04-10T18:11:08.462133Z","end":"2026-04-10T18:11:08.614162Z","steps":["trace[1404068364] 'read index received' (duration: 15.936407ms)","trace[1404068364] 'applied index is now lower than readState.Index' (duration: 136.091903ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:08.614285Z","caller":"traceutil/trace.go:171","msg":"trace[1676255343] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"201.518206ms","start":"2026-04-10T18:11:08.412728Z","end":"2026-04-10T18:11:08.614246Z","steps":["trace[1676255343] 'process raft request' (duration: 65.422703ms)","trace[1676255343] 'compare' (duration: 135.4265ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:11:08.614385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.228593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c39585a5-c228-4e76-8460-4dd51a315393\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-04-10T18:11:08.614449Z","caller":"traceutil/trace.go:171","msg":"trace[1257557809] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c39585a5-c228-4e76-8460-4dd51a315393; range_end:; response_count:1; response_revision:4823; }","duration":"152.353646ms","start":"2026-04-10T18:11:08.46208Z","end":"2026-04-10T18:11:08.614434Z","steps":["trace[1257557809] 'agreement among raft nodes before linearized reading' (duration: 152.147752ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:08.733349Z","caller":"traceutil/trace.go:171","msg":"trace[867979562] linearizableReadLoop","detail":"{readStateIndex:5004; appliedIndex:5003; }","duration":"119.088463ms","start":"2026-04-10T18:11:08.614234Z","end":"2026-04-10T18:11:08.733323Z","steps":["trace[867979562] 'read index received' (duration: 112.855809ms)","trace[867979562] 'applied index is now lower than readState.Index' (duration: 6.231394ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:08.733371Z","caller":"traceutil/trace.go:171","msg":"trace[611276225] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"148.865918ms","start":"2026-04-10T18:11:08.584472Z","end":"2026-04-10T18:11:08.733338Z","steps":["trace[611276225] 'process raft request' (duration: 142.675594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.733796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.665261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:11:08.733874Z","caller":"traceutil/trace.go:171","msg":"trace[303755366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4825; }","duration":"196.802764ms","start":"2026-04-10T18:11:08.537056Z","end":"2026-04-10T18:11:08.733859Z","steps":["trace[303755366] 'agreement among raft nodes before linearized reading' (duration: 196.467046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.734007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.587921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-10T18:11:08.734136Z","caller":"traceutil/trace.go:171","msg":"trace[398188066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4825; }","duration":"167.779705ms","start":"2026-04-10T18:11:08.566334Z","end":"2026-04-10T18:11:08.734113Z","steps":["trace[398188066] 'agreement among raft nodes before linearized reading' (duration: 167.049039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.734416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.641422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cbacc7f0-b0ab-4629-b44f-0571e4c7314f\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-04-10T18:11:08.734521Z","caller":"traceutil/trace.go:171","msg":"trace[1862510464] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cbacc7f0-b0ab-4629-b44f-0571e4c7314f; range_end:; response_count:1; response_revision:4825; }","duration":"169.761164ms","start":"2026-04-10T18:11:08.564737Z","end":"2026-04-10T18:11:08.734498Z","steps":["trace[1862510464] 'agreement among raft nodes before linearized reading' (duration: 168.723023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:08.734728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.39772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2196043"} {"level":"info","ts":"2026-04-10T18:11:08.734819Z","caller":"traceutil/trace.go:171","msg":"trace[1606488301] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4825; }","duration":"112.535983ms","start":"2026-04-10T18:11:08.622259Z","end":"2026-04-10T18:11:08.734795Z","steps":["trace[1606488301] 'agreement among raft nodes before linearized reading' (duration: 111.317028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:09.162198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.313059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:11:09.162433Z","caller":"traceutil/trace.go:171","msg":"trace[1215396564] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"119.339599ms","start":"2026-04-10T18:11:09.043075Z","end":"2026-04-10T18:11:09.162415Z","steps":["trace[1215396564] 'process raft request' (duration: 16.722763ms)","trace[1215396564] 'compare' (duration: 102.166996ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:09.16292Z","caller":"traceutil/trace.go:171","msg":"trace[1094702910] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"119.611605ms","start":"2026-04-10T18:11:09.043277Z","end":"2026-04-10T18:11:09.162889Z","steps":["trace[1094702910] 'process raft request' (duration: 119.019793ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:13.077938Z","caller":"traceutil/trace.go:171","msg":"trace[1656864937] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"224.015645ms","start":"2026-04-10T18:11:12.853901Z","end":"2026-04-10T18:11:13.077916Z","steps":["trace[1656864937] 'process raft request' (duration: 223.893312ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:13.182129Z","caller":"traceutil/trace.go:171","msg":"trace[112093537] linearizableReadLoop","detail":"{readStateIndex:5109; appliedIndex:5108; }","duration":"197.72653ms","start":"2026-04-10T18:11:12.984384Z","end":"2026-04-10T18:11:13.18211Z","steps":["trace[112093537] 'read index received' (duration: 93.893431ms)","trace[112093537] 'applied index is now lower than readState.Index' (duration: 103.832409ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:13.182209Z","caller":"traceutil/trace.go:171","msg":"trace[263946621] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"112.026673ms","start":"2026-04-10T18:11:13.070174Z","end":"2026-04-10T18:11:13.1822Z","steps":["trace[263946621] 'process raft request' (duration: 111.88853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:13.182433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.033147ms","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-10T18:11:13.182551Z","caller":"traceutil/trace.go:171","msg":"trace[1085235723] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4927; }","duration":"198.196381ms","start":"2026-04-10T18:11:12.984332Z","end":"2026-04-10T18:11:13.182529Z","steps":["trace[1085235723] 'agreement among raft nodes before linearized reading' (duration: 197.902714ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:13.182294Z","caller":"traceutil/trace.go:171","msg":"trace[206798320] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"298.125531ms","start":"2026-04-10T18:11:12.88408Z","end":"2026-04-10T18:11:13.182206Z","steps":["trace[206798320] 'process raft request' (duration: 297.855996ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:17.136292Z","caller":"traceutil/trace.go:171","msg":"trace[620885236] linearizableReadLoop","detail":"{readStateIndex:5270; appliedIndex:5269; }","duration":"374.381013ms","start":"2026-04-10T18:11:16.761877Z","end":"2026-04-10T18:11:17.136258Z","steps":["trace[620885236] 'read index received' (duration: 374.133918ms)","trace[620885236] 'applied index is now lower than readState.Index' (duration: 246.215µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:17.136426Z","caller":"traceutil/trace.go:171","msg":"trace[371142546] transaction","detail":"{read_only:false; response_revision:5084; number_of_response:1; }","duration":"394.83807ms","start":"2026-04-10T18:11:16.741559Z","end":"2026-04-10T18:11:17.136397Z","steps":["trace[371142546] 'process raft request' (duration: 394.445743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:17.136563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.657538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-zj7dl-tls\" ","response":"range_response_count:1 size:2184"} {"level":"warn","ts":"2026-04-10T18:11:17.136635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:16.741543Z","time spent":"394.953122ms","remote":"127.0.0.1:35264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3703,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:11:17.136667Z","caller":"traceutil/trace.go:171","msg":"trace[843329514] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-zj7dl-tls; range_end:; response_count:1; response_revision:5084; }","duration":"374.7982ms","start":"2026-04-10T18:11:16.761845Z","end":"2026-04-10T18:11:17.136643Z","steps":["trace[843329514] 'agreement among raft nodes before linearized reading' (duration: 374.559146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:17.136734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:16.76183Z","time spent":"374.893533ms","remote":"127.0.0.1:38092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":2207,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-zj7dl-tls\" "} {"level":"info","ts":"2026-04-10T18:11:17.181392Z","caller":"traceutil/trace.go:171","msg":"trace[1209453049] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"390.257748ms","start":"2026-04-10T18:11:16.791076Z","end":"2026-04-10T18:11:17.181334Z","steps":["trace[1209453049] 'process raft request' (duration: 389.894961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:17.181545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:16.791047Z","time spent":"390.420491ms","remote":"127.0.0.1:39024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":413790,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:11:17.182482Z","caller":"traceutil/trace.go:171","msg":"trace[954948290] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"320.047259ms","start":"2026-04-10T18:11:16.862408Z","end":"2026-04-10T18:11:17.182455Z","steps":["trace[954948290] 'process raft request' (duration: 318.863626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:17.182634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:16.86238Z","time spent":"320.164732ms","remote":"127.0.0.1:35344","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-10T18:11:17.380722Z","caller":"traceutil/trace.go:171","msg":"trace[581488805] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"147.142372ms","start":"2026-04-10T18:11:17.233545Z","end":"2026-04-10T18:11:17.380687Z","steps":["trace[581488805] 'process raft request' (duration: 61.264221ms)","trace[581488805] 'compare' (duration: 78.337132ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:17.639975Z","caller":"traceutil/trace.go:171","msg":"trace[719204987] linearizableReadLoop","detail":"{readStateIndex:5279; appliedIndex:5278; }","duration":"115.601665ms","start":"2026-04-10T18:11:17.524343Z","end":"2026-04-10T18:11:17.639944Z","steps":["trace[719204987] 'read index received' (duration: 90.112747ms)","trace[719204987] 'applied index is now lower than readState.Index' (duration: 25.487608ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:17.640401Z","caller":"traceutil/trace.go:171","msg":"trace[462029445] transaction","detail":"{read_only:false; response_revision:5093; number_of_response:1; }","duration":"186.401325ms","start":"2026-04-10T18:11:17.453984Z","end":"2026-04-10T18:11:17.640385Z","steps":["trace[462029445] 'process raft request' (duration: 160.457929ms)","trace[462029445] 'compare' (duration: 25.155261ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:11:17.640636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.273228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777461"} {"level":"info","ts":"2026-04-10T18:11:17.640725Z","caller":"traceutil/trace.go:171","msg":"trace[1550252558] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5093; }","duration":"116.37272ms","start":"2026-04-10T18:11:17.524334Z","end":"2026-04-10T18:11:17.640706Z","steps":["trace[1550252558] 'agreement among raft nodes before linearized reading' (duration: 115.818329ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:17.664218Z","caller":"traceutil/trace.go:171","msg":"trace[318323620] transaction","detail":"{read_only:false; response_revision:5094; number_of_response:1; }","duration":"101.218037ms","start":"2026-04-10T18:11:17.562938Z","end":"2026-04-10T18:11:17.664156Z","steps":["trace[318323620] 'process raft request' (duration: 101.101105ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:17.778601Z","caller":"traceutil/trace.go:171","msg":"trace[708507351] linearizableReadLoop","detail":"{readStateIndex:5281; appliedIndex:5280; }","duration":"138.536801ms","start":"2026-04-10T18:11:17.640042Z","end":"2026-04-10T18:11:17.778579Z","steps":["trace[708507351] 'read index received' (duration: 24.1123ms)","trace[708507351] 'applied index is now lower than readState.Index' (duration: 114.423341ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:11:17.778772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.814403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:11:17.778805Z","caller":"traceutil/trace.go:171","msg":"trace[715973097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5094; }","duration":"198.900675ms","start":"2026-04-10T18:11:17.579893Z","end":"2026-04-10T18:11:17.778794Z","steps":["trace[715973097] 'agreement among raft nodes before linearized reading' (duration: 198.822783ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:19.544962Z","caller":"traceutil/trace.go:171","msg":"trace[645669647] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"115.334279ms","start":"2026-04-10T18:11:19.429606Z","end":"2026-04-10T18:11:19.54494Z","steps":["trace[645669647] 'process raft request' (duration: 115.071374ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:26.805249Z","caller":"traceutil/trace.go:171","msg":"trace[1095213501] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"145.411958ms","start":"2026-04-10T18:11:26.659782Z","end":"2026-04-10T18:11:26.805194Z","steps":["trace[1095213501] 'process raft request' (duration: 124.878469ms)","trace[1095213501] 'compare' (duration: 19.485508ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:11:27.231886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.453954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:11:27.232027Z","caller":"traceutil/trace.go:171","msg":"trace[852579616] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"424.439316ms","start":"2026-04-10T18:11:26.807562Z","end":"2026-04-10T18:11:27.232002Z","steps":["trace[852579616] 'process raft request' (duration: 252.789818ms)","trace[852579616] 'compare' (duration: 171.087397ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:11:27.232106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:26.807531Z","time spent":"424.540438ms","remote":"127.0.0.1:35266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T18:11:27.527375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.163178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:11:27.527603Z","caller":"traceutil/trace.go:171","msg":"trace[380485109] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"710.997678ms","start":"2026-04-10T18:11:26.81657Z","end":"2026-04-10T18:11:27.527567Z","steps":["trace[380485109] 'process raft request' (duration: 534.548264ms)","trace[380485109] 'compare' (duration: 176.014256ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:27.527659Z","caller":"traceutil/trace.go:171","msg":"trace[1984614287] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"290.968171ms","start":"2026-04-10T18:11:27.236672Z","end":"2026-04-10T18:11:27.52764Z","steps":["trace[1984614287] 'process raft request' (duration: 290.92803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.527757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:26.816555Z","time spent":"711.12439ms","remote":"127.0.0.1:35264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8035,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:11:27.52777Z","caller":"traceutil/trace.go:171","msg":"trace[543598350] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"291.266557ms","start":"2026-04-10T18:11:27.236483Z","end":"2026-04-10T18:11:27.52775Z","steps":["trace[543598350] 'process raft request' (duration: 291.077713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.527964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.597249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:11:27.527751Z","caller":"traceutil/trace.go:171","msg":"trace[794443531] linearizableReadLoop","detail":"{readStateIndex:5478; appliedIndex:5477; }","duration":"438.395924ms","start":"2026-04-10T18:11:27.089331Z","end":"2026-04-10T18:11:27.527727Z","steps":["trace[794443531] 'read index received' (duration: 261.687695ms)","trace[794443531] 'applied index is now lower than readState.Index' (duration: 176.705919ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:27.528038Z","caller":"traceutil/trace.go:171","msg":"trace[1647693508] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5288; }","duration":"438.723041ms","start":"2026-04-10T18:11:27.08929Z","end":"2026-04-10T18:11:27.528013Z","steps":["trace[1647693508] 'agreement among raft nodes before linearized reading' (duration: 438.513447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.528111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:27.089271Z","time spent":"438.821904ms","remote":"127.0.0.1:57670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-10T18:11:27.528311Z","caller":"traceutil/trace.go:171","msg":"trace[399293719] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"309.113193ms","start":"2026-04-10T18:11:27.218601Z","end":"2026-04-10T18:11:27.527714Z","steps":["trace[399293719] 'process raft request' (duration: 308.885218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.528457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:27.218574Z","time spent":"309.774217ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T18:11:27.538378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.566318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-10T18:11:27.538439Z","caller":"traceutil/trace.go:171","msg":"trace[1495269499] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5289; }","duration":"102.67131ms","start":"2026-04-10T18:11:27.435752Z","end":"2026-04-10T18:11:27.538423Z","steps":["trace[1495269499] 'agreement among raft nodes before linearized reading' (duration: 102.528487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.53858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.681355ms","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-10T18:11:27.538601Z","caller":"traceutil/trace.go:171","msg":"trace[94563155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5289; }","duration":"275.731086ms","start":"2026-04-10T18:11:27.262865Z","end":"2026-04-10T18:11:27.538596Z","steps":["trace[94563155] 'agreement among raft nodes before linearized reading' (duration: 275.676635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.538742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.404731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-10T18:11:27.538833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.239377ms","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-10T18:11:27.538833Z","caller":"traceutil/trace.go:171","msg":"trace[1361042103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5289; }","duration":"254.563024ms","start":"2026-04-10T18:11:27.284251Z","end":"2026-04-10T18:11:27.538815Z","steps":["trace[1361042103] 'agreement among raft nodes before linearized reading' (duration: 254.259888ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.538862Z","caller":"traceutil/trace.go:171","msg":"trace[1030027328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5289; }","duration":"237.295678ms","start":"2026-04-10T18:11:27.30156Z","end":"2026-04-10T18:11:27.538856Z","steps":["trace[1030027328] 'agreement among raft nodes before linearized reading' (duration: 237.226847ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.672374Z","caller":"traceutil/trace.go:171","msg":"trace[651571864] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"130.397445ms","start":"2026-04-10T18:11:27.541896Z","end":"2026-04-10T18:11:27.672294Z","steps":["trace[651571864] 'process raft request' (duration: 105.046418ms)","trace[651571864] 'compare' (duration: 25.090202ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:27.672402Z","caller":"traceutil/trace.go:171","msg":"trace[1479162519] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"130.467256ms","start":"2026-04-10T18:11:27.541903Z","end":"2026-04-10T18:11:27.672371Z","steps":["trace[1479162519] 'process raft request' (duration: 130.303813ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.672694Z","caller":"traceutil/trace.go:171","msg":"trace[1480663891] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"130.70421ms","start":"2026-04-10T18:11:27.541976Z","end":"2026-04-10T18:11:27.67268Z","steps":["trace[1480663891] 'process raft request' (duration: 130.315613ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.672714Z","caller":"traceutil/trace.go:171","msg":"trace[365653737] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"129.774262ms","start":"2026-04-10T18:11:27.542926Z","end":"2026-04-10T18:11:27.6727Z","steps":["trace[365653737] 'process raft request' (duration: 129.648649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.701899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.629761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:11:27.701985Z","caller":"traceutil/trace.go:171","msg":"trace[535407247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5298; }","duration":"107.765823ms","start":"2026-04-10T18:11:27.594198Z","end":"2026-04-10T18:11:27.701964Z","steps":["trace[535407247] 'agreement among raft nodes before linearized reading' (duration: 78.60381ms)","trace[535407247] 'range keys from in-memory index tree' (duration: 29.03358ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:33.87464Z","caller":"traceutil/trace.go:171","msg":"trace[1726010046] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"129.516806ms","start":"2026-04-10T18:11:33.745097Z","end":"2026-04-10T18:11:33.874614Z","steps":["trace[1726010046] 'process raft request' (duration: 106.757622ms)","trace[1726010046] 'compare' (duration: 22.648462ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:33.878895Z","caller":"traceutil/trace.go:171","msg":"trace[1064851186] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"133.056938ms","start":"2026-04-10T18:11:33.745814Z","end":"2026-04-10T18:11:33.878871Z","steps":["trace[1064851186] 'process raft request' (duration: 132.973156ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:33.878968Z","caller":"traceutil/trace.go:171","msg":"trace[919735929] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"133.219101ms","start":"2026-04-10T18:11:33.745722Z","end":"2026-04-10T18:11:33.878941Z","steps":["trace[919735929] 'process raft request' (duration: 132.958665ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:33.879199Z","caller":"traceutil/trace.go:171","msg":"trace[1113410947] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"109.003957ms","start":"2026-04-10T18:11:33.770167Z","end":"2026-04-10T18:11:33.87917Z","steps":["trace[1113410947] 'process raft request' (duration: 108.885194ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:33.87919Z","caller":"traceutil/trace.go:171","msg":"trace[1352650460] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"109.266402ms","start":"2026-04-10T18:11:33.769889Z","end":"2026-04-10T18:11:33.879155Z","steps":["trace[1352650460] 'process raft request' (duration: 108.938686ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:36.014049Z","caller":"traceutil/trace.go:171","msg":"trace[963312884] linearizableReadLoop","detail":"{readStateIndex:5621; appliedIndex:5620; }","duration":"134.966195ms","start":"2026-04-10T18:11:35.879046Z","end":"2026-04-10T18:11:36.014013Z","steps":["trace[963312884] 'read index received' (duration: 134.736541ms)","trace[963312884] 'applied index is now lower than readState.Index' (duration: 227.834µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:36.014102Z","caller":"traceutil/trace.go:171","msg":"trace[2045706504] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"178.085518ms","start":"2026-04-10T18:11:35.835981Z","end":"2026-04-10T18:11:36.014066Z","steps":["trace[2045706504] 'process raft request' (duration: 177.799162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:36.01436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.276401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-10T18:11:36.014405Z","caller":"traceutil/trace.go:171","msg":"trace[840736115] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5426; }","duration":"135.354663ms","start":"2026-04-10T18:11:35.879038Z","end":"2026-04-10T18:11:36.014393Z","steps":["trace[840736115] 'agreement among raft nodes before linearized reading' (duration: 135.154229ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:36.211746Z","caller":"traceutil/trace.go:171","msg":"trace[1957816196] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"325.695064ms","start":"2026-04-10T18:11:35.886022Z","end":"2026-04-10T18:11:36.211717Z","steps":["trace[1957816196] 'process raft request' (duration: 324.542712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:36.21196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:35.886003Z","time spent":"325.838187ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:11:36.21212Z","caller":"traceutil/trace.go:171","msg":"trace[1227636025] linearizableReadLoop","detail":"{readStateIndex:5623; appliedIndex:5621; }","duration":"197.928372ms","start":"2026-04-10T18:11:36.014154Z","end":"2026-04-10T18:11:36.212082Z","steps":["trace[1227636025] 'read index received' (duration: 196.379682ms)","trace[1227636025] 'applied index is now lower than readState.Index' (duration: 1.54505ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:36.21228Z","caller":"traceutil/trace.go:171","msg":"trace[523670965] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"326.149413ms","start":"2026-04-10T18:11:35.886102Z","end":"2026-04-10T18:11:36.212252Z","steps":["trace[523670965] 'process raft request' (duration: 325.52118ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:36.21215Z","caller":"traceutil/trace.go:171","msg":"trace[1142942351] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"192.876731ms","start":"2026-04-10T18:11:36.019244Z","end":"2026-04-10T18:11:36.212121Z","steps":["trace[1142942351] 'process raft request' (duration: 192.660527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:36.212457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.433789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-10T18:11:36.212456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:35.886075Z","time spent":"326.271017ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T18:11:36.212471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.434345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-q4kmv\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-04-10T18:11:36.21248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.983591ms","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-10T18:11:36.212511Z","caller":"traceutil/trace.go:171","msg":"trace[2059728732] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5430; }","duration":"328.530912ms","start":"2026-04-10T18:11:35.883969Z","end":"2026-04-10T18:11:36.2125Z","steps":["trace[2059728732] 'agreement among raft nodes before linearized reading' (duration: 328.342128ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:36.21253Z","caller":"traceutil/trace.go:171","msg":"trace[1184130169] range","detail":"{range_begin:/registry/pods/openstack/keepalived-q4kmv; range_end:; response_count:1; response_revision:5430; }","duration":"130.554278ms","start":"2026-04-10T18:11:36.081961Z","end":"2026-04-10T18:11:36.212515Z","steps":["trace[1184130169] 'agreement among raft nodes before linearized reading' (duration: 130.388695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:36.212544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:35.883949Z","time spent":"328.587803ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-10T18:11:36.212543Z","caller":"traceutil/trace.go:171","msg":"trace[489155228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5430; }","duration":"328.086943ms","start":"2026-04-10T18:11:35.88444Z","end":"2026-04-10T18:11:36.212527Z","steps":["trace[489155228] 'agreement among raft nodes before linearized reading' (duration: 327.827437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:36.212609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:11:35.884414Z","time spent":"328.176384ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T18:11:50.052199Z","caller":"traceutil/trace.go:171","msg":"trace[1406439561] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"176.871153ms","start":"2026-04-10T18:11:49.875271Z","end":"2026-04-10T18:11:50.052142Z","steps":["trace[1406439561] 'process raft request' (duration: 176.472595ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:12:39.452663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3004} {"level":"info","ts":"2026-04-10T18:12:39.536539Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3004,"took":"82.268155ms","hash":1490663132,"current-db-size-bytes":56754176,"current-db-size":"57 MB","current-db-size-in-use-bytes":31084544,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-10T18:12:39.536621Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1490663132,"revision":3004,"compact-revision":-1} {"level":"warn","ts":"2026-04-10T18:13:41.182666Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903911090727566047,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T18:13:41.238419Z","caller":"traceutil/trace.go:171","msg":"trace[33025175] transaction","detail":"{read_only:false; response_revision:6483; number_of_response:1; }","duration":"572.170096ms","start":"2026-04-10T18:13:40.666211Z","end":"2026-04-10T18:13:41.238381Z","steps":["trace[33025175] 'process raft request' (duration: 571.887621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.238772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.666166Z","time spent":"572.473512ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:13:41.264362Z","caller":"traceutil/trace.go:171","msg":"trace[1446316646] linearizableReadLoop","detail":"{readStateIndex:6712; appliedIndex:6710; }","duration":"581.702826ms","start":"2026-04-10T18:13:40.682585Z","end":"2026-04-10T18:13:41.264288Z","steps":["trace[1446316646] 'read index received' (duration: 555.594585ms)","trace[1446316646] 'applied index is now lower than readState.Index' (duration: 26.106631ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:13:41.264454Z","caller":"traceutil/trace.go:171","msg":"trace[1959727867] transaction","detail":"{read_only:false; response_revision:6484; number_of_response:1; }","duration":"597.568214ms","start":"2026-04-10T18:13:40.666836Z","end":"2026-04-10T18:13:41.264405Z","steps":["trace[1959727867] 'process raft request' (duration: 597.241967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.264786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.155925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-10T18:13:41.264904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.666799Z","time spent":"597.93315ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T18:13:41.264956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.406674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-10T18:13:41.265011Z","caller":"traceutil/trace.go:171","msg":"trace[1271547445] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6484; }","duration":"582.327558ms","start":"2026-04-10T18:13:40.682539Z","end":"2026-04-10T18:13:41.264867Z","steps":["trace[1271547445] 'agreement among raft nodes before linearized reading' (duration: 582.002571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.265163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.539587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-04-10T18:13:41.265246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.061037ms","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-10T18:13:41.265071Z","caller":"traceutil/trace.go:171","msg":"trace[464169125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6484; }","duration":"375.544306ms","start":"2026-04-10T18:13:40.889499Z","end":"2026-04-10T18:13:41.265043Z","steps":["trace[464169125] 'agreement among raft nodes before linearized reading' (duration: 375.23572ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:13:41.265307Z","caller":"traceutil/trace.go:171","msg":"trace[2011818487] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6484; }","duration":"229.750212ms","start":"2026-04-10T18:13:41.035528Z","end":"2026-04-10T18:13:41.265278Z","steps":["trace[2011818487] 'agreement among raft nodes before linearized reading' (duration: 229.301052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.265104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.25773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-10T18:13:41.265448Z","caller":"traceutil/trace.go:171","msg":"trace[1084941021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6484; }","duration":"367.68983ms","start":"2026-04-10T18:13:40.897734Z","end":"2026-04-10T18:13:41.265423Z","steps":["trace[1084941021] 'agreement among raft nodes before linearized reading' (duration: 367.134108ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:13:41.265441Z","caller":"traceutil/trace.go:171","msg":"trace[1841839508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6484; }","duration":"375.134898ms","start":"2026-04-10T18:13:40.890167Z","end":"2026-04-10T18:13:41.265302Z","steps":["trace[1841839508] 'agreement among raft nodes before linearized reading' (duration: 374.719989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.26551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.897716Z","time spent":"367.776421ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T18:13:41.265352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.889415Z","time spent":"375.903984ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T18:13:41.265557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.890088Z","time spent":"375.411363ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T18:13:41.265448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.682516Z","time spent":"582.703758ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-10T18:13:41.265656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.944334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-q4kmv\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-10T18:13:41.265798Z","caller":"traceutil/trace.go:171","msg":"trace[961170834] range","detail":"{range_begin:/registry/pods/openstack/keepalived-q4kmv; range_end:; response_count:1; response_revision:6484; }","duration":"367.147509ms","start":"2026-04-10T18:13:40.898622Z","end":"2026-04-10T18:13:41.26577Z","steps":["trace[961170834] 'agreement among raft nodes before linearized reading' (duration: 366.163068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.265873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.898602Z","time spent":"367.25744ms","remote":"127.0.0.1:35264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-q4kmv\" "} {"level":"info","ts":"2026-04-10T18:17:39.500514Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6041} {"level":"info","ts":"2026-04-10T18:17:39.751327Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6041,"took":"248.452032ms","hash":4065836029,"current-db-size-bytes":56754176,"current-db-size":"57 MB","current-db-size-in-use-bytes":21667840,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-10T18:17:39.751382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4065836029,"revision":6041,"compact-revision":3004} {"level":"warn","ts":"2026-04-10T18:17:49.17562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.394895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:17:49.175693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.366945ms","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-10T18:17:49.17581Z","caller":"traceutil/trace.go:171","msg":"trace[1325916551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8332; }","duration":"417.518217ms","start":"2026-04-10T18:17:48.758266Z","end":"2026-04-10T18:17:49.175784Z","steps":["trace[1325916551] 'range keys from in-memory index tree' (duration: 417.207251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:49.175897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:17:48.758259Z","time spent":"417.625519ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-10T18:17:49.175745Z","caller":"traceutil/trace.go:171","msg":"trace[868446452] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:8332; }","duration":"430.584729ms","start":"2026-04-10T18:17:48.745132Z","end":"2026-04-10T18:17:49.175717Z","steps":["trace[868446452] 'count revisions from in-memory index tree' (duration: 430.217571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:49.176063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:17:48.745102Z","time spent":"430.936165ms","remote":"127.0.0.1:39046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"info","ts":"2026-04-10T18:17:49.17622Z","caller":"traceutil/trace.go:171","msg":"trace[160247322] linearizableReadLoop","detail":"{readStateIndex:8623; appliedIndex:8622; }","duration":"263.959851ms","start":"2026-04-10T18:17:48.912202Z","end":"2026-04-10T18:17:49.176162Z","steps":["trace[160247322] 'read index received' (duration: 262.9254ms)","trace[160247322] 'applied index is now lower than readState.Index' (duration: 1.033141ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:17:49.176221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.587028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:17:49.176252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.909815ms","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-10T18:17:49.176252Z","caller":"traceutil/trace.go:171","msg":"trace[1656255166] transaction","detail":"{read_only:false; response_revision:8333; number_of_response:1; }","duration":"265.336049ms","start":"2026-04-10T18:17:48.910876Z","end":"2026-04-10T18:17:49.176212Z","steps":["trace[1656255166] 'process raft request' (duration: 264.238537ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:17:49.176296Z","caller":"traceutil/trace.go:171","msg":"trace[1030506364] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8332; }","duration":"422.705691ms","start":"2026-04-10T18:17:48.753572Z","end":"2026-04-10T18:17:49.176278Z","steps":["trace[1030506364] 'count revisions from in-memory index tree' (duration: 422.407815ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:17:49.17633Z","caller":"traceutil/trace.go:171","msg":"trace[478973475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8332; }","duration":"420.006048ms","start":"2026-04-10T18:17:48.756308Z","end":"2026-04-10T18:17:49.176314Z","steps":["trace[478973475] 'range keys from in-memory index tree' (duration: 419.744902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:49.176338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:17:48.753554Z","time spent":"422.774043ms","remote":"127.0.0.1:45498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-04-10T18:17:49.176371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:17:48.7563Z","time spent":"420.061169ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T18:17:49.176332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.460877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-q4kmv\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-10T18:17:49.176443Z","caller":"traceutil/trace.go:171","msg":"trace[1146137795] range","detail":"{range_begin:/registry/pods/openstack/keepalived-q4kmv; range_end:; response_count:1; response_revision:8332; }","duration":"373.615141ms","start":"2026-04-10T18:17:48.802802Z","end":"2026-04-10T18:17:49.176417Z","steps":["trace[1146137795] 'range keys from in-memory index tree' (duration: 373.132081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:49.17647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.287997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/barbican-api-6877cbf56-mbfvv\" ","response":"range_response_count:1 size:8463"} {"level":"warn","ts":"2026-04-10T18:17:49.176493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:17:48.802784Z","time spent":"373.699232ms","remote":"127.0.0.1:35264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-q4kmv\" "} {"level":"info","ts":"2026-04-10T18:17:49.176532Z","caller":"traceutil/trace.go:171","msg":"trace[289250572] range","detail":"{range_begin:/registry/pods/openstack/barbican-api-6877cbf56-mbfvv; range_end:; response_count:1; response_revision:8333; }","duration":"264.493402ms","start":"2026-04-10T18:17:48.912022Z","end":"2026-04-10T18:17:49.176516Z","steps":["trace[289250572] 'agreement among raft nodes before linearized reading' (duration: 264.252607ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:00.694138Z","caller":"traceutil/trace.go:171","msg":"trace[330006870] transaction","detail":"{read_only:false; response_revision:8395; number_of_response:1; }","duration":"470.322798ms","start":"2026-04-10T18:18:00.223791Z","end":"2026-04-10T18:18:00.694113Z","steps":["trace[330006870] 'process raft request' (duration: 470.166064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:00.694287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:00.223766Z","time spent":"470.44156ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:18:00.710246Z","caller":"traceutil/trace.go:171","msg":"trace[1981447002] transaction","detail":"{read_only:false; response_revision:8396; number_of_response:1; }","duration":"380.707131ms","start":"2026-04-10T18:18:00.329497Z","end":"2026-04-10T18:18:00.710204Z","steps":["trace[1981447002] 'process raft request' (duration: 380.466767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:00.710376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.109078ms","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-10T18:18:00.710432Z","caller":"traceutil/trace.go:171","msg":"trace[635269666] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8396; }","duration":"246.26499ms","start":"2026-04-10T18:18:00.464155Z","end":"2026-04-10T18:18:00.71042Z","steps":["trace[635269666] 'agreement among raft nodes before linearized reading' (duration: 246.139898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:00.710451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:00.329473Z","time spent":"380.879075ms","remote":"127.0.0.1:35344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:18:00.710172Z","caller":"traceutil/trace.go:171","msg":"trace[1961990482] linearizableReadLoop","detail":"{readStateIndex:8689; appliedIndex:8687; }","duration":"245.904144ms","start":"2026-04-10T18:18:00.464232Z","end":"2026-04-10T18:18:00.710136Z","steps":["trace[1961990482] 'read index received' (duration: 229.65695ms)","trace[1961990482] 'applied index is now lower than readState.Index' (duration: 16.245394ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:02.859432Z","caller":"traceutil/trace.go:171","msg":"trace[1450302546] linearizableReadLoop","detail":"{readStateIndex:8700; appliedIndex:8699; }","duration":"149.676025ms","start":"2026-04-10T18:18:02.70973Z","end":"2026-04-10T18:18:02.859406Z","steps":["trace[1450302546] 'read index received' (duration: 149.595203ms)","trace[1450302546] 'applied index is now lower than readState.Index' (duration: 79.682µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:02.859488Z","caller":"traceutil/trace.go:171","msg":"trace[1308875439] transaction","detail":"{read_only:false; response_revision:8406; number_of_response:1; }","duration":"160.431828ms","start":"2026-04-10T18:18:02.69902Z","end":"2026-04-10T18:18:02.859452Z","steps":["trace[1308875439] 'process raft request' (duration: 160.205794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:02.85964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.88855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-10T18:18:02.859698Z","caller":"traceutil/trace.go:171","msg":"trace[1956209100] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8406; }","duration":"149.985261ms","start":"2026-04-10T18:18:02.7097Z","end":"2026-04-10T18:18:02.859685Z","steps":["trace[1956209100] 'agreement among raft nodes before linearized reading' (duration: 149.822608ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:02.951215Z","caller":"traceutil/trace.go:171","msg":"trace[1877159761] transaction","detail":"{read_only:false; response_revision:8408; number_of_response:1; }","duration":"236.285641ms","start":"2026-04-10T18:18:02.714903Z","end":"2026-04-10T18:18:02.951189Z","steps":["trace[1877159761] 'process raft request' (duration: 236.123258ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:02.951336Z","caller":"traceutil/trace.go:171","msg":"trace[872540774] transaction","detail":"{read_only:false; response_revision:8407; number_of_response:1; }","duration":"240.597918ms","start":"2026-04-10T18:18:02.710697Z","end":"2026-04-10T18:18:02.951295Z","steps":["trace[872540774] 'process raft request' (duration: 159.376718ms)","trace[872540774] 'compare' (duration: 80.788471ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:18:02.951817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.220935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-10T18:18:02.951876Z","caller":"traceutil/trace.go:171","msg":"trace[205080175] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8409; }","duration":"160.306006ms","start":"2026-04-10T18:18:02.791554Z","end":"2026-04-10T18:18:02.95186Z","steps":["trace[205080175] 'agreement among raft nodes before linearized reading' (duration: 159.970019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:02.951959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.689622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-10T18:18:02.952015Z","caller":"traceutil/trace.go:171","msg":"trace[127034092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8409; }","duration":"182.782995ms","start":"2026-04-10T18:18:02.769218Z","end":"2026-04-10T18:18:02.952001Z","steps":["trace[127034092] 'agreement among raft nodes before linearized reading' (duration: 182.320155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:02.952431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.343298ms","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-10T18:18:02.952481Z","caller":"traceutil/trace.go:171","msg":"trace[114108859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8409; }","duration":"160.405459ms","start":"2026-04-10T18:18:02.792061Z","end":"2026-04-10T18:18:02.952467Z","steps":["trace[114108859] 'agreement among raft nodes before linearized reading' (duration: 159.447479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:02.952487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.187445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-10T18:18:02.952537Z","caller":"traceutil/trace.go:171","msg":"trace[1115103599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8409; }","duration":"161.251586ms","start":"2026-04-10T18:18:02.791272Z","end":"2026-04-10T18:18:02.952523Z","steps":["trace[1115103599] 'agreement among raft nodes before linearized reading' (duration: 160.259875ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:33.120663Z","caller":"traceutil/trace.go:171","msg":"trace[685521003] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"149.288757ms","start":"2026-04-10T18:18:32.971349Z","end":"2026-04-10T18:18:33.120638Z","steps":["trace[685521003] 'process raft request' (duration: 149.121994ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:33.123474Z","caller":"traceutil/trace.go:171","msg":"trace[6219261] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"145.136504ms","start":"2026-04-10T18:18:32.9783Z","end":"2026-04-10T18:18:33.123437Z","steps":["trace[6219261] 'process raft request' (duration: 144.898439ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:43.641838Z","caller":"traceutil/trace.go:171","msg":"trace[118921457] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"228.66234ms","start":"2026-04-10T18:18:43.413143Z","end":"2026-04-10T18:18:43.641805Z","steps":["trace[118921457] 'process raft request' (duration: 228.288152ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:43.64812Z","caller":"traceutil/trace.go:171","msg":"trace[1190978490] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8721; }","duration":"234.235061ms","start":"2026-04-10T18:18:43.413859Z","end":"2026-04-10T18:18:43.648094Z","steps":["trace[1190978490] 'process raft request' (duration: 233.907815ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:43.648259Z","caller":"traceutil/trace.go:171","msg":"trace[563606092] linearizableReadLoop","detail":"{readStateIndex:9028; appliedIndex:9026; }","duration":"202.088849ms","start":"2026-04-10T18:18:43.446156Z","end":"2026-04-10T18:18:43.648245Z","steps":["trace[563606092] 'read index received' (duration: 195.229202ms)","trace[563606092] 'applied index is now lower than readState.Index' (duration: 6.859027ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:43.648403Z","caller":"traceutil/trace.go:171","msg":"trace[2063957722] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"118.126905ms","start":"2026-04-10T18:18:43.530268Z","end":"2026-04-10T18:18:43.648395Z","steps":["trace[2063957722] 'process raft request' (duration: 117.884731ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:43.648399Z","caller":"traceutil/trace.go:171","msg":"trace[149487165] transaction","detail":"{read_only:false; response_revision:8722; number_of_response:1; }","duration":"201.756953ms","start":"2026-04-10T18:18:43.446626Z","end":"2026-04-10T18:18:43.648383Z","steps":["trace[149487165] 'process raft request' (duration: 201.312954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:43.648531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.357685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-pvcs5\" ","response":"range_response_count:1 size:4645"} {"level":"info","ts":"2026-04-10T18:18:43.648583Z","caller":"traceutil/trace.go:171","msg":"trace[1980344821] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-pvcs5; range_end:; response_count:1; response_revision:8723; }","duration":"202.417336ms","start":"2026-04-10T18:18:43.446151Z","end":"2026-04-10T18:18:43.648568Z","steps":["trace[1980344821] 'agreement among raft nodes before linearized reading' (duration: 202.323714ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:44.232741Z","caller":"traceutil/trace.go:171","msg":"trace[310854247] linearizableReadLoop","detail":"{readStateIndex:9035; appliedIndex:9034; }","duration":"104.366461ms","start":"2026-04-10T18:18:44.128345Z","end":"2026-04-10T18:18:44.232712Z","steps":["trace[310854247] 'read index received' (duration: 104.227078ms)","trace[310854247] 'applied index is now lower than readState.Index' (duration: 138.233µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:44.232769Z","caller":"traceutil/trace.go:171","msg":"trace[1845815662] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"116.768718ms","start":"2026-04-10T18:18:44.115982Z","end":"2026-04-10T18:18:44.232751Z","steps":["trace[1845815662] 'process raft request' (duration: 116.563914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:44.232919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.539175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T18:18:44.232954Z","caller":"traceutil/trace.go:171","msg":"trace[136163712] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:8728; }","duration":"104.663217ms","start":"2026-04-10T18:18:44.128282Z","end":"2026-04-10T18:18:44.232945Z","steps":["trace[136163712] 'agreement among raft nodes before linearized reading' (duration: 104.525454ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:44.559876Z","caller":"traceutil/trace.go:171","msg":"trace[457704765] linearizableReadLoop","detail":"{readStateIndex:9036; appliedIndex:9035; }","duration":"131.89032ms","start":"2026-04-10T18:18:44.427962Z","end":"2026-04-10T18:18:44.559852Z","steps":["trace[457704765] 'read index received' (duration: 131.609775ms)","trace[457704765] 'applied index is now lower than readState.Index' (duration: 279.645µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:44.559957Z","caller":"traceutil/trace.go:171","msg":"trace[1072275288] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"167.569692ms","start":"2026-04-10T18:18:44.392349Z","end":"2026-04-10T18:18:44.559919Z","steps":["trace[1072275288] 'process raft request' (duration: 167.335587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:44.560078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.106074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-10T18:18:44.560146Z","caller":"traceutil/trace.go:171","msg":"trace[565690594] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8729; }","duration":"132.217246ms","start":"2026-04-10T18:18:44.427912Z","end":"2026-04-10T18:18:44.560129Z","steps":["trace[565690594] 'agreement among raft nodes before linearized reading' (duration: 132.027822ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:19:07.337393Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002463.wal"} {"level":"info","ts":"2026-04-10T18:19:58.949961Z","caller":"traceutil/trace.go:171","msg":"trace[1802125920] transaction","detail":"{read_only:false; response_revision:9466; number_of_response:1; }","duration":"100.875801ms","start":"2026-04-10T18:19:58.849056Z","end":"2026-04-10T18:19:58.949932Z","steps":["trace[1802125920] 'process raft request' (duration: 100.635756ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:20:25.878165Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e892d50a3a4fc0f4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-10T18:20:25.884685Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-10T18:20:25.88478Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-10T18:22:39.507436Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8152} {"level":"info","ts":"2026-04-10T18:22:39.569981Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8152,"took":"60.219739ms","hash":3121692589,"current-db-size-bytes":56754176,"current-db-size":"57 MB","current-db-size-in-use-bytes":28983296,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-10T18:22:39.570092Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3121692589,"revision":8152,"compact-revision":6041} {"level":"info","ts":"2026-04-10T18:27:39.514683Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10677} {"level":"info","ts":"2026-04-10T18:27:39.590173Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10677,"took":"73.390734ms","hash":1566559528,"current-db-size-bytes":56754176,"current-db-size":"57 MB","current-db-size-in-use-bytes":21680128,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-10T18:27:39.590237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1566559528,"revision":10677,"compact-revision":8152}