{"level":"warn","ts":"2026-04-09T05:52:44.806021Z","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-09T05:52:44.806134Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.232: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.232:2380","--initial-cluster=instance=https://199.19.213.232:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.232:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.232: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-09T05:52:44.806221Z","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-09T05:52:44.806236Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-04-09T05:52:44.806266Z","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-09T05:52:44.807266Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"]} {"level":"info","ts":"2026-04-09T05:52:44.807379Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.232: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-09T05:52:44.811479Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.862211ms"} {"level":"info","ts":"2026-04-09T05:52:44.816949Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"20a2700e013b1fa5","cluster-id":"b7b35e617ebc7ac7"} {"level":"info","ts":"2026-04-09T05:52:44.817029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T05:52:44.817051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 0"} {"level":"info","ts":"2026-04-09T05:52:44.817065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 20a2700e013b1fa5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T05:52:44.817074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 1"} {"level":"info","ts":"2026-04-09T05:52:44.817119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"warn","ts":"2026-04-09T05:52:44.822972Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T05:52:44.824085Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T05:52:44.826824Z","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-09T05:52:44.829127Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"20a2700e013b1fa5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T05:52:44.829361Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"20a2700e013b1fa5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T05:52:44.829588Z","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-09T05:52:44.829698Z","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-09T05:52:44.829737Z","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-09T05:52:44.833584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"info","ts":"2026-04-09T05:52:44.834825Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","added-peer-id":"20a2700e013b1fa5","added-peer-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-04-09T05:52:44.838151Z","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-09T05:52:44.838335Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"20a2700e013b1fa5","initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T05:52:44.838357Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T05:52:44.838412Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-04-09T05:52:44.838421Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-04-09T05:52:45.518241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T05:52:45.51832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T05:52:45.51839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgPreVoteResp from 20a2700e013b1fa5 at term 1"} {"level":"info","ts":"2026-04-09T05:52:45.518419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became candidate at term 2"} {"level":"info","ts":"2026-04-09T05:52:45.518436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgVoteResp from 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-04-09T05:52:45.518459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became leader at term 2"} {"level":"info","ts":"2026-04-09T05:52:45.51848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 20a2700e013b1fa5 elected leader 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-04-09T05:52:45.613592Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"20a2700e013b1fa5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.232:2379]}","request-path":"/0/members/20a2700e013b1fa5/attributes","cluster-id":"b7b35e617ebc7ac7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T05:52:45.613761Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T05:52:45.61415Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:52:45.614608Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T05:52:45.616286Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.232:2379"} {"level":"info","ts":"2026-04-09T05:52:45.616436Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T05:52:45.616464Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T05:52:45.618501Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T05:52:45.634927Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:52:45.635608Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:52:45.635654Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:52:51.10958Z","caller":"traceutil/trace.go:171","msg":"trace[228040674] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"142.283164ms","start":"2026-04-09T05:52:50.96723Z","end":"2026-04-09T05:52:51.109513Z","steps":["trace[228040674] 'read index received' (duration: 69.955324ms)","trace[228040674] 'applied index is now lower than readState.Index' (duration: 72.32589ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:52:51.109627Z","caller":"traceutil/trace.go:171","msg":"trace[434201185] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"158.381409ms","start":"2026-04-09T05:52:50.951223Z","end":"2026-04-09T05:52:51.109604Z","steps":["trace[434201185] 'process raft request' (duration: 85.933449ms)","trace[434201185] 'compare' (duration: 72.081058ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:52:51.109764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.509296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:52:51.109865Z","caller":"traceutil/trace.go:171","msg":"trace[996599625] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; response_count:0; response_revision:307; }","duration":"142.698318ms","start":"2026-04-09T05:52:50.967153Z","end":"2026-04-09T05:52:51.109851Z","steps":["trace[996599625] 'agreement among raft nodes before linearized reading' (duration: 142.523977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:52:51.110163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.045257ms","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-09T05:52:51.110291Z","caller":"traceutil/trace.go:171","msg":"trace[524185044] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:307; }","duration":"131.188098ms","start":"2026-04-09T05:52:50.979086Z","end":"2026-04-09T05:52:51.110275Z","steps":["trace[524185044] 'agreement among raft nodes before linearized reading' (duration: 130.968316ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:51.577034Z","caller":"traceutil/trace.go:171","msg":"trace[777943824] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"462.151781ms","start":"2026-04-09T05:52:51.114794Z","end":"2026-04-09T05:52:51.576945Z","steps":["trace[777943824] 'process raft request' (duration: 443.777009ms)","trace[777943824] 'compare' (duration: 17.887938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:52:51.57803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:52:51.114773Z","time spent":"462.415632ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:52:51.741688Z","caller":"traceutil/trace.go:171","msg":"trace[582277588] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"252.469495ms","start":"2026-04-09T05:52:51.489197Z","end":"2026-04-09T05:52:51.741666Z","steps":["trace[582277588] 'process raft request' (duration: 252.394255ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:51.741717Z","caller":"traceutil/trace.go:171","msg":"trace[1135317538] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"612.299714ms","start":"2026-04-09T05:52:51.129368Z","end":"2026-04-09T05:52:51.741667Z","steps":["trace[1135317538] 'process raft request' (duration: 604.269982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:52:51.741873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.742281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:52:51.741919Z","caller":"traceutil/trace.go:171","msg":"trace[283487330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:309; }","duration":"535.857313ms","start":"2026-04-09T05:52:51.206053Z","end":"2026-04-09T05:52:51.74191Z","steps":["trace[283487330] 'agreement among raft nodes before linearized reading' (duration: 535.680911ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:51.741676Z","caller":"traceutil/trace.go:171","msg":"trace[1251956993] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"535.536279ms","start":"2026-04-09T05:52:51.206114Z","end":"2026-04-09T05:52:51.74165Z","steps":["trace[1251956993] 'read index received' (duration: 352.470131ms)","trace[1251956993] 'applied index is now lower than readState.Index' (duration: 183.065098ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:52:51.741934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:52:51.129336Z","time spent":"612.498995ms","remote":"127.0.0.1:59936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-09T05:52:51.741953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:52:51.206031Z","time spent":"535.913283ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-09T05:52:51.742309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.807614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"warn","ts":"2026-04-09T05:52:51.742322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.119881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T05:52:51.742222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.596134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:52:51.742362Z","caller":"traceutil/trace.go:171","msg":"trace[1912210487] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:309; }","duration":"254.898255ms","start":"2026-04-09T05:52:51.487452Z","end":"2026-04-09T05:52:51.74235Z","steps":["trace[1912210487] 'agreement among raft nodes before linearized reading' (duration: 254.792255ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:51.742434Z","caller":"traceutil/trace.go:171","msg":"trace[52808766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:309; }","duration":"444.236411ms","start":"2026-04-09T05:52:51.298124Z","end":"2026-04-09T05:52:51.742361Z","steps":["trace[52808766] 'agreement among raft nodes before linearized reading' (duration: 444.143691ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:51.742421Z","caller":"traceutil/trace.go:171","msg":"trace[472466421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:309; }","duration":"524.775176ms","start":"2026-04-09T05:52:51.217597Z","end":"2026-04-09T05:52:51.742372Z","steps":["trace[472466421] 'agreement among raft nodes before linearized reading' (duration: 524.517614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:52:51.742518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:52:51.298094Z","time spent":"444.387232ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-09T05:52:51.742526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:52:51.217587Z","time spent":"524.906456ms","remote":"127.0.0.1:59768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-09T05:52:51.894538Z","caller":"traceutil/trace.go:171","msg":"trace[805358130] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:320; }","duration":"120.245342ms","start":"2026-04-09T05:52:51.774269Z","end":"2026-04-09T05:52:51.894514Z","steps":["trace[805358130] 'read index received' (duration: 77.067327ms)","trace[805358130] 'applied index is now lower than readState.Index' (duration: 43.176875ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:52:51.894649Z","caller":"traceutil/trace.go:171","msg":"trace[54117605] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"144.291327ms","start":"2026-04-09T05:52:51.750328Z","end":"2026-04-09T05:52:51.894619Z","steps":["trace[54117605] 'process raft request' (duration: 101.074682ms)","trace[54117605] 'compare' (duration: 42.913613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:52:51.894715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.423513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-09T05:52:51.894752Z","caller":"traceutil/trace.go:171","msg":"trace[1611696395] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:312; }","duration":"120.515403ms","start":"2026-04-09T05:52:51.774226Z","end":"2026-04-09T05:52:51.894741Z","steps":["trace[1611696395] 'agreement among raft nodes before linearized reading' (duration: 120.431703ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:51.894718Z","caller":"traceutil/trace.go:171","msg":"trace[1965823252] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"127.811281ms","start":"2026-04-09T05:52:51.766854Z","end":"2026-04-09T05:52:51.894666Z","steps":["trace[1965823252] 'process raft request' (duration: 127.590368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:52:51.894939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.668217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-09T05:52:51.895069Z","caller":"traceutil/trace.go:171","msg":"trace[420747254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:312; }","duration":"119.818518ms","start":"2026-04-09T05:52:51.775232Z","end":"2026-04-09T05:52:51.895051Z","steps":["trace[420747254] 'agreement among raft nodes before linearized reading' (duration: 119.641027ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:55.712565Z","caller":"traceutil/trace.go:171","msg":"trace[2142643731] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"123.905053ms","start":"2026-04-09T05:52:55.588638Z","end":"2026-04-09T05:52:55.712543Z","steps":["trace[2142643731] 'read index received' (duration: 123.739952ms)","trace[2142643731] 'applied index is now lower than readState.Index' (duration: 161.521µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:52:55.712697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.047044ms","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-09T05:52:55.712726Z","caller":"traceutil/trace.go:171","msg":"trace[1958748154] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:388; }","duration":"124.128945ms","start":"2026-04-09T05:52:55.588589Z","end":"2026-04-09T05:52:55.712718Z","steps":["trace[1958748154] 'agreement among raft nodes before linearized reading' (duration: 124.036643ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:52:55.712654Z","caller":"traceutil/trace.go:171","msg":"trace[403375756] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"203.75823ms","start":"2026-04-09T05:52:55.508854Z","end":"2026-04-09T05:52:55.712613Z","steps":["trace[403375756] 'process raft request' (duration: 203.546069ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:01.92451Z","caller":"traceutil/trace.go:171","msg":"trace[1818765195] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"181.69632ms","start":"2026-04-09T05:53:01.742791Z","end":"2026-04-09T05:53:01.924487Z","steps":["trace[1818765195] 'read index received' (duration: 181.502698ms)","trace[1818765195] 'applied index is now lower than readState.Index' (duration: 192.562µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:53:01.924693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.881892ms","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-09T05:53:01.924789Z","caller":"traceutil/trace.go:171","msg":"trace[1002066466] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"182.031152ms","start":"2026-04-09T05:53:01.742745Z","end":"2026-04-09T05:53:01.924776Z","steps":["trace[1002066466] 'agreement among raft nodes before linearized reading' (duration: 181.836921ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:01.924763Z","caller":"traceutil/trace.go:171","msg":"trace[1068318445] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"397.0113ms","start":"2026-04-09T05:53:01.527662Z","end":"2026-04-09T05:53:01.924673Z","steps":["trace[1068318445] 'process raft request' (duration: 396.702777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:01.925207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:01.527647Z","time spent":"397.270111ms","remote":"127.0.0.1:59920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:53:10.27089Z","caller":"traceutil/trace.go:171","msg":"trace[1877889416] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"180.06161ms","start":"2026-04-09T05:53:10.090788Z","end":"2026-04-09T05:53:10.270849Z","steps":["trace[1877889416] 'read index received' (duration: 178.016299ms)","trace[1877889416] 'applied index is now lower than readState.Index' (duration: 2.04372ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:10.27093Z","caller":"traceutil/trace.go:171","msg":"trace[1552666827] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"184.744242ms","start":"2026-04-09T05:53:10.086151Z","end":"2026-04-09T05:53:10.270896Z","steps":["trace[1552666827] 'process raft request' (duration: 182.606227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:10.271038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.235959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-09T05:53:10.271077Z","caller":"traceutil/trace.go:171","msg":"trace[121172959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:462; }","duration":"180.340045ms","start":"2026-04-09T05:53:10.090726Z","end":"2026-04-09T05:53:10.271066Z","steps":["trace[121172959] 'agreement among raft nodes before linearized reading' (duration: 180.214837ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:13.306356Z","caller":"traceutil/trace.go:171","msg":"trace[1180922747] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"124.935811ms","start":"2026-04-09T05:53:13.180748Z","end":"2026-04-09T05:53:13.305684Z","steps":["trace[1180922747] 'process raft request' (duration: 107.2344ms)","trace[1180922747] 'compare' (duration: 17.156253ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:13.52186Z","caller":"traceutil/trace.go:171","msg":"trace[434480020] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"119.765653ms","start":"2026-04-09T05:53:13.402067Z","end":"2026-04-09T05:53:13.521833Z","steps":["trace[434480020] 'process raft request' (duration: 44.870985ms)","trace[434480020] 'compare' (duration: 74.689137ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:13.52455Z","caller":"traceutil/trace.go:171","msg":"trace[1042874418] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:510; }","duration":"112.943548ms","start":"2026-04-09T05:53:13.411582Z","end":"2026-04-09T05:53:13.524526Z","steps":["trace[1042874418] 'read index received' (duration: 35.413523ms)","trace[1042874418] 'applied index is now lower than readState.Index' (duration: 77.528295ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:13.524549Z","caller":"traceutil/trace.go:171","msg":"trace[1705449636] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"119.010864ms","start":"2026-04-09T05:53:13.405504Z","end":"2026-04-09T05:53:13.524515Z","steps":["trace[1705449636] 'process raft request' (duration: 118.797432ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:13.524684Z","caller":"traceutil/trace.go:171","msg":"trace[1683814978] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"117.548918ms","start":"2026-04-09T05:53:13.40712Z","end":"2026-04-09T05:53:13.524669Z","steps":["trace[1683814978] 'process raft request' (duration: 117.341456ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:13.524564Z","caller":"traceutil/trace.go:171","msg":"trace[935235480] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"117.59445ms","start":"2026-04-09T05:53:13.406943Z","end":"2026-04-09T05:53:13.524537Z","steps":["trace[935235480] 'process raft request' (duration: 117.460262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:13.524912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.310618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14401"} {"level":"info","ts":"2026-04-09T05:53:13.52498Z","caller":"traceutil/trace.go:171","msg":"trace[2037302601] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:499; }","duration":"113.434374ms","start":"2026-04-09T05:53:13.411529Z","end":"2026-04-09T05:53:13.524963Z","steps":["trace[2037302601] 'agreement among raft nodes before linearized reading' (duration: 113.301637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:13.745152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.513169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-09T05:53:13.745216Z","caller":"traceutil/trace.go:171","msg":"trace[1812357920] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:502; }","duration":"118.603393ms","start":"2026-04-09T05:53:13.626596Z","end":"2026-04-09T05:53:13.7452Z","steps":["trace[1812357920] 'range keys from in-memory index tree' (duration: 118.224813ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:14.4885Z","caller":"traceutil/trace.go:171","msg":"trace[1749215589] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:520; }","duration":"203.213809ms","start":"2026-04-09T05:53:14.285261Z","end":"2026-04-09T05:53:14.488475Z","steps":["trace[1749215589] 'read index received' (duration: 182.462632ms)","trace[1749215589] 'applied index is now lower than readState.Index' (duration: 20.749857ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:14.488601Z","caller":"traceutil/trace.go:171","msg":"trace[888331510] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"212.595181ms","start":"2026-04-09T05:53:14.27594Z","end":"2026-04-09T05:53:14.488535Z","steps":["trace[888331510] 'process raft request' (duration: 191.75151ms)","trace[888331510] 'compare' (duration: 20.668502ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:53:14.48869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.41118ms","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-09T05:53:14.48873Z","caller":"traceutil/trace.go:171","msg":"trace[1470729294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:505; }","duration":"203.485794ms","start":"2026-04-09T05:53:14.285233Z","end":"2026-04-09T05:53:14.488719Z","steps":["trace[1470729294] 'agreement among raft nodes before linearized reading' (duration: 203.372408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:14.48881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.199314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-09T05:53:14.488924Z","caller":"traceutil/trace.go:171","msg":"trace[413233156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:505; }","duration":"200.359513ms","start":"2026-04-09T05:53:14.288537Z","end":"2026-04-09T05:53:14.488896Z","steps":["trace[413233156] 'agreement among raft nodes before linearized reading' (duration: 200.117541ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257347Z","caller":"traceutil/trace.go:171","msg":"trace[601699455] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"175.224784ms","start":"2026-04-09T05:53:15.0821Z","end":"2026-04-09T05:53:15.257325Z","steps":["trace[601699455] 'process raft request' (duration: 175.030383ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257421Z","caller":"traceutil/trace.go:171","msg":"trace[1552286250] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"171.43158ms","start":"2026-04-09T05:53:15.085957Z","end":"2026-04-09T05:53:15.257388Z","steps":["trace[1552286250] 'process raft request' (duration: 171.282151ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257498Z","caller":"traceutil/trace.go:171","msg":"trace[909354232] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"169.076721ms","start":"2026-04-09T05:53:15.088401Z","end":"2026-04-09T05:53:15.257477Z","steps":["trace[909354232] 'process raft request' (duration: 168.920703ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257637Z","caller":"traceutil/trace.go:171","msg":"trace[1737860675] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"169.789386ms","start":"2026-04-09T05:53:15.087839Z","end":"2026-04-09T05:53:15.257628Z","steps":["trace[1737860675] 'process raft request' (duration: 169.446179ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257713Z","caller":"traceutil/trace.go:171","msg":"trace[567803315] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"163.976901ms","start":"2026-04-09T05:53:15.09369Z","end":"2026-04-09T05:53:15.257666Z","steps":["trace[567803315] 'process raft request' (duration: 163.923819ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257736Z","caller":"traceutil/trace.go:171","msg":"trace[360392487] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"164.903557ms","start":"2026-04-09T05:53:15.092825Z","end":"2026-04-09T05:53:15.257729Z","steps":["trace[360392487] 'process raft request' (duration: 164.570051ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.257735Z","caller":"traceutil/trace.go:171","msg":"trace[1668541536] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"165.674158ms","start":"2026-04-09T05:53:15.092011Z","end":"2026-04-09T05:53:15.257685Z","steps":["trace[1668541536] 'process raft request' (duration: 165.350772ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.303744Z","caller":"traceutil/trace.go:171","msg":"trace[1255460408] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"193.626798ms","start":"2026-04-09T05:53:15.110072Z","end":"2026-04-09T05:53:15.303698Z","steps":["trace[1255460408] 'process raft request' (duration: 193.46704ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.303863Z","caller":"traceutil/trace.go:171","msg":"trace[1057238131] transaction","detail":"{read_only:false; number_of_response:1; response_revision:518; }","duration":"193.626957ms","start":"2026-04-09T05:53:15.110199Z","end":"2026-04-09T05:53:15.303826Z","steps":["trace[1057238131] 'process raft request' (duration: 193.47792ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.303861Z","caller":"traceutil/trace.go:171","msg":"trace[425181831] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"193.66319ms","start":"2026-04-09T05:53:15.110172Z","end":"2026-04-09T05:53:15.303835Z","steps":["trace[425181831] 'process raft request' (duration: 193.4559ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.304104Z","caller":"traceutil/trace.go:171","msg":"trace[240938814] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"183.697623ms","start":"2026-04-09T05:53:15.120376Z","end":"2026-04-09T05:53:15.304074Z","steps":["trace[240938814] 'process raft request' (duration: 183.381167ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.304197Z","caller":"traceutil/trace.go:171","msg":"trace[322627023] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"175.051223ms","start":"2026-04-09T05:53:15.129117Z","end":"2026-04-09T05:53:15.304168Z","steps":["trace[322627023] 'process raft request' (duration: 174.889925ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.304398Z","caller":"traceutil/trace.go:171","msg":"trace[1214488157] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"161.79941ms","start":"2026-04-09T05:53:15.142584Z","end":"2026-04-09T05:53:15.304384Z","steps":["trace[1214488157] 'process raft request' (duration: 161.503034ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.558718Z","caller":"traceutil/trace.go:171","msg":"trace[1737358839] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"141.840427ms","start":"2026-04-09T05:53:15.416849Z","end":"2026-04-09T05:53:15.55869Z","steps":["trace[1737358839] 'process raft request' (duration: 88.148428ms)","trace[1737358839] 'compare' (duration: 53.51206ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:15.558973Z","caller":"traceutil/trace.go:171","msg":"trace[189391717] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"141.911039ms","start":"2026-04-09T05:53:15.417046Z","end":"2026-04-09T05:53:15.558957Z","steps":["trace[189391717] 'process raft request' (duration: 141.644676ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.558972Z","caller":"traceutil/trace.go:171","msg":"trace[1388032258] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"142.003633ms","start":"2026-04-09T05:53:15.416943Z","end":"2026-04-09T05:53:15.558947Z","steps":["trace[1388032258] 'process raft request' (duration: 141.672557ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.736347Z","caller":"traceutil/trace.go:171","msg":"trace[1260906714] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"140.821064ms","start":"2026-04-09T05:53:15.595496Z","end":"2026-04-09T05:53:15.736317Z","steps":["trace[1260906714] 'process raft request' (duration: 93.185775ms)","trace[1260906714] 'compare' (duration: 47.507253ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:15.742719Z","caller":"traceutil/trace.go:171","msg":"trace[1162580403] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"127.816975ms","start":"2026-04-09T05:53:15.614884Z","end":"2026-04-09T05:53:15.742701Z","steps":["trace[1162580403] 'process raft request' (duration: 127.759892ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.74296Z","caller":"traceutil/trace.go:171","msg":"trace[86408374] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"137.429142ms","start":"2026-04-09T05:53:15.605522Z","end":"2026-04-09T05:53:15.742952Z","steps":["trace[86408374] 'process raft request' (duration: 136.995651ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.924731Z","caller":"traceutil/trace.go:171","msg":"trace[1878863526] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"167.317601ms","start":"2026-04-09T05:53:15.757386Z","end":"2026-04-09T05:53:15.924704Z","steps":["trace[1878863526] 'process raft request' (duration: 83.926254ms)","trace[1878863526] 'compare' (duration: 83.240599ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:15.979607Z","caller":"traceutil/trace.go:171","msg":"trace[1623877331] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"213.441414ms","start":"2026-04-09T05:53:15.766138Z","end":"2026-04-09T05:53:15.97958Z","steps":["trace[1623877331] 'process raft request' (duration: 213.16651ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:15.979698Z","caller":"traceutil/trace.go:171","msg":"trace[589222333] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"168.009145ms","start":"2026-04-09T05:53:15.811662Z","end":"2026-04-09T05:53:15.979671Z","steps":["trace[589222333] 'process raft request' (duration: 167.855438ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:16.100855Z","caller":"traceutil/trace.go:171","msg":"trace[903514395] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"107.017658ms","start":"2026-04-09T05:53:15.993808Z","end":"2026-04-09T05:53:16.100825Z","steps":["trace[903514395] 'process raft request' (duration: 102.220708ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:16.112704Z","caller":"traceutil/trace.go:171","msg":"trace[1117413525] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"116.748626ms","start":"2026-04-09T05:53:15.995939Z","end":"2026-04-09T05:53:16.112687Z","steps":["trace[1117413525] 'process raft request' (duration: 116.310964ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:16.112897Z","caller":"traceutil/trace.go:171","msg":"trace[541295399] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"109.030245ms","start":"2026-04-09T05:53:16.003843Z","end":"2026-04-09T05:53:16.112873Z","steps":["trace[541295399] 'process raft request' (duration: 108.580602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:17.165924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.873097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T05:53:17.166191Z","caller":"traceutil/trace.go:171","msg":"trace[940862381] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"145.841054ms","start":"2026-04-09T05:53:17.02031Z","end":"2026-04-09T05:53:17.166151Z","steps":["trace[940862381] 'process raft request' (duration: 29.42405ms)","trace[940862381] 'compare' (duration: 115.545081ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:17.16632Z","caller":"traceutil/trace.go:171","msg":"trace[827808288] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"136.694431ms","start":"2026-04-09T05:53:17.029566Z","end":"2026-04-09T05:53:17.166261Z","steps":["trace[827808288] 'read index received' (duration: 20.237384ms)","trace[827808288] 'applied index is now lower than readState.Index' (duration: 116.453056ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:53:17.166619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.030538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"} {"level":"info","ts":"2026-04-09T05:53:17.166698Z","caller":"traceutil/trace.go:171","msg":"trace[1326229847] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:585; }","duration":"137.134893ms","start":"2026-04-09T05:53:17.02954Z","end":"2026-04-09T05:53:17.166674Z","steps":["trace[1326229847] 'agreement among raft nodes before linearized reading' (duration: 136.882139ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:17.167176Z","caller":"traceutil/trace.go:171","msg":"trace[1220295709] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"137.452188ms","start":"2026-04-09T05:53:17.029708Z","end":"2026-04-09T05:53:17.167133Z","steps":["trace[1220295709] 'process raft request' (duration: 136.67762ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.057834Z","caller":"traceutil/trace.go:171","msg":"trace[1664346067] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"200.970009ms","start":"2026-04-09T05:53:17.856781Z","end":"2026-04-09T05:53:18.05775Z","steps":["trace[1664346067] 'process raft request' (duration: 200.837071ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.06722Z","caller":"traceutil/trace.go:171","msg":"trace[2050939705] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"205.470146ms","start":"2026-04-09T05:53:17.861731Z","end":"2026-04-09T05:53:18.067201Z","steps":["trace[2050939705] 'process raft request' (duration: 205.377232ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.228642Z","caller":"traceutil/trace.go:171","msg":"trace[212809231] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"111.668484ms","start":"2026-04-09T05:53:18.116952Z","end":"2026-04-09T05:53:18.22862Z","steps":["trace[212809231] 'process raft request' (duration: 111.373739ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.275143Z","caller":"traceutil/trace.go:171","msg":"trace[1266449375] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:630; }","duration":"141.063384ms","start":"2026-04-09T05:53:18.134058Z","end":"2026-04-09T05:53:18.275122Z","steps":["trace[1266449375] 'read index received' (duration: 94.179266ms)","trace[1266449375] 'applied index is now lower than readState.Index' (duration: 46.883338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:53:18.275319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.215721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-09T05:53:18.275367Z","caller":"traceutil/trace.go:171","msg":"trace[1080653879] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"141.316956ms","start":"2026-04-09T05:53:18.134024Z","end":"2026-04-09T05:53:18.275341Z","steps":["trace[1080653879] 'agreement among raft nodes before linearized reading' (duration: 141.172189ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.275582Z","caller":"traceutil/trace.go:171","msg":"trace[2039480592] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"151.424584ms","start":"2026-04-09T05:53:18.124133Z","end":"2026-04-09T05:53:18.275558Z","steps":["trace[2039480592] 'process raft request' (duration: 150.882397ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.598063Z","caller":"traceutil/trace.go:171","msg":"trace[2140579971] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"341.897608ms","start":"2026-04-09T05:53:18.256143Z","end":"2026-04-09T05:53:18.598041Z","steps":["trace[2140579971] 'process raft request' (duration: 341.740111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:18.598145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.256106Z","time spent":"342.000513ms","remote":"127.0.0.1:59844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-09T05:53:18.93721Z","caller":"traceutil/trace.go:171","msg":"trace[518396333] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"657.772653ms","start":"2026-04-09T05:53:18.279416Z","end":"2026-04-09T05:53:18.937188Z","steps":["trace[518396333] 'process raft request' (duration: 655.67583ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.937298Z","caller":"traceutil/trace.go:171","msg":"trace[1625851817] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:632; }","duration":"359.991245ms","start":"2026-04-09T05:53:18.577283Z","end":"2026-04-09T05:53:18.937275Z","steps":["trace[1625851817] 'read index received' (duration: 20.598309ms)","trace[1625851817] 'applied index is now lower than readState.Index' (duration: 339.391506ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:53:18.937329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.279396Z","time spent":"657.873238ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:53:18.937336Z","caller":"traceutil/trace.go:171","msg":"trace[2018375240] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"642.695353ms","start":"2026-04-09T05:53:18.294616Z","end":"2026-04-09T05:53:18.937311Z","steps":["trace[2018375240] 'process raft request' (duration: 642.508694ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.937366Z","caller":"traceutil/trace.go:171","msg":"trace[142936499] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"481.354785ms","start":"2026-04-09T05:53:18.455987Z","end":"2026-04-09T05:53:18.937342Z","steps":["trace[142936499] 'process raft request' (duration: 481.24629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:18.93748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.294591Z","time spent":"642.806819ms","remote":"127.0.0.1:59844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:53:18.937484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.455968Z","time spent":"481.44852ms","remote":"127.0.0.1:59844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-09T05:53:18.937509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.212897ms","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-09T05:53:18.937543Z","caller":"traceutil/trace.go:171","msg":"trace[1097765180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"360.28565ms","start":"2026-04-09T05:53:18.577246Z","end":"2026-04-09T05:53:18.937532Z","steps":["trace[1097765180] 'agreement among raft nodes before linearized reading' (duration: 360.134182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:18.937577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.577226Z","time spent":"360.344132ms","remote":"127.0.0.1:59996","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-09T05:53:18.946083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.013928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-09T05:53:18.946141Z","caller":"traceutil/trace.go:171","msg":"trace[1434239951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"368.115533ms","start":"2026-04-09T05:53:18.578013Z","end":"2026-04-09T05:53:18.946129Z","steps":["trace[1434239951] 'agreement among raft nodes before linearized reading' (duration: 367.947005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:18.946193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.577994Z","time spent":"368.190728ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-09T05:53:18.946463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.839411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T05:53:18.946495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.682429ms","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-09T05:53:18.946529Z","caller":"traceutil/trace.go:171","msg":"trace[1033424105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"360.779754ms","start":"2026-04-09T05:53:18.585741Z","end":"2026-04-09T05:53:18.94652Z","steps":["trace[1033424105] 'agreement among raft nodes before linearized reading' (duration: 360.662648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:18.946559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.585731Z","time spent":"360.822776ms","remote":"127.0.0.1:59996","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-09T05:53:18.946563Z","caller":"traceutil/trace.go:171","msg":"trace[573289671] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"341.448457ms","start":"2026-04-09T05:53:18.605107Z","end":"2026-04-09T05:53:18.946556Z","steps":["trace[573289671] 'process raft request' (duration: 340.651148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:18.946635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:18.605087Z","time spent":"341.501049ms","remote":"127.0.0.1:59844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:53:18.946679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.156705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-09T05:53:18.946698Z","caller":"traceutil/trace.go:171","msg":"trace[70100507] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:617; }","duration":"286.194308ms","start":"2026-04-09T05:53:18.660498Z","end":"2026-04-09T05:53:18.946692Z","steps":["trace[70100507] 'agreement among raft nodes before linearized reading' (duration: 286.157506ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.94673Z","caller":"traceutil/trace.go:171","msg":"trace[1582811633] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"292.091917ms","start":"2026-04-09T05:53:18.654627Z","end":"2026-04-09T05:53:18.946719Z","steps":["trace[1582811633] 'process raft request' (duration: 291.268397ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:18.94653Z","caller":"traceutil/trace.go:171","msg":"trace[1927551137] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:617; }","duration":"244.926266ms","start":"2026-04-09T05:53:18.701587Z","end":"2026-04-09T05:53:18.946514Z","steps":["trace[1927551137] 'agreement among raft nodes before linearized reading' (duration: 244.80257ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:19.719186Z","caller":"traceutil/trace.go:171","msg":"trace[1625518975] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"238.555106ms","start":"2026-04-09T05:53:19.480592Z","end":"2026-04-09T05:53:19.719147Z","steps":["trace[1625518975] 'process raft request' (duration: 237.111956ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:19.71941Z","caller":"traceutil/trace.go:171","msg":"trace[735282073] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"235.378452ms","start":"2026-04-09T05:53:19.484Z","end":"2026-04-09T05:53:19.719378Z","steps":["trace[735282073] 'process raft request' (duration: 235.056985ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:26.0727Z","caller":"traceutil/trace.go:171","msg":"trace[1633906645] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"281.874396ms","start":"2026-04-09T05:53:25.7908Z","end":"2026-04-09T05:53:26.072674Z","steps":["trace[1633906645] 'read index received' (duration: 281.604694ms)","trace[1633906645] 'applied index is now lower than readState.Index' (duration: 268.802µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:26.072753Z","caller":"traceutil/trace.go:171","msg":"trace[2084109062] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"477.2752ms","start":"2026-04-09T05:53:25.595449Z","end":"2026-04-09T05:53:26.072724Z","steps":["trace[2084109062] 'process raft request' (duration: 477.08832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:26.072909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:25.595432Z","time spent":"477.390775ms","remote":"127.0.0.1:59920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:53:26.072921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.106816ms","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-09T05:53:26.072966Z","caller":"traceutil/trace.go:171","msg":"trace[1462735916] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:682; }","duration":"282.205651ms","start":"2026-04-09T05:53:25.790749Z","end":"2026-04-09T05:53:26.072954Z","steps":["trace[1462735916] 'agreement among raft nodes before linearized reading' (duration: 282.039753ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:26.194129Z","caller":"traceutil/trace.go:171","msg":"trace[2055990332] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"116.736032ms","start":"2026-04-09T05:53:26.077369Z","end":"2026-04-09T05:53:26.194105Z","steps":["trace[2055990332] 'process raft request' (duration: 111.397563ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:27.459205Z","caller":"traceutil/trace.go:171","msg":"trace[1828922509] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"418.901278ms","start":"2026-04-09T05:53:27.040285Z","end":"2026-04-09T05:53:27.459186Z","steps":["trace[1828922509] 'read index received' (duration: 418.743131ms)","trace[1828922509] 'applied index is now lower than readState.Index' (duration: 157.467µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:27.459293Z","caller":"traceutil/trace.go:171","msg":"trace[624255726] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"480.245279ms","start":"2026-04-09T05:53:26.97904Z","end":"2026-04-09T05:53:27.459285Z","steps":["trace[624255726] 'process raft request' (duration: 480.02916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:27.459417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:26.979023Z","time spent":"480.289181ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:53:27.459712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.376669ms","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-09T05:53:27.459835Z","caller":"traceutil/trace.go:171","msg":"trace[824744599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:684; }","duration":"419.554346ms","start":"2026-04-09T05:53:27.040252Z","end":"2026-04-09T05:53:27.459806Z","steps":["trace[824744599] 'agreement among raft nodes before linearized reading' (duration: 419.182979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:27.459905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:27.040241Z","time spent":"419.652401ms","remote":"127.0.0.1:59996","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-09T05:53:27.4605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.39044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T05:53:27.460492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.758118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-09T05:53:27.460548Z","caller":"traceutil/trace.go:171","msg":"trace[255893568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"240.563037ms","start":"2026-04-09T05:53:27.219972Z","end":"2026-04-09T05:53:27.460535Z","steps":["trace[255893568] 'agreement among raft nodes before linearized reading' (duration: 240.406931ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:53:27.460569Z","caller":"traceutil/trace.go:171","msg":"trace[2005081606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:684; }","duration":"400.877023ms","start":"2026-04-09T05:53:27.059674Z","end":"2026-04-09T05:53:27.460551Z","steps":["trace[2005081606] 'agreement among raft nodes before linearized reading' (duration: 400.655814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:27.460614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:27.059659Z","time spent":"400.946676ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-09T05:53:27.460764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.615486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-09T05:53:27.460858Z","caller":"traceutil/trace.go:171","msg":"trace[1706608204] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:684; }","duration":"365.919999ms","start":"2026-04-09T05:53:27.094912Z","end":"2026-04-09T05:53:27.460832Z","steps":["trace[1706608204] 'agreement among raft nodes before linearized reading' (duration: 365.47159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:27.461047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:27.094895Z","time spent":"366.13787ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-09T05:53:27.863009Z","caller":"traceutil/trace.go:171","msg":"trace[282931187] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"398.743359ms","start":"2026-04-09T05:53:27.46423Z","end":"2026-04-09T05:53:27.862974Z","steps":["trace[282931187] 'process raft request' (duration: 379.245568ms)","trace[282931187] 'compare' (duration: 19.260391ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:53:27.863032Z","caller":"traceutil/trace.go:171","msg":"trace[1815156585] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"395.477684ms","start":"2026-04-09T05:53:27.467529Z","end":"2026-04-09T05:53:27.863006Z","steps":["trace[1815156585] 'process raft request' (duration: 395.430952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:27.863162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:27.464202Z","time spent":"398.879044ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:53:27.863063Z","caller":"traceutil/trace.go:171","msg":"trace[301981685] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"397.794657ms","start":"2026-04-09T05:53:27.465246Z","end":"2026-04-09T05:53:27.86304Z","steps":["trace[301981685] 'process raft request' (duration: 397.667321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:53:27.863278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:27.467512Z","time spent":"395.676483ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:53:27.863301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:53:27.465232Z","time spent":"398.022396ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:54:00.486885Z","caller":"traceutil/trace.go:171","msg":"trace[182380425] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"264.91611ms","start":"2026-04-09T05:54:00.221947Z","end":"2026-04-09T05:54:00.486863Z","steps":["trace[182380425] 'read index received' (duration: 264.537627ms)","trace[182380425] 'applied index is now lower than readState.Index' (duration: 377.433µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:54:00.48692Z","caller":"traceutil/trace.go:171","msg":"trace[712177830] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"326.779245ms","start":"2026-04-09T05:54:00.160122Z","end":"2026-04-09T05:54:00.486901Z","steps":["trace[712177830] 'process raft request' (duration: 326.358081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:54:00.487024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:54:00.160105Z","time spent":"326.850387ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:54:00.487044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.033873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:54:00.487284Z","caller":"traceutil/trace.go:171","msg":"trace[1360621792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"265.310201ms","start":"2026-04-09T05:54:00.221908Z","end":"2026-04-09T05:54:00.487218Z","steps":["trace[1360621792] 'agreement among raft nodes before linearized reading' (duration: 265.027423ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.161682Z","caller":"traceutil/trace.go:171","msg":"trace[317296720] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"116.909945ms","start":"2026-04-09T05:54:01.044742Z","end":"2026-04-09T05:54:01.161652Z","steps":["trace[317296720] 'process raft request' (duration: 116.120701ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.164836Z","caller":"traceutil/trace.go:171","msg":"trace[1785207595] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"107.818975ms","start":"2026-04-09T05:54:01.056987Z","end":"2026-04-09T05:54:01.164806Z","steps":["trace[1785207595] 'process raft request' (duration: 107.564518ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.164961Z","caller":"traceutil/trace.go:171","msg":"trace[118581588] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"107.234577ms","start":"2026-04-09T05:54:01.057699Z","end":"2026-04-09T05:54:01.164933Z","steps":["trace[118581588] 'process raft request' (duration: 107.024361ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.16512Z","caller":"traceutil/trace.go:171","msg":"trace[338539396] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"105.696709ms","start":"2026-04-09T05:54:01.059386Z","end":"2026-04-09T05:54:01.165083Z","steps":["trace[338539396] 'process raft request' (duration: 105.501083ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165178Z","caller":"traceutil/trace.go:171","msg":"trace[1887767878] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"107.486614ms","start":"2026-04-09T05:54:01.057657Z","end":"2026-04-09T05:54:01.165144Z","steps":["trace[1887767878] 'process raft request' (duration: 107.02942ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.16527Z","caller":"traceutil/trace.go:171","msg":"trace[248604434] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"106.651829ms","start":"2026-04-09T05:54:01.058606Z","end":"2026-04-09T05:54:01.165257Z","steps":["trace[248604434] 'process raft request' (duration: 106.201585ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165144Z","caller":"traceutil/trace.go:171","msg":"trace[1676515500] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"107.888887ms","start":"2026-04-09T05:54:01.057198Z","end":"2026-04-09T05:54:01.165087Z","steps":["trace[1676515500] 'process raft request' (duration: 107.413353ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165406Z","caller":"traceutil/trace.go:171","msg":"trace[1032956142] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"107.534586ms","start":"2026-04-09T05:54:01.057855Z","end":"2026-04-09T05:54:01.16539Z","steps":["trace[1032956142] 'process raft request' (duration: 106.923757ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165554Z","caller":"traceutil/trace.go:171","msg":"trace[739494965] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"106.214596ms","start":"2026-04-09T05:54:01.059328Z","end":"2026-04-09T05:54:01.165543Z","steps":["trace[739494965] 'process raft request' (duration: 105.532075ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165589Z","caller":"traceutil/trace.go:171","msg":"trace[912512074] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"106.480804ms","start":"2026-04-09T05:54:01.059097Z","end":"2026-04-09T05:54:01.165578Z","steps":["trace[912512074] 'process raft request' (duration: 105.736161ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165609Z","caller":"traceutil/trace.go:171","msg":"trace[2120688349] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"107.869456ms","start":"2026-04-09T05:54:01.057727Z","end":"2026-04-09T05:54:01.165597Z","steps":["trace[2120688349] 'process raft request' (duration: 107.02719ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165189Z","caller":"traceutil/trace.go:171","msg":"trace[1335696653] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"114.009585ms","start":"2026-04-09T05:54:01.051166Z","end":"2026-04-09T05:54:01.165176Z","steps":["trace[1335696653] 'process raft request' (duration: 113.094577ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.16538Z","caller":"traceutil/trace.go:171","msg":"trace[53773940] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"105.891496ms","start":"2026-04-09T05:54:01.059478Z","end":"2026-04-09T05:54:01.16537Z","steps":["trace[53773940] 'process raft request' (duration: 105.526244ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:01.165819Z","caller":"traceutil/trace.go:171","msg":"trace[1120102925] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"108.143475ms","start":"2026-04-09T05:54:01.057606Z","end":"2026-04-09T05:54:01.165749Z","steps":["trace[1120102925] 'process raft request' (duration: 107.042531ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:54:12.019671Z","caller":"traceutil/trace.go:171","msg":"trace[1988596052] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"133.881109ms","start":"2026-04-09T05:54:11.88577Z","end":"2026-04-09T05:54:12.019651Z","steps":["trace[1988596052] 'process raft request' (duration: 133.753665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:54:12.565975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.245819ms","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-09T05:54:12.566057Z","caller":"traceutil/trace.go:171","msg":"trace[1031012029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1200; }","duration":"432.433254ms","start":"2026-04-09T05:54:12.133603Z","end":"2026-04-09T05:54:12.566036Z","steps":["trace[1031012029] 'range keys from in-memory index tree' (duration: 432.028803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:54:12.566117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:54:12.13358Z","time spent":"432.527257ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T05:54:12.566139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.768683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-09T05:54:12.566212Z","caller":"traceutil/trace.go:171","msg":"trace[1716377012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1200; }","duration":"334.873947ms","start":"2026-04-09T05:54:12.231319Z","end":"2026-04-09T05:54:12.566193Z","steps":["trace[1716377012] 'range keys from in-memory index tree' (duration: 334.599279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:54:12.566232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.873813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:54:12.566876Z","caller":"traceutil/trace.go:171","msg":"trace[348924971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1200; }","duration":"346.058369ms","start":"2026-04-09T05:54:12.220302Z","end":"2026-04-09T05:54:12.56636Z","steps":["trace[348924971] 'range keys from in-memory index tree' (duration: 345.797141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:54:12.567074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:54:12.220281Z","time spent":"346.641395ms","remote":"127.0.0.1:59768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-09T05:54:12.567211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:54:12.231311Z","time spent":"335.886425ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-09T05:54:27.94088Z","caller":"traceutil/trace.go:171","msg":"trace[1123753344] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"142.171937ms","start":"2026-04-09T05:54:27.798639Z","end":"2026-04-09T05:54:27.940811Z","steps":["trace[1123753344] 'process raft request' (duration: 141.926882ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:00.405416Z","caller":"traceutil/trace.go:171","msg":"trace[652385507] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"288.254166ms","start":"2026-04-09T05:55:00.117102Z","end":"2026-04-09T05:55:00.405357Z","steps":["trace[652385507] 'process raft request' (duration: 288.013402ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:00.531394Z","caller":"traceutil/trace.go:171","msg":"trace[1379490437] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"411.464757ms","start":"2026-04-09T05:55:00.119902Z","end":"2026-04-09T05:55:00.531367Z","steps":["trace[1379490437] 'process raft request' (duration: 411.225082ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:00.531633Z","caller":"traceutil/trace.go:171","msg":"trace[1105869732] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1934; }","duration":"361.657495ms","start":"2026-04-09T05:55:00.169957Z","end":"2026-04-09T05:55:00.531615Z","steps":["trace[1105869732] 'read index received' (duration: 235.261844ms)","trace[1105869732] 'applied index is now lower than readState.Index' (duration: 126.394431ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:55:00.531677Z","caller":"traceutil/trace.go:171","msg":"trace[506811232] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"347.705793ms","start":"2026-04-09T05:55:00.183952Z","end":"2026-04-09T05:55:00.531657Z","steps":["trace[506811232] 'process raft request' (duration: 347.352406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:00.531775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.801939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bc093fd8-ce7b-41e2-b367-67522c005b83\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-09T05:55:00.531741Z","caller":"traceutil/trace.go:171","msg":"trace[2091644367] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"182.159759ms","start":"2026-04-09T05:55:00.349549Z","end":"2026-04-09T05:55:00.531709Z","steps":["trace[2091644367] 'process raft request' (duration: 181.972004ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:00.53181Z","caller":"traceutil/trace.go:171","msg":"trace[1100286612] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bc093fd8-ce7b-41e2-b367-67522c005b83; range_end:; response_count:1; response_revision:1864; }","duration":"361.89481ms","start":"2026-04-09T05:55:00.169905Z","end":"2026-04-09T05:55:00.5318Z","steps":["trace[1100286612] 'agreement among raft nodes before linearized reading' (duration: 361.798119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:00.531835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:00.169882Z","time spent":"361.946632ms","remote":"127.0.0.1:59920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bc093fd8-ce7b-41e2-b367-67522c005b83\" "} {"level":"warn","ts":"2026-04-09T05:55:00.531812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:00.183929Z","time spent":"347.816426ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:55:00.532078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:00.119877Z","time spent":"411.602849ms","remote":"127.0.0.1:59920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:55:00.557237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.115534ms","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-09T05:55:00.557311Z","caller":"traceutil/trace.go:171","msg":"trace[1999593364] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1865; }","duration":"150.240777ms","start":"2026-04-09T05:55:00.407049Z","end":"2026-04-09T05:55:00.55729Z","steps":["trace[1999593364] 'agreement among raft nodes before linearized reading' (duration: 150.020273ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:09.159264Z","caller":"traceutil/trace.go:171","msg":"trace[1000319638] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"163.129829ms","start":"2026-04-09T05:55:08.996098Z","end":"2026-04-09T05:55:09.159228Z","steps":["trace[1000319638] 'process raft request' (duration: 162.922235ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:09.15947Z","caller":"traceutil/trace.go:171","msg":"trace[1136843720] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2025; }","duration":"163.232911ms","start":"2026-04-09T05:55:08.996201Z","end":"2026-04-09T05:55:09.159434Z","steps":["trace[1136843720] 'read index received' (duration: 163.21778ms)","trace[1136843720] 'applied index is now lower than readState.Index' (duration: 12.64µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:55:09.159799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.562117ms","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-09T05:55:09.159862Z","caller":"traceutil/trace.go:171","msg":"trace[1614185281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1948; }","duration":"163.67861ms","start":"2026-04-09T05:55:08.996169Z","end":"2026-04-09T05:55:09.159847Z","steps":["trace[1614185281] 'agreement among raft nodes before linearized reading' (duration: 163.409784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:09.19789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.642432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-09T05:55:09.197909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.14721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11979"} {"level":"info","ts":"2026-04-09T05:55:09.198153Z","caller":"traceutil/trace.go:171","msg":"trace[527501219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1949; }","duration":"201.993388ms","start":"2026-04-09T05:55:08.996142Z","end":"2026-04-09T05:55:09.198135Z","steps":["trace[527501219] 'agreement among raft nodes before linearized reading' (duration: 201.57849ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:09.197891Z","caller":"traceutil/trace.go:171","msg":"trace[172198319] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"197.81625ms","start":"2026-04-09T05:55:09.000048Z","end":"2026-04-09T05:55:09.197865Z","steps":["trace[172198319] 'process raft request' (duration: 197.239249ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:09.19819Z","caller":"traceutil/trace.go:171","msg":"trace[1398790144] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1949; }","duration":"162.521038ms","start":"2026-04-09T05:55:09.035647Z","end":"2026-04-09T05:55:09.198168Z","steps":["trace[1398790144] 'agreement among raft nodes before linearized reading' (duration: 162.049479ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:14.787074Z","caller":"traceutil/trace.go:171","msg":"trace[510906295] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2057; }","duration":"128.876731ms","start":"2026-04-09T05:55:14.658174Z","end":"2026-04-09T05:55:14.787051Z","steps":["trace[510906295] 'read index received' (duration: 126.305455ms)","trace[510906295] 'applied index is now lower than readState.Index' (duration: 2.569516ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:55:14.787138Z","caller":"traceutil/trace.go:171","msg":"trace[1418368812] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"199.125507ms","start":"2026-04-09T05:55:14.587983Z","end":"2026-04-09T05:55:14.787109Z","steps":["trace[1418368812] 'process raft request' (duration: 196.481909ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:14.787184Z","caller":"traceutil/trace.go:171","msg":"trace[1066557986] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"131.729403ms","start":"2026-04-09T05:55:14.655398Z","end":"2026-04-09T05:55:14.787128Z","steps":["trace[1066557986] 'process raft request' (duration: 131.59451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:14.787325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.142075ms","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-09T05:55:14.787372Z","caller":"traceutil/trace.go:171","msg":"trace[710022811] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1981; }","duration":"129.256017ms","start":"2026-04-09T05:55:14.658099Z","end":"2026-04-09T05:55:14.787355Z","steps":["trace[710022811] 'agreement among raft nodes before linearized reading' (duration: 129.093435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:14.787431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.194716ms","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":"warn","ts":"2026-04-09T05:55:14.787543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.619188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-5448d56d95-9djb4\" ","response":"range_response_count:1 size:5821"} {"level":"info","ts":"2026-04-09T05:55:14.787539Z","caller":"traceutil/trace.go:171","msg":"trace[325445395] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1981; }","duration":"119.346589ms","start":"2026-04-09T05:55:14.668165Z","end":"2026-04-09T05:55:14.787512Z","steps":["trace[325445395] 'agreement among raft nodes before linearized reading' (duration: 119.124955ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:14.787577Z","caller":"traceutil/trace.go:171","msg":"trace[887475670] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-5448d56d95-9djb4; range_end:; response_count:1; response_revision:1981; }","duration":"107.71221ms","start":"2026-04-09T05:55:14.679851Z","end":"2026-04-09T05:55:14.787563Z","steps":["trace[887475670] 'agreement among raft nodes before linearized reading' (duration: 107.537247ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:28.74924Z","caller":"traceutil/trace.go:171","msg":"trace[1341569137] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"105.125369ms","start":"2026-04-09T05:55:28.644067Z","end":"2026-04-09T05:55:28.749192Z","steps":["trace[1341569137] 'process raft request' (duration: 98.233983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:35.435102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.66144ms","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-09T05:55:35.435304Z","caller":"traceutil/trace.go:171","msg":"trace[1162031317] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2108; }","duration":"479.946115ms","start":"2026-04-09T05:55:34.95533Z","end":"2026-04-09T05:55:35.435276Z","steps":["trace[1162031317] 'range keys from in-memory index tree' (duration: 479.372656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:35.435393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:34.955311Z","time spent":"480.065988ms","remote":"127.0.0.1:33260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-09T05:55:35.435163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.723308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:55:35.435553Z","caller":"traceutil/trace.go:171","msg":"trace[660659089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2108; }","duration":"215.669284ms","start":"2026-04-09T05:55:35.219847Z","end":"2026-04-09T05:55:35.435516Z","steps":["trace[660659089] 'range keys from in-memory index tree' (duration: 214.614396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:35.435668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.016892ms","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-09T05:55:35.43574Z","caller":"traceutil/trace.go:171","msg":"trace[392243794] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2108; }","duration":"495.155815ms","start":"2026-04-09T05:55:34.940564Z","end":"2026-04-09T05:55:35.43572Z","steps":["trace[392243794] 'range keys from in-memory index tree' (duration: 494.086868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:35.435783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:34.940543Z","time spent":"495.227975ms","remote":"127.0.0.1:59996","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-09T05:55:35.435967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.668617ms","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-09T05:55:35.436095Z","caller":"traceutil/trace.go:171","msg":"trace[1632188795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2108; }","duration":"143.933292ms","start":"2026-04-09T05:55:35.292104Z","end":"2026-04-09T05:55:35.436037Z","steps":["trace[1632188795] 'range keys from in-memory index tree' (duration: 143.339622ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:35.659961Z","caller":"traceutil/trace.go:171","msg":"trace[1599330387] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"217.012515ms","start":"2026-04-09T05:55:35.442905Z","end":"2026-04-09T05:55:35.659917Z","steps":["trace[1599330387] 'process raft request' (duration: 205.370045ms)","trace[1599330387] 'compare' (duration: 11.196184ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:55:35.660366Z","caller":"traceutil/trace.go:171","msg":"trace[1221010312] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"214.78462ms","start":"2026-04-09T05:55:35.445567Z","end":"2026-04-09T05:55:35.660351Z","steps":["trace[1221010312] 'process raft request' (duration: 214.259681ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:35.660823Z","caller":"traceutil/trace.go:171","msg":"trace[1355445559] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"213.58669ms","start":"2026-04-09T05:55:35.447203Z","end":"2026-04-09T05:55:35.66079Z","steps":["trace[1355445559] 'process raft request' (duration: 213.430647ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:35.660827Z","caller":"traceutil/trace.go:171","msg":"trace[1389995439] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"214.460154ms","start":"2026-04-09T05:55:35.446337Z","end":"2026-04-09T05:55:35.660797Z","steps":["trace[1389995439] 'process raft request' (duration: 213.882405ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:55:36.258727Z","caller":"traceutil/trace.go:171","msg":"trace[549225415] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"310.342195ms","start":"2026-04-09T05:55:35.948335Z","end":"2026-04-09T05:55:36.258678Z","steps":["trace[549225415] 'read index received' (duration: 212.810127ms)","trace[549225415] 'applied index is now lower than readState.Index' (duration: 97.530958ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:55:36.258924Z","caller":"traceutil/trace.go:171","msg":"trace[2044466133] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"535.088505ms","start":"2026-04-09T05:55:35.72379Z","end":"2026-04-09T05:55:36.258879Z","steps":["trace[2044466133] 'process raft request' (duration: 436.764864ms)","trace[2044466133] 'compare' (duration: 97.481067ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:55:36.259349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.001135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-09T05:55:36.259402Z","caller":"traceutil/trace.go:171","msg":"trace[350848254] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2114; }","duration":"311.112886ms","start":"2026-04-09T05:55:35.948273Z","end":"2026-04-09T05:55:36.259385Z","steps":["trace[350848254] 'agreement among raft nodes before linearized reading' (duration: 310.918212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:55:36.259451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:35.948244Z","time spent":"311.197698ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-09T05:55:36.259552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:55:35.723762Z","time spent":"535.610074ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T05:56:38.862622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.367746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-09T05:56:38.862734Z","caller":"traceutil/trace.go:171","msg":"trace[261047665] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:2553; }","duration":"192.552648ms","start":"2026-04-09T05:56:38.670159Z","end":"2026-04-09T05:56:38.862712Z","steps":["trace[261047665] 'range keys from in-memory index tree' (duration: 192.161343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:56:38.862637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.819146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:56:38.862925Z","caller":"traceutil/trace.go:171","msg":"trace[668017010] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2553; }","duration":"142.16007ms","start":"2026-04-09T05:56:38.720731Z","end":"2026-04-09T05:56:38.862892Z","steps":["trace[668017010] 'count revisions from in-memory index tree' (duration: 141.748226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:56:41.646283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.247154ms","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-09T05:56:41.646345Z","caller":"traceutil/trace.go:171","msg":"trace[630345906] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2564; }","duration":"495.369895ms","start":"2026-04-09T05:56:41.15096Z","end":"2026-04-09T05:56:41.64633Z","steps":["trace[630345906] 'range keys from in-memory index tree' (duration: 495.096981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:56:41.646374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:56:41.150938Z","time spent":"495.428567ms","remote":"127.0.0.1:59926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-04-09T05:56:41.646679Z","caller":"traceutil/trace.go:171","msg":"trace[2131287209] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"374.503083ms","start":"2026-04-09T05:56:41.272139Z","end":"2026-04-09T05:56:41.646642Z","steps":["trace[2131287209] 'process raft request' (duration: 300.706702ms)","trace[2131287209] 'compare' (duration: 73.648329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:56:41.646861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:56:41.272106Z","time spent":"374.656348ms","remote":"127.0.0.1:59996","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-09T05:56:41.647656Z","caller":"traceutil/trace.go:171","msg":"trace[1112360293] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"372.885143ms","start":"2026-04-09T05:56:41.274736Z","end":"2026-04-09T05:56:41.647621Z","steps":["trace[1112360293] 'process raft request' (duration: 372.730251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:56:41.647846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:56:41.274696Z","time spent":"373.062515ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:56:56.100818Z","caller":"traceutil/trace.go:171","msg":"trace[701041000] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"127.36834ms","start":"2026-04-09T05:56:55.973409Z","end":"2026-04-09T05:56:56.100777Z","steps":["trace[701041000] 'process raft request' (duration: 126.972884ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:56:56.128116Z","caller":"traceutil/trace.go:171","msg":"trace[698740817] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"120.374996ms","start":"2026-04-09T05:56:56.007712Z","end":"2026-04-09T05:56:56.128087Z","steps":["trace[698740817] 'process raft request' (duration: 120.179383ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:57:12.089415Z","caller":"traceutil/trace.go:171","msg":"trace[1835296368] transaction","detail":"{read_only:false; response_revision:2732; number_of_response:1; }","duration":"322.270582ms","start":"2026-04-09T05:57:11.767109Z","end":"2026-04-09T05:57:12.089379Z","steps":["trace[1835296368] 'process raft request' (duration: 322.070718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:57:12.089638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:57:11.767086Z","time spent":"322.439123ms","remote":"127.0.0.1:59996","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-09T05:57:12.111476Z","caller":"traceutil/trace.go:171","msg":"trace[53493858] linearizableReadLoop","detail":"{readStateIndex:2837; appliedIndex:2835; }","duration":"245.160658ms","start":"2026-04-09T05:57:11.866284Z","end":"2026-04-09T05:57:12.111445Z","steps":["trace[53493858] 'read index received' (duration: 222.897199ms)","trace[53493858] 'applied index is now lower than readState.Index' (duration: 22.262029ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:57:12.11161Z","caller":"traceutil/trace.go:171","msg":"trace[2029993331] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"331.52223ms","start":"2026-04-09T05:57:11.780046Z","end":"2026-04-09T05:57:12.111569Z","steps":["trace[2029993331] 'process raft request' (duration: 331.186896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:57:12.111657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.337121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T05:57:12.111837Z","caller":"traceutil/trace.go:171","msg":"trace[219696142] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2733; }","duration":"245.586833ms","start":"2026-04-09T05:57:11.866222Z","end":"2026-04-09T05:57:12.111808Z","steps":["trace[219696142] 'agreement among raft nodes before linearized reading' (duration: 245.336049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:57:12.111845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T05:57:11.780004Z","time spent":"331.717374ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T05:57:17.456158Z","caller":"traceutil/trace.go:171","msg":"trace[1889155437] transaction","detail":"{read_only:false; response_revision:2762; number_of_response:1; }","duration":"253.82953ms","start":"2026-04-09T05:57:17.202294Z","end":"2026-04-09T05:57:17.456123Z","steps":["trace[1889155437] 'process raft request' (duration: 253.581096ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:57:33.718611Z","caller":"traceutil/trace.go:171","msg":"trace[1726754465] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"176.5394ms","start":"2026-04-09T05:57:33.542028Z","end":"2026-04-09T05:57:33.718567Z","steps":["trace[1726754465] 'process raft request' (duration: 176.260351ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:57:45.77402Z","caller":"traceutil/trace.go:171","msg":"trace[898258126] transaction","detail":"{read_only:false; response_revision:2909; number_of_response:1; }","duration":"126.308215ms","start":"2026-04-09T05:57:45.647683Z","end":"2026-04-09T05:57:45.773991Z","steps":["trace[898258126] 'process raft request' (duration: 126.178061ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:58:29.113498Z","caller":"traceutil/trace.go:171","msg":"trace[1270843915] transaction","detail":"{read_only:false; response_revision:3140; number_of_response:1; }","duration":"120.461335ms","start":"2026-04-09T05:58:28.992998Z","end":"2026-04-09T05:58:29.113459Z","steps":["trace[1270843915] 'process raft request' (duration: 27.832828ms)","trace[1270843915] 'compare' (duration: 92.37743ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:58:29.113802Z","caller":"traceutil/trace.go:171","msg":"trace[603882798] transaction","detail":"{read_only:false; response_revision:3141; number_of_response:1; }","duration":"119.838027ms","start":"2026-04-09T05:58:28.993905Z","end":"2026-04-09T05:58:29.113743Z","steps":["trace[603882798] 'process raft request' (duration: 119.505628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:58:29.333474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.565213ms","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-09T05:58:29.333718Z","caller":"traceutil/trace.go:171","msg":"trace[354694996] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3142; }","duration":"116.824461ms","start":"2026-04-09T05:58:29.216871Z","end":"2026-04-09T05:58:29.333695Z","steps":["trace[354694996] 'range keys from in-memory index tree' (duration: 116.547973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:58:29.333525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.430745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T05:58:29.334028Z","caller":"traceutil/trace.go:171","msg":"trace[923302657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3142; }","duration":"113.952269ms","start":"2026-04-09T05:58:29.219974Z","end":"2026-04-09T05:58:29.333926Z","steps":["trace[923302657] 'range keys from in-memory index tree' (duration: 113.261881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:59:01.30684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.527432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1449"} {"level":"warn","ts":"2026-04-09T05:59:01.3069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.932654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-09T05:59:01.306918Z","caller":"traceutil/trace.go:171","msg":"trace[785608538] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:3300; }","duration":"142.637616ms","start":"2026-04-09T05:59:01.164263Z","end":"2026-04-09T05:59:01.306901Z","steps":["trace[785608538] 'range keys from in-memory index tree' (duration: 142.3802ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:59:01.306952Z","caller":"traceutil/trace.go:171","msg":"trace[2142461801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3300; }","duration":"125.987505ms","start":"2026-04-09T05:59:01.18095Z","end":"2026-04-09T05:59:01.306937Z","steps":["trace[2142461801] 'range keys from in-memory index tree' (duration: 125.79524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T05:59:01.307047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.683486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-09T05:59:01.307131Z","caller":"traceutil/trace.go:171","msg":"trace[1452707895] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3300; }","duration":"123.817391ms","start":"2026-04-09T05:59:01.183294Z","end":"2026-04-09T05:59:01.307111Z","steps":["trace[1452707895] 'range keys from in-memory index tree' (duration: 123.506792ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:59:01.689693Z","caller":"traceutil/trace.go:171","msg":"trace[2049433871] transaction","detail":"{read_only:false; response_revision:3305; number_of_response:1; }","duration":"279.782394ms","start":"2026-04-09T05:59:01.40989Z","end":"2026-04-09T05:59:01.689672Z","steps":["trace[2049433871] 'process raft request' (duration: 279.711932ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:59:01.689721Z","caller":"traceutil/trace.go:171","msg":"trace[918331493] transaction","detail":"{read_only:false; response_revision:3304; number_of_response:1; }","duration":"280.354217ms","start":"2026-04-09T05:59:01.409323Z","end":"2026-04-09T05:59:01.689677Z","steps":["trace[918331493] 'process raft request' (duration: 213.206259ms)","trace[918331493] 'compare' (duration: 66.758769ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:59:03.818519Z","caller":"traceutil/trace.go:171","msg":"trace[100368076] transaction","detail":"{read_only:false; response_revision:3314; number_of_response:1; }","duration":"118.175449ms","start":"2026-04-09T05:59:03.700305Z","end":"2026-04-09T05:59:03.81848Z","steps":["trace[100368076] 'process raft request' (duration: 61.850594ms)","trace[100368076] 'compare' (duration: 56.224493ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:59:07.002256Z","caller":"traceutil/trace.go:171","msg":"trace[27088164] transaction","detail":"{read_only:false; response_revision:3329; number_of_response:1; }","duration":"137.792408ms","start":"2026-04-09T05:59:06.864432Z","end":"2026-04-09T05:59:07.002224Z","steps":["trace[27088164] 'process raft request' (duration: 65.657203ms)","trace[27088164] 'compare' (duration: 71.980481ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T05:59:21.36612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.43267ms","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-09T05:59:21.366225Z","caller":"traceutil/trace.go:171","msg":"trace[897152746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3489; }","duration":"117.574455ms","start":"2026-04-09T05:59:21.248627Z","end":"2026-04-09T05:59:21.366202Z","steps":["trace[897152746] 'range keys from in-memory index tree' (duration: 117.262757ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:59:40.167463Z","caller":"traceutil/trace.go:171","msg":"trace[307812088] transaction","detail":"{read_only:false; response_revision:3604; number_of_response:1; }","duration":"106.45204ms","start":"2026-04-09T05:59:40.060983Z","end":"2026-04-09T05:59:40.167435Z","steps":["trace[307812088] 'process raft request' (duration: 100.960456ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T05:59:41.789347Z","caller":"traceutil/trace.go:171","msg":"trace[1167699325] transaction","detail":"{read_only:false; response_revision:3610; number_of_response:1; }","duration":"110.145367ms","start":"2026-04-09T05:59:41.679167Z","end":"2026-04-09T05:59:41.789313Z","steps":["trace[1167699325] 'process raft request' (duration: 90.30532ms)","trace[1167699325] 'compare' (duration: 19.677822ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T05:59:50.354521Z","caller":"traceutil/trace.go:171","msg":"trace[945410867] transaction","detail":"{read_only:false; response_revision:3654; number_of_response:1; }","duration":"128.226645ms","start":"2026-04-09T05:59:50.226257Z","end":"2026-04-09T05:59:50.354484Z","steps":["trace[945410867] 'process raft request' (duration: 118.208486ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:05.411794Z","caller":"traceutil/trace.go:171","msg":"trace[678988421] linearizableReadLoop","detail":"{readStateIndex:4723; appliedIndex:4722; }","duration":"197.26446ms","start":"2026-04-09T06:01:05.21451Z","end":"2026-04-09T06:01:05.411775Z","steps":["trace[678988421] 'read index received' (duration: 118.847886ms)","trace[678988421] 'applied index is now lower than readState.Index' (duration: 78.415384ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:05.412359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.833321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-04-09T06:01:05.412385Z","caller":"traceutil/trace.go:171","msg":"trace[1151847337] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"244.882836ms","start":"2026-04-09T06:01:05.167491Z","end":"2026-04-09T06:01:05.412374Z","steps":["trace[1151847337] 'process raft request' (duration: 165.952371ms)","trace[1151847337] 'compare' (duration: 78.242372ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:05.412428Z","caller":"traceutil/trace.go:171","msg":"trace[1079435119] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4547; }","duration":"197.946914ms","start":"2026-04-09T06:01:05.214468Z","end":"2026-04-09T06:01:05.412415Z","steps":["trace[1079435119] 'agreement among raft nodes before linearized reading' (duration: 197.76715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:05.486351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.557366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:05.486421Z","caller":"traceutil/trace.go:171","msg":"trace[1204460516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4548; }","duration":"264.667757ms","start":"2026-04-09T06:01:05.221735Z","end":"2026-04-09T06:01:05.486403Z","steps":["trace[1204460516] 'agreement among raft nodes before linearized reading' (duration: 264.538345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:05.487079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.998079ms","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-09T06:01:05.487123Z","caller":"traceutil/trace.go:171","msg":"trace[1930270130] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4548; }","duration":"185.05417ms","start":"2026-04-09T06:01:05.302058Z","end":"2026-04-09T06:01:05.487112Z","steps":["trace[1930270130] 'agreement among raft nodes before linearized reading' (duration: 184.937508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:05.48746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.560344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-04-09T06:01:05.487504Z","caller":"traceutil/trace.go:171","msg":"trace[1329475559] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4548; }","duration":"190.635865ms","start":"2026-04-09T06:01:05.296855Z","end":"2026-04-09T06:01:05.487491Z","steps":["trace[1329475559] 'agreement among raft nodes before linearized reading' (duration: 190.527023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:05.488074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.655765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:18 size:484124"} {"level":"info","ts":"2026-04-09T06:01:05.488117Z","caller":"traceutil/trace.go:171","msg":"trace[1547787697] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:18; response_revision:4548; }","duration":"232.701286ms","start":"2026-04-09T06:01:05.255405Z","end":"2026-04-09T06:01:05.488106Z","steps":["trace[1547787697] 'agreement among raft nodes before linearized reading' (duration: 232.39775ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:05.662237Z","caller":"traceutil/trace.go:171","msg":"trace[1753583497] linearizableReadLoop","detail":"{readStateIndex:4726; appliedIndex:4725; }","duration":"112.149ms","start":"2026-04-09T06:01:05.550064Z","end":"2026-04-09T06:01:05.662213Z","steps":["trace[1753583497] 'read index received' (duration: 111.956756ms)","trace[1753583497] 'applied index is now lower than readState.Index' (duration: 190.664µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:05.662452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.365324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-09T06:01:05.662487Z","caller":"traceutil/trace.go:171","msg":"trace[1763570831] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4550; }","duration":"112.438126ms","start":"2026-04-09T06:01:05.550038Z","end":"2026-04-09T06:01:05.662477Z","steps":["trace[1763570831] 'agreement among raft nodes before linearized reading' (duration: 112.275013ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:05.66288Z","caller":"traceutil/trace.go:171","msg":"trace[1574763299] transaction","detail":"{read_only:false; response_revision:4550; number_of_response:1; }","duration":"123.236307ms","start":"2026-04-09T06:01:05.53963Z","end":"2026-04-09T06:01:05.662867Z","steps":["trace[1574763299] 'process raft request' (duration: 122.421741ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:06.153539Z","caller":"traceutil/trace.go:171","msg":"trace[1819637805] linearizableReadLoop","detail":"{readStateIndex:4739; appliedIndex:4737; }","duration":"135.917663ms","start":"2026-04-09T06:01:06.017599Z","end":"2026-04-09T06:01:06.153516Z","steps":["trace[1819637805] 'read index received' (duration: 56.288828ms)","trace[1819637805] 'applied index is now lower than readState.Index' (duration: 79.627474ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:06.153662Z","caller":"traceutil/trace.go:171","msg":"trace[2030035485] transaction","detail":"{read_only:false; response_revision:4563; number_of_response:1; }","duration":"147.521761ms","start":"2026-04-09T06:01:06.006118Z","end":"2026-04-09T06:01:06.15364Z","steps":["trace[2030035485] 'process raft request' (duration: 89.326247ms)","trace[2030035485] 'compare' (duration: 57.854057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:06.153756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.135987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-09T06:01:06.153822Z","caller":"traceutil/trace.go:171","msg":"trace[1717703839] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4564; }","duration":"136.25371ms","start":"2026-04-09T06:01:06.017558Z","end":"2026-04-09T06:01:06.153811Z","steps":["trace[1717703839] 'agreement among raft nodes before linearized reading' (duration: 136.058936ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:06.153971Z","caller":"traceutil/trace.go:171","msg":"trace[1943959463] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"131.332226ms","start":"2026-04-09T06:01:06.022631Z","end":"2026-04-09T06:01:06.153963Z","steps":["trace[1943959463] 'process raft request' (duration: 130.815256ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:06.311506Z","caller":"traceutil/trace.go:171","msg":"trace[556945601] transaction","detail":"{read_only:false; response_revision:4569; number_of_response:1; }","duration":"125.549657ms","start":"2026-04-09T06:01:06.185937Z","end":"2026-04-09T06:01:06.311487Z","steps":["trace[556945601] 'process raft request' (duration: 97.253166ms)","trace[556945601] 'compare' (duration: 28.21379ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:06.317873Z","caller":"traceutil/trace.go:171","msg":"trace[1864371437] transaction","detail":"{read_only:false; response_revision:4570; number_of_response:1; }","duration":"131.896807ms","start":"2026-04-09T06:01:06.185958Z","end":"2026-04-09T06:01:06.317855Z","steps":["trace[1864371437] 'process raft request' (duration: 131.467259ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:06.318353Z","caller":"traceutil/trace.go:171","msg":"trace[158203621] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"128.296909ms","start":"2026-04-09T06:01:06.190024Z","end":"2026-04-09T06:01:06.318321Z","steps":["trace[158203621] 'process raft request' (duration: 127.725148ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:07.03055Z","caller":"traceutil/trace.go:171","msg":"trace[1823588795] linearizableReadLoop","detail":"{readStateIndex:4763; appliedIndex:4762; }","duration":"187.727195ms","start":"2026-04-09T06:01:06.84278Z","end":"2026-04-09T06:01:07.030507Z","steps":["trace[1823588795] 'read index received' (duration: 20.891443ms)","trace[1823588795] 'applied index is now lower than readState.Index' (duration: 166.833782ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:07.030664Z","caller":"traceutil/trace.go:171","msg":"trace[151888622] transaction","detail":"{read_only:false; response_revision:4587; number_of_response:1; }","duration":"201.943441ms","start":"2026-04-09T06:01:06.82868Z","end":"2026-04-09T06:01:07.030623Z","steps":["trace[151888622] 'process raft request' (duration: 201.586655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.030852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.01693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T06:01:07.030903Z","caller":"traceutil/trace.go:171","msg":"trace[72783026] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:4587; }","duration":"188.156132ms","start":"2026-04-09T06:01:06.842731Z","end":"2026-04-09T06:01:07.030887Z","steps":["trace[72783026] 'agreement among raft nodes before linearized reading' (duration: 187.969178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.030967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.845147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b6dd16c1-ea11-45f1-b551-ec84651bee25\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-04-09T06:01:07.031046Z","caller":"traceutil/trace.go:171","msg":"trace[2130326886] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b6dd16c1-ea11-45f1-b551-ec84651bee25; range_end:; response_count:1; response_revision:4587; }","duration":"171.978279ms","start":"2026-04-09T06:01:06.859047Z","end":"2026-04-09T06:01:07.031025Z","steps":["trace[2130326886] 'agreement among raft nodes before linearized reading' (duration: 171.731573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.034724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.292128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-09T06:01:07.034931Z","caller":"traceutil/trace.go:171","msg":"trace[58445303] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4587; }","duration":"152.38918ms","start":"2026-04-09T06:01:06.882403Z","end":"2026-04-09T06:01:07.034792Z","steps":["trace[58445303] 'agreement among raft nodes before linearized reading' (duration: 148.836493ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:07.356438Z","caller":"traceutil/trace.go:171","msg":"trace[781101572] linearizableReadLoop","detail":"{readStateIndex:4765; appliedIndex:4764; }","duration":"283.72853ms","start":"2026-04-09T06:01:07.07269Z","end":"2026-04-09T06:01:07.356418Z","steps":["trace[781101572] 'read index received' (duration: 283.537336ms)","trace[781101572] 'applied index is now lower than readState.Index' (duration: 190.144µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:07.356912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.656046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b6dd16c1-ea11-45f1-b551-ec84651bee25\" ","response":"range_response_count:1 size:3894"} {"level":"info","ts":"2026-04-09T06:01:07.356971Z","caller":"traceutil/trace.go:171","msg":"trace[1701559017] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b6dd16c1-ea11-45f1-b551-ec84651bee25; range_end:; response_count:1; response_revision:4589; }","duration":"180.761238ms","start":"2026-04-09T06:01:07.176195Z","end":"2026-04-09T06:01:07.356956Z","steps":["trace[1701559017] 'agreement among raft nodes before linearized reading' (duration: 180.658897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.357142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.779614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:07.357194Z","caller":"traceutil/trace.go:171","msg":"trace[1139688543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4589; }","duration":"136.877356ms","start":"2026-04-09T06:01:07.220304Z","end":"2026-04-09T06:01:07.357181Z","steps":["trace[1139688543] 'agreement among raft nodes before linearized reading' (duration: 136.791465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.357365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.664957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-09T06:01:07.357426Z","caller":"traceutil/trace.go:171","msg":"trace[273723778] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4589; }","duration":"284.777799ms","start":"2026-04-09T06:01:07.072633Z","end":"2026-04-09T06:01:07.35741Z","steps":["trace[273723778] 'agreement among raft nodes before linearized reading' (duration: 284.611516ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:07.35682Z","caller":"traceutil/trace.go:171","msg":"trace[442480903] transaction","detail":"{read_only:false; response_revision:4589; number_of_response:1; }","duration":"315.719669ms","start":"2026-04-09T06:01:07.041035Z","end":"2026-04-09T06:01:07.356755Z","steps":["trace[442480903] 'process raft request' (duration: 315.25328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.359792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:07.041009Z","time spent":"318.699944ms","remote":"127.0.0.1:59920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:01:07.968063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.817248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-09T06:01:07.968147Z","caller":"traceutil/trace.go:171","msg":"trace[1904037676] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4589; }","duration":"580.92863ms","start":"2026-04-09T06:01:07.38719Z","end":"2026-04-09T06:01:07.968119Z","steps":["trace[1904037676] 'range keys from in-memory index tree' (duration: 580.660425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.968199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:07.387174Z","time spent":"581.012761ms","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3529,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"info","ts":"2026-04-09T06:01:07.968223Z","caller":"traceutil/trace.go:171","msg":"trace[997965674] transaction","detail":"{read_only:false; response_revision:4590; number_of_response:1; }","duration":"561.805401ms","start":"2026-04-09T06:01:07.406379Z","end":"2026-04-09T06:01:07.968184Z","steps":["trace[997965674] 'process raft request' (duration: 545.104429ms)","trace[997965674] 'compare' (duration: 16.218023ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:07.968363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:07.406352Z","time spent":"561.934065ms","remote":"127.0.0.1:59996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:01:07.997952Z","caller":"traceutil/trace.go:171","msg":"trace[1809219372] transaction","detail":"{read_only:false; response_revision:4591; number_of_response:1; }","duration":"497.579238ms","start":"2026-04-09T06:01:07.500348Z","end":"2026-04-09T06:01:07.997927Z","steps":["trace[1809219372] 'process raft request' (duration: 497.370904ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:07.998093Z","caller":"traceutil/trace.go:171","msg":"trace[728785903] linearizableReadLoop","detail":"{readStateIndex:4767; appliedIndex:4765; }","duration":"473.097079ms","start":"2026-04-09T06:01:07.524975Z","end":"2026-04-09T06:01:07.998072Z","steps":["trace[728785903] 'read index received' (duration: 426.476276ms)","trace[728785903] 'applied index is now lower than readState.Index' (duration: 46.619713ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:07.998126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:07.500326Z","time spent":"497.702411ms","remote":"127.0.0.1:59996","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-09T06:01:07.998258Z","caller":"traceutil/trace.go:171","msg":"trace[1079479904] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"330.077807ms","start":"2026-04-09T06:01:07.668168Z","end":"2026-04-09T06:01:07.998246Z","steps":["trace[1079479904] 'process raft request' (duration: 329.702261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.998356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:07.668144Z","time spent":"330.143648ms","remote":"127.0.0.1:59996","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-09T06:01:07.998464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.484907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:07.998495Z","caller":"traceutil/trace.go:171","msg":"trace[1771094941] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4592; }","duration":"473.552098ms","start":"2026-04-09T06:01:07.524932Z","end":"2026-04-09T06:01:07.998484Z","steps":["trace[1771094941] 'agreement among raft nodes before linearized reading' (duration: 473.503867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:07.998522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:07.524911Z","time spent":"473.603979ms","remote":"127.0.0.1:40634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:01:10.085689Z","caller":"traceutil/trace.go:171","msg":"trace[1791011452] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"192.996595ms","start":"2026-04-09T06:01:09.892667Z","end":"2026-04-09T06:01:10.085663Z","steps":["trace[1791011452] 'process raft request' (duration: 192.841032ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:10.173692Z","caller":"traceutil/trace.go:171","msg":"trace[721725998] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"273.70923ms","start":"2026-04-09T06:01:09.899953Z","end":"2026-04-09T06:01:10.173662Z","steps":["trace[721725998] 'process raft request' (duration: 270.698053ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:10.174366Z","caller":"traceutil/trace.go:171","msg":"trace[283093737] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"169.192997ms","start":"2026-04-09T06:01:10.005157Z","end":"2026-04-09T06:01:10.17435Z","steps":["trace[283093737] 'process raft request' (duration: 168.472753ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:10.174519Z","caller":"traceutil/trace.go:171","msg":"trace[149296253] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"170.881579ms","start":"2026-04-09T06:01:10.00324Z","end":"2026-04-09T06:01:10.174121Z","steps":["trace[149296253] 'process raft request' (duration: 170.338019ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:10.175696Z","caller":"traceutil/trace.go:171","msg":"trace[395459511] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"130.431254ms","start":"2026-04-09T06:01:10.045214Z","end":"2026-04-09T06:01:10.175646Z","steps":["trace[395459511] 'process raft request' (duration: 128.463227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:15.698554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.24357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:15.698628Z","caller":"traceutil/trace.go:171","msg":"trace[1113500553] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:4774; }","duration":"299.374841ms","start":"2026-04-09T06:01:15.399239Z","end":"2026-04-09T06:01:15.698614Z","steps":["trace[1113500553] 'count revisions from in-memory index tree' (duration: 299.153458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:15.698699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.220299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8a8e0e92-1743-4c77-b77e-76e07d217070\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-09T06:01:15.698774Z","caller":"traceutil/trace.go:171","msg":"trace[443887132] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8a8e0e92-1743-4c77-b77e-76e07d217070; range_end:; response_count:1; response_revision:4774; }","duration":"293.333251ms","start":"2026-04-09T06:01:15.405423Z","end":"2026-04-09T06:01:15.698756Z","steps":["trace[443887132] 'range keys from in-memory index tree' (duration: 293.031774ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:16.086279Z","caller":"traceutil/trace.go:171","msg":"trace[1976675351] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"132.98372ms","start":"2026-04-09T06:01:15.953272Z","end":"2026-04-09T06:01:16.086255Z","steps":["trace[1976675351] 'process raft request' (duration: 132.835647ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:16.142309Z","caller":"traceutil/trace.go:171","msg":"trace[1935658466] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"183.568374ms","start":"2026-04-09T06:01:15.958715Z","end":"2026-04-09T06:01:16.142283Z","steps":["trace[1935658466] 'process raft request' (duration: 165.475099ms)","trace[1935658466] 'compare' (duration: 17.925442ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:16.337932Z","caller":"traceutil/trace.go:171","msg":"trace[1233266415] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"103.079227ms","start":"2026-04-09T06:01:16.234815Z","end":"2026-04-09T06:01:16.337894Z","steps":["trace[1233266415] 'process raft request' (duration: 33.110393ms)","trace[1233266415] 'compare' (duration: 69.79094ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:16.625004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.657568ms","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-09T06:01:16.625065Z","caller":"traceutil/trace.go:171","msg":"trace[1899433990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4781; }","duration":"174.773321ms","start":"2026-04-09T06:01:16.450278Z","end":"2026-04-09T06:01:16.625052Z","steps":["trace[1899433990] 'range keys from in-memory index tree' (duration: 174.485406ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:16.741658Z","caller":"traceutil/trace.go:171","msg":"trace[556931034] transaction","detail":"{read_only:false; response_revision:4782; number_of_response:1; }","duration":"111.97689ms","start":"2026-04-09T06:01:16.62965Z","end":"2026-04-09T06:01:16.741627Z","steps":["trace[556931034] 'process raft request' (duration: 111.669985ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:16.797699Z","caller":"traceutil/trace.go:171","msg":"trace[927540396] linearizableReadLoop","detail":"{readStateIndex:4964; appliedIndex:4962; }","duration":"106.265594ms","start":"2026-04-09T06:01:16.691401Z","end":"2026-04-09T06:01:16.797667Z","steps":["trace[927540396] 'read index received' (duration: 49.905012ms)","trace[927540396] 'applied index is now lower than readState.Index' (duration: 56.359242ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:16.797749Z","caller":"traceutil/trace.go:171","msg":"trace[1510364200] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"166.719982ms","start":"2026-04-09T06:01:16.631001Z","end":"2026-04-09T06:01:16.797721Z","steps":["trace[1510364200] 'process raft request' (duration: 166.530388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:16.798087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.665191ms","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-09T06:01:16.798126Z","caller":"traceutil/trace.go:171","msg":"trace[1907846229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4783; }","duration":"106.760793ms","start":"2026-04-09T06:01:16.691353Z","end":"2026-04-09T06:01:16.798114Z","steps":["trace[1907846229] 'agreement among raft nodes before linearized reading' (duration: 106.481858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:17.074118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.732931ms","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-09T06:01:17.074201Z","caller":"traceutil/trace.go:171","msg":"trace[75715341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4784; }","duration":"119.853904ms","start":"2026-04-09T06:01:16.954325Z","end":"2026-04-09T06:01:17.074179Z","steps":["trace[75715341] 'range keys from in-memory index tree' (duration: 119.577668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:19.059656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.590127ms","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-09T06:01:19.059743Z","caller":"traceutil/trace.go:171","msg":"trace[1525504064] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4811; }","duration":"230.713729ms","start":"2026-04-09T06:01:18.829004Z","end":"2026-04-09T06:01:19.059718Z","steps":["trace[1525504064] 'range keys from in-memory index tree' (duration: 230.417964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:19.060156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.883738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8a8e0e92-1743-4c77-b77e-76e07d217070\" ","response":"range_response_count:1 size:3952"} {"level":"warn","ts":"2026-04-09T06:01:19.060212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.460702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-04-09T06:01:19.06024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.27337ms","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-09T06:01:19.060258Z","caller":"traceutil/trace.go:171","msg":"trace[1549755599] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4811; }","duration":"258.531282ms","start":"2026-04-09T06:01:18.801711Z","end":"2026-04-09T06:01:19.060242Z","steps":["trace[1549755599] 'range keys from in-memory index tree' (duration: 258.319559ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:19.060256Z","caller":"traceutil/trace.go:171","msg":"trace[1604088196] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8a8e0e92-1743-4c77-b77e-76e07d217070; range_end:; response_count:1; response_revision:4811; }","duration":"253.00803ms","start":"2026-04-09T06:01:18.807225Z","end":"2026-04-09T06:01:19.060233Z","steps":["trace[1604088196] 'range keys from in-memory index tree' (duration: 252.724115ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:19.060295Z","caller":"traceutil/trace.go:171","msg":"trace[446759685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4811; }","duration":"314.354642ms","start":"2026-04-09T06:01:18.745925Z","end":"2026-04-09T06:01:19.060279Z","steps":["trace[446759685] 'range keys from in-memory index tree' (duration: 314.128258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:19.060336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:18.745909Z","time spent":"314.414983ms","remote":"127.0.0.1:59996","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-09T06:01:21.788127Z","caller":"traceutil/trace.go:171","msg":"trace[2081665806] linearizableReadLoop","detail":"{readStateIndex:5048; appliedIndex:5047; }","duration":"129.70427ms","start":"2026-04-09T06:01:21.658406Z","end":"2026-04-09T06:01:21.788111Z","steps":["trace[2081665806] 'read index received' (duration: 56.521147ms)","trace[2081665806] 'applied index is now lower than readState.Index' (duration: 73.182393ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:21.788334Z","caller":"traceutil/trace.go:171","msg":"trace[1754403293] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"169.858167ms","start":"2026-04-09T06:01:21.618415Z","end":"2026-04-09T06:01:21.788273Z","steps":["trace[1754403293] 'process raft request' (duration: 96.585412ms)","trace[1754403293] 'compare' (duration: 72.865427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:21.788833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.418333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-09T06:01:21.788865Z","caller":"traceutil/trace.go:171","msg":"trace[1778219500] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4865; }","duration":"130.494485ms","start":"2026-04-09T06:01:21.65836Z","end":"2026-04-09T06:01:21.788855Z","steps":["trace[1778219500] 'agreement among raft nodes before linearized reading' (duration: 129.810582ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:24.260149Z","caller":"traceutil/trace.go:171","msg":"trace[1630243564] linearizableReadLoop","detail":"{readStateIndex:5092; appliedIndex:5091; }","duration":"173.311716ms","start":"2026-04-09T06:01:24.086801Z","end":"2026-04-09T06:01:24.260113Z","steps":["trace[1630243564] 'read index received' (duration: 79.131675ms)","trace[1630243564] 'applied index is now lower than readState.Index' (duration: 94.178001ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:24.261832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.016867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-04-09T06:01:24.261891Z","caller":"traceutil/trace.go:171","msg":"trace[759810392] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4907; }","duration":"175.132509ms","start":"2026-04-09T06:01:24.086746Z","end":"2026-04-09T06:01:24.261879Z","steps":["trace[759810392] 'agreement among raft nodes before linearized reading' (duration: 173.488359ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:28.460172Z","caller":"traceutil/trace.go:171","msg":"trace[1815274441] linearizableReadLoop","detail":"{readStateIndex:5114; appliedIndex:5113; }","duration":"302.721897ms","start":"2026-04-09T06:01:28.157422Z","end":"2026-04-09T06:01:28.460144Z","steps":["trace[1815274441] 'read index received' (duration: 302.677146ms)","trace[1815274441] 'applied index is now lower than readState.Index' (duration: 43.471µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:28.460301Z","caller":"traceutil/trace.go:171","msg":"trace[1066386577] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"362.38314ms","start":"2026-04-09T06:01:28.097907Z","end":"2026-04-09T06:01:28.46029Z","steps":["trace[1066386577] 'process raft request' (duration: 362.073805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:28.460501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:28.097893Z","time spent":"362.492742ms","remote":"127.0.0.1:59920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:01:28.460787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.239157ms","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-09T06:01:28.461028Z","caller":"traceutil/trace.go:171","msg":"trace[1390299738] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4928; }","duration":"303.487432ms","start":"2026-04-09T06:01:28.157371Z","end":"2026-04-09T06:01:28.460859Z","steps":["trace[1390299738] 'agreement among raft nodes before linearized reading' (duration: 303.184007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:28.461109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:28.157353Z","time spent":"303.735386ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:01:28.476108Z","caller":"traceutil/trace.go:171","msg":"trace[263582594] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"203.929973ms","start":"2026-04-09T06:01:28.272156Z","end":"2026-04-09T06:01:28.476086Z","steps":["trace[263582594] 'process raft request' (duration: 203.667918ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:28.476185Z","caller":"traceutil/trace.go:171","msg":"trace[1289176958] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"128.706387ms","start":"2026-04-09T06:01:28.347434Z","end":"2026-04-09T06:01:28.47614Z","steps":["trace[1289176958] 'process raft request' (duration: 128.625006ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:28.47623Z","caller":"traceutil/trace.go:171","msg":"trace[26247687] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"202.162221ms","start":"2026-04-09T06:01:28.274016Z","end":"2026-04-09T06:01:28.476178Z","steps":["trace[26247687] 'process raft request' (duration: 202.016169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:28.476498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.775915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:28.476567Z","caller":"traceutil/trace.go:171","msg":"trace[2080993167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4932; }","duration":"255.917737ms","start":"2026-04-09T06:01:28.220638Z","end":"2026-04-09T06:01:28.476556Z","steps":["trace[2080993167] 'agreement among raft nodes before linearized reading' (duration: 255.47749ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:28.476806Z","caller":"traceutil/trace.go:171","msg":"trace[1076574717] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"203.19496ms","start":"2026-04-09T06:01:28.273583Z","end":"2026-04-09T06:01:28.476778Z","steps":["trace[1076574717] 'process raft request' (duration: 202.413016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:29.33343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.83044ms","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-09T06:01:29.333642Z","caller":"traceutil/trace.go:171","msg":"trace[1752972903] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4941; }","duration":"116.327389ms","start":"2026-04-09T06:01:29.217287Z","end":"2026-04-09T06:01:29.333614Z","steps":["trace[1752972903] 'range keys from in-memory index tree' (duration: 115.798529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:29.334495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.130812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:01:29.335479Z","caller":"traceutil/trace.go:171","msg":"trace[2019222849] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5128; }","duration":"117.00928ms","start":"2026-04-09T06:01:29.218443Z","end":"2026-04-09T06:01:29.335452Z","steps":["trace[2019222849] 'read index received' (duration: 3.604155ms)","trace[2019222849] 'applied index is now lower than readState.Index' (duration: 113.403995ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:29.335596Z","caller":"traceutil/trace.go:171","msg":"trace[732546262] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"160.49837ms","start":"2026-04-09T06:01:29.175084Z","end":"2026-04-09T06:01:29.335582Z","steps":["trace[732546262] 'process raft request' (duration: 46.978273ms)","trace[732546262] 'compare' (duration: 111.939249ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:29.335801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.350847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:29.336042Z","caller":"traceutil/trace.go:171","msg":"trace[1319000684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4943; }","duration":"117.616462ms","start":"2026-04-09T06:01:29.218411Z","end":"2026-04-09T06:01:29.336028Z","steps":["trace[1319000684] 'agreement among raft nodes before linearized reading' (duration: 117.292986ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:29.336157Z","caller":"traceutil/trace.go:171","msg":"trace[308082277] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"118.68092ms","start":"2026-04-09T06:01:29.217419Z","end":"2026-04-09T06:01:29.3361Z","steps":["trace[308082277] 'process raft request' (duration: 117.893236ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:29.536281Z","caller":"traceutil/trace.go:171","msg":"trace[385612276] linearizableReadLoop","detail":"{readStateIndex:5133; appliedIndex:5132; }","duration":"126.2982ms","start":"2026-04-09T06:01:29.40995Z","end":"2026-04-09T06:01:29.536248Z","steps":["trace[385612276] 'read index received' (duration: 33.065719ms)","trace[385612276] 'applied index is now lower than readState.Index' (duration: 93.230721ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:29.536361Z","caller":"traceutil/trace.go:171","msg":"trace[1152251936] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"126.944452ms","start":"2026-04-09T06:01:29.409363Z","end":"2026-04-09T06:01:29.536308Z","steps":["trace[1152251936] 'process raft request' (duration: 33.761542ms)","trace[1152251936] 'compare' (duration: 92.986556ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:29.536473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.496394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:01:29.536522Z","caller":"traceutil/trace.go:171","msg":"trace[46404500] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:4946; }","duration":"126.600675ms","start":"2026-04-09T06:01:29.409907Z","end":"2026-04-09T06:01:29.536508Z","steps":["trace[46404500] 'agreement among raft nodes before linearized reading' (duration: 126.490913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:29.536745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.558473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-04-09T06:01:29.536824Z","caller":"traceutil/trace.go:171","msg":"trace[507803567] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4946; }","duration":"122.691955ms","start":"2026-04-09T06:01:29.414116Z","end":"2026-04-09T06:01:29.536808Z","steps":["trace[507803567] 'agreement among raft nodes before linearized reading' (duration: 122.473171ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:29.667929Z","caller":"traceutil/trace.go:171","msg":"trace[698988679] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"123.953318ms","start":"2026-04-09T06:01:29.543933Z","end":"2026-04-09T06:01:29.667886Z","steps":["trace[698988679] 'process raft request' (duration: 95.579014ms)","trace[698988679] 'compare' (duration: 28.026228ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:29.668856Z","caller":"traceutil/trace.go:171","msg":"trace[260645283] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"122.250806ms","start":"2026-04-09T06:01:29.546562Z","end":"2026-04-09T06:01:29.668813Z","steps":["trace[260645283] 'process raft request' (duration: 122.011802ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:29.669345Z","caller":"traceutil/trace.go:171","msg":"trace[999003959] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"124.729431ms","start":"2026-04-09T06:01:29.544571Z","end":"2026-04-09T06:01:29.669301Z","steps":["trace[999003959] 'process raft request' (duration: 123.181383ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:39.374361Z","caller":"traceutil/trace.go:171","msg":"trace[1365196628] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"110.207922ms","start":"2026-04-09T06:01:39.264129Z","end":"2026-04-09T06:01:39.374337Z","steps":["trace[1365196628] 'process raft request' (duration: 100.61344ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.37607Z","caller":"traceutil/trace.go:171","msg":"trace[1141133404] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"124.611467ms","start":"2026-04-09T06:01:54.251431Z","end":"2026-04-09T06:01:54.376043Z","steps":["trace[1141133404] 'process raft request' (duration: 124.411914ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.746455Z","caller":"traceutil/trace.go:171","msg":"trace[830790928] transaction","detail":"{read_only:false; response_revision:5135; number_of_response:1; }","duration":"182.694996ms","start":"2026-04-09T06:01:54.563738Z","end":"2026-04-09T06:01:54.746433Z","steps":["trace[830790928] 'process raft request' (duration: 182.611845ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.746884Z","caller":"traceutil/trace.go:171","msg":"trace[392793279] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"170.407641ms","start":"2026-04-09T06:01:54.576459Z","end":"2026-04-09T06:01:54.746867Z","steps":["trace[392793279] 'process raft request' (duration: 170.377171ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747031Z","caller":"traceutil/trace.go:171","msg":"trace[1527260298] transaction","detail":"{read_only:false; response_revision:5142; number_of_response:1; }","duration":"170.814028ms","start":"2026-04-09T06:01:54.576139Z","end":"2026-04-09T06:01:54.746953Z","steps":["trace[1527260298] 'process raft request' (duration: 170.597753ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747149Z","caller":"traceutil/trace.go:171","msg":"trace[1499460310] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"170.93789ms","start":"2026-04-09T06:01:54.576204Z","end":"2026-04-09T06:01:54.747142Z","steps":["trace[1499460310] 'process raft request' (duration: 170.576874ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747233Z","caller":"traceutil/trace.go:171","msg":"trace[58474693] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"171.060362ms","start":"2026-04-09T06:01:54.57616Z","end":"2026-04-09T06:01:54.74722Z","steps":["trace[58474693] 'process raft request' (duration: 170.591563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:54.747259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.031382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-09T06:01:54.747303Z","caller":"traceutil/trace.go:171","msg":"trace[2054630820] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5149; }","duration":"175.105703ms","start":"2026-04-09T06:01:54.572188Z","end":"2026-04-09T06:01:54.747293Z","steps":["trace[2054630820] 'agreement among raft nodes before linearized reading' (duration: 174.91119ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747314Z","caller":"traceutil/trace.go:171","msg":"trace[503928244] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"171.085162ms","start":"2026-04-09T06:01:54.576221Z","end":"2026-04-09T06:01:54.747306Z","steps":["trace[503928244] 'process raft request' (duration: 170.572694ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747049Z","caller":"traceutil/trace.go:171","msg":"trace[1131054445] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"171.123234ms","start":"2026-04-09T06:01:54.575915Z","end":"2026-04-09T06:01:54.747038Z","steps":["trace[1131054445] 'process raft request' (duration: 170.582804ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747422Z","caller":"traceutil/trace.go:171","msg":"trace[1889119968] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"171.144543ms","start":"2026-04-09T06:01:54.576247Z","end":"2026-04-09T06:01:54.747392Z","steps":["trace[1889119968] 'process raft request' (duration: 170.560203ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747517Z","caller":"traceutil/trace.go:171","msg":"trace[1502801127] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"171.197545ms","start":"2026-04-09T06:01:54.576285Z","end":"2026-04-09T06:01:54.747483Z","steps":["trace[1502801127] 'process raft request' (duration: 170.537084ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747724Z","caller":"traceutil/trace.go:171","msg":"trace[1124439166] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"184.656451ms","start":"2026-04-09T06:01:54.563054Z","end":"2026-04-09T06:01:54.74771Z","steps":["trace[1124439166] 'process raft request' (duration: 92.225179ms)","trace[1124439166] 'compare' (duration: 90.955706ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:54.746901Z","caller":"traceutil/trace.go:171","msg":"trace[631744671] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"170.798617ms","start":"2026-04-09T06:01:54.576065Z","end":"2026-04-09T06:01:54.746863Z","steps":["trace[631744671] 'process raft request' (duration: 170.628954ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.746953Z","caller":"traceutil/trace.go:171","msg":"trace[1908371998] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"170.850909ms","start":"2026-04-09T06:01:54.57609Z","end":"2026-04-09T06:01:54.746941Z","steps":["trace[1908371998] 'process raft request' (duration: 170.623654ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.74704Z","caller":"traceutil/trace.go:171","msg":"trace[924483625] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"176.945886ms","start":"2026-04-09T06:01:54.570081Z","end":"2026-04-09T06:01:54.747027Z","steps":["trace[924483625] 'process raft request' (duration: 176.309905ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747081Z","caller":"traceutil/trace.go:171","msg":"trace[1277232882] linearizableReadLoop","detail":"{readStateIndex:5329; appliedIndex:5326; }","duration":"174.864319ms","start":"2026-04-09T06:01:54.572208Z","end":"2026-04-09T06:01:54.747072Z","steps":["trace[1277232882] 'read index received' (duration: 83.118968ms)","trace[1277232882] 'applied index is now lower than readState.Index' (duration: 91.743371ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:54.746906Z","caller":"traceutil/trace.go:171","msg":"trace[1022679499] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"170.697596ms","start":"2026-04-09T06:01:54.576184Z","end":"2026-04-09T06:01:54.746882Z","steps":["trace[1022679499] 'process raft request' (duration: 170.578343ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.747758Z","caller":"traceutil/trace.go:171","msg":"trace[1201838031] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"171.776854ms","start":"2026-04-09T06:01:54.575966Z","end":"2026-04-09T06:01:54.747742Z","steps":["trace[1201838031] 'process raft request' (duration: 170.700175ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:54.746904Z","caller":"traceutil/trace.go:171","msg":"trace[2050416140] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"170.769418ms","start":"2026-04-09T06:01:54.576115Z","end":"2026-04-09T06:01:54.746885Z","steps":["trace[2050416140] 'process raft request' (duration: 170.610324ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:05.787971Z","caller":"traceutil/trace.go:171","msg":"trace[297182511] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"199.122512ms","start":"2026-04-09T06:02:05.588814Z","end":"2026-04-09T06:02:05.787936Z","steps":["trace[297182511] 'process raft request' (duration: 149.819677ms)","trace[297182511] 'compare' (duration: 49.166242ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:02:05.804951Z","caller":"traceutil/trace.go:171","msg":"trace[1186951952] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"215.553146ms","start":"2026-04-09T06:02:05.589365Z","end":"2026-04-09T06:02:05.804918Z","steps":["trace[1186951952] 'process raft request' (duration: 215.377613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:05.805289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.031311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:02:05.805363Z","caller":"traceutil/trace.go:171","msg":"trace[873164629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5289; }","duration":"172.187443ms","start":"2026-04-09T06:02:05.633161Z","end":"2026-04-09T06:02:05.805349Z","steps":["trace[873164629] 'agreement among raft nodes before linearized reading' (duration: 171.842097ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:05.804902Z","caller":"traceutil/trace.go:171","msg":"trace[1976550716] linearizableReadLoop","detail":"{readStateIndex:5484; appliedIndex:5482; }","duration":"171.666095ms","start":"2026-04-09T06:02:05.633214Z","end":"2026-04-09T06:02:05.80488Z","steps":["trace[1976550716] 'read index received' (duration: 105.450917ms)","trace[1976550716] 'applied index is now lower than readState.Index' (duration: 66.213848ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:02:05.805808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.122391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"} {"level":"info","ts":"2026-04-09T06:02:05.805872Z","caller":"traceutil/trace.go:171","msg":"trace[1689455409] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5289; }","duration":"150.266294ms","start":"2026-04-09T06:02:05.655589Z","end":"2026-04-09T06:02:05.805856Z","steps":["trace[1689455409] 'agreement among raft nodes before linearized reading' (duration: 150.0144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:05.806087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.325945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:02:05.806141Z","caller":"traceutil/trace.go:171","msg":"trace[1617192124] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5289; }","duration":"150.389996ms","start":"2026-04-09T06:02:05.655738Z","end":"2026-04-09T06:02:05.806128Z","steps":["trace[1617192124] 'agreement among raft nodes before linearized reading' (duration: 150.309374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:05.806275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.375566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:02:05.806471Z","caller":"traceutil/trace.go:171","msg":"trace[5198950] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5289; }","duration":"150.63273ms","start":"2026-04-09T06:02:05.655826Z","end":"2026-04-09T06:02:05.806459Z","steps":["trace[5198950] 'agreement among raft nodes before linearized reading' (duration: 150.397097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:05.808285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.224628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-09T06:02:05.808344Z","caller":"traceutil/trace.go:171","msg":"trace[965917011] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5289; }","duration":"126.32133ms","start":"2026-04-09T06:02:05.682006Z","end":"2026-04-09T06:02:05.808327Z","steps":["trace[965917011] 'agreement among raft nodes before linearized reading' (duration: 123.760925ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:18.547737Z","caller":"traceutil/trace.go:171","msg":"trace[650652853] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"112.417382ms","start":"2026-04-09T06:02:18.43529Z","end":"2026-04-09T06:02:18.547707Z","steps":["trace[650652853] 'process raft request' (duration: 112.207758ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:45.784385Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2909} {"level":"info","ts":"2026-04-09T06:02:45.855783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2909,"took":"69.842985ms","hash":1281089772,"current-db-size-bytes":52015104,"current-db-size":"52 MB","current-db-size-in-use-bytes":29155328,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-09T06:02:45.855844Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1281089772,"revision":2909,"compact-revision":-1} {"level":"info","ts":"2026-04-09T06:04:58.746698Z","caller":"traceutil/trace.go:171","msg":"trace[323788569] transaction","detail":"{read_only:false; response_revision:6501; number_of_response:1; }","duration":"199.550203ms","start":"2026-04-09T06:04:58.547119Z","end":"2026-04-09T06:04:58.746669Z","steps":["trace[323788569] 'process raft request' (duration: 199.379ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:04:58.793257Z","caller":"traceutil/trace.go:171","msg":"trace[891102934] linearizableReadLoop","detail":"{readStateIndex:6739; appliedIndex:6737; }","duration":"135.542842ms","start":"2026-04-09T06:04:58.657665Z","end":"2026-04-09T06:04:58.793208Z","steps":["trace[891102934] 'read index received' (duration: 88.95477ms)","trace[891102934] 'applied index is now lower than readState.Index' (duration: 46.585982ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:04:58.79329Z","caller":"traceutil/trace.go:171","msg":"trace[1520315963] transaction","detail":"{read_only:false; response_revision:6502; number_of_response:1; }","duration":"239.058497ms","start":"2026-04-09T06:04:58.554199Z","end":"2026-04-09T06:04:58.793258Z","steps":["trace[1520315963] 'process raft request' (duration: 238.794033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:04:58.793625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.921368ms","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-09T06:04:58.793679Z","caller":"traceutil/trace.go:171","msg":"trace[576340490] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6502; }","duration":"136.05789ms","start":"2026-04-09T06:04:58.657605Z","end":"2026-04-09T06:04:58.793663Z","steps":["trace[576340490] 'agreement among raft nodes before linearized reading' (duration: 135.809066ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:07:45.792305Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5594} {"level":"info","ts":"2026-04-09T06:07:45.872019Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5594,"took":"77.403569ms","hash":1738282719,"current-db-size-bytes":52015104,"current-db-size":"52 MB","current-db-size-in-use-bytes":18292736,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-09T06:07:45.872259Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1738282719,"revision":5594,"compact-revision":2909}