{"level":"warn","ts":"2026-06-02T06:47:53.072081Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:47:53.072151Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.78: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.78:2380","--initial-cluster=instance=https://199.19.213.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.78:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-02T06:47:53.072206Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:47:53.072213Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.78:2380"]} {"level":"info","ts":"2026-06-02T06:47:53.072228Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T06:47:53.072807Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.78:2379"]} {"level":"info","ts":"2026-06-02T06:47:53.072873Z","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.78:2380"],"listen-peer-urls":["https://199.19.213.78:2380"],"advertise-client-urls":["https://199.19.213.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.78:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-02T06:47:53.08185Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.785737ms"} {"level":"info","ts":"2026-06-02T06:47:53.11256Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"173f1df9994fe3b5","cluster-id":"f38512da1b70c9fc"} {"level":"info","ts":"2026-06-02T06:47:53.112673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T06:47:53.112703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became follower at term 0"} {"level":"info","ts":"2026-06-02T06:47:53.112954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 173f1df9994fe3b5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T06:47:53.112983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became follower at term 1"} {"level":"info","ts":"2026-06-02T06:47:53.113103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 switched to configuration voters=(1675090544261325749)"} {"level":"warn","ts":"2026-06-02T06:47:53.136115Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T06:47:53.139271Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T06:47:53.141949Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-02T06:47:53.147019Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"173f1df9994fe3b5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T06:47:53.147523Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T06:47:53.147653Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T06:47:53.147677Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T06:47:53.147795Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"173f1df9994fe3b5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T06:47:53.148988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 switched to configuration voters=(1675090544261325749)"} {"level":"info","ts":"2026-06-02T06:47:53.149226Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f38512da1b70c9fc","local-member-id":"173f1df9994fe3b5","added-peer-id":"173f1df9994fe3b5","added-peer-peer-urls":["https://199.19.213.78:2380"]} {"level":"info","ts":"2026-06-02T06:47:53.152533Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T06:47:53.152654Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.78:2380"} {"level":"info","ts":"2026-06-02T06:47:53.152706Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.78:2380"} {"level":"info","ts":"2026-06-02T06:47:53.152779Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"173f1df9994fe3b5","initial-advertise-peer-urls":["https://199.19.213.78:2380"],"listen-peer-urls":["https://199.19.213.78:2380"],"advertise-client-urls":["https://199.19.213.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T06:47:53.152857Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T06:47:53.613469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T06:47:53.613527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T06:47:53.613552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 received MsgPreVoteResp from 173f1df9994fe3b5 at term 1"} {"level":"info","ts":"2026-06-02T06:47:53.613566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became candidate at term 2"} {"level":"info","ts":"2026-06-02T06:47:53.613574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 received MsgVoteResp from 173f1df9994fe3b5 at term 2"} {"level":"info","ts":"2026-06-02T06:47:53.613604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became leader at term 2"} {"level":"info","ts":"2026-06-02T06:47:53.613618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 173f1df9994fe3b5 elected leader 173f1df9994fe3b5 at term 2"} {"level":"info","ts":"2026-06-02T06:47:53.614466Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:53.615151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:47:53.615149Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"173f1df9994fe3b5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.78:2379]}","request-path":"/0/members/173f1df9994fe3b5/attributes","cluster-id":"f38512da1b70c9fc","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T06:47:53.615172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:47:53.615388Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T06:47:53.615432Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T06:47:53.616497Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f38512da1b70c9fc","local-member-id":"173f1df9994fe3b5","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:53.616568Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:53.616586Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:53.617781Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.78:2379"} {"level":"info","ts":"2026-06-02T06:47:53.618473Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T06:48:08.655262Z","caller":"traceutil/trace.go:171","msg":"trace[554987908] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"151.693101ms","start":"2026-06-02T06:48:08.503541Z","end":"2026-06-02T06:48:08.655234Z","steps":["trace[554987908] 'process raft request' (duration: 151.490158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:31.081916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.38799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:48:31.08241Z","caller":"traceutil/trace.go:171","msg":"trace[2055191064] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"263.261089ms","start":"2026-06-02T06:48:30.81907Z","end":"2026-06-02T06:48:31.082331Z","steps":["trace[2055191064] 'process raft request' (duration: 102.727799ms)","trace[2055191064] 'compare' (duration: 159.18903ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:31.082541Z","caller":"traceutil/trace.go:171","msg":"trace[617480337] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"263.258769ms","start":"2026-06-02T06:48:30.81925Z","end":"2026-06-02T06:48:31.082508Z","steps":["trace[617480337] 'process raft request' (duration: 263.029288ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:31.082407Z","caller":"traceutil/trace.go:171","msg":"trace[1487851727] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"263.237128ms","start":"2026-06-02T06:48:30.81914Z","end":"2026-06-02T06:48:31.082377Z","steps":["trace[1487851727] 'process raft request' (duration: 262.948619ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:31.082624Z","caller":"traceutil/trace.go:171","msg":"trace[148742907] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"170.31015ms","start":"2026-06-02T06:48:30.9123Z","end":"2026-06-02T06:48:31.08261Z","steps":["trace[148742907] 'process raft request' (duration: 170.23085ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:31.082657Z","caller":"traceutil/trace.go:171","msg":"trace[1779333415] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"260.330065ms","start":"2026-06-02T06:48:30.822312Z","end":"2026-06-02T06:48:31.082642Z","steps":["trace[1779333415] 'process raft request' (duration: 260.104246ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:31.250948Z","caller":"traceutil/trace.go:171","msg":"trace[441528768] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"114.210254ms","start":"2026-06-02T06:48:31.136702Z","end":"2026-06-02T06:48:31.250912Z","steps":["trace[441528768] 'process raft request' (duration: 92.413614ms)","trace[441528768] 'compare' (duration: 21.56535ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:31.251176Z","caller":"traceutil/trace.go:171","msg":"trace[25292911] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"107.664041ms","start":"2026-06-02T06:48:31.143495Z","end":"2026-06-02T06:48:31.251159Z","steps":["trace[25292911] 'process raft request' (duration: 107.279471ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:31.281008Z","caller":"traceutil/trace.go:171","msg":"trace[1304697145] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"110.542319ms","start":"2026-06-02T06:48:31.170441Z","end":"2026-06-02T06:48:31.280983Z","steps":["trace[1304697145] 'process raft request' (duration: 110.329189ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:31.282241Z","caller":"traceutil/trace.go:171","msg":"trace[1874502693] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"102.832965ms","start":"2026-06-02T06:48:31.179388Z","end":"2026-06-02T06:48:31.282221Z","steps":["trace[1874502693] 'process raft request' (duration: 101.559116ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:37.542687Z","caller":"traceutil/trace.go:171","msg":"trace[1407656549] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"227.460942ms","start":"2026-06-02T06:48:37.315206Z","end":"2026-06-02T06:48:37.542667Z","steps":["trace[1407656549] 'read index received' (duration: 225.946743ms)","trace[1407656549] 'applied index is now lower than readState.Index' (duration: 1.513479ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:37.542789Z","caller":"traceutil/trace.go:171","msg":"trace[541557174] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"263.472932ms","start":"2026-06-02T06:48:37.279309Z","end":"2026-06-02T06:48:37.542782Z","steps":["trace[541557174] 'process raft request' (duration: 262.371415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:37.542996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.72323ms","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-06-02T06:48:37.54307Z","caller":"traceutil/trace.go:171","msg":"trace[618023577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"182.813951ms","start":"2026-06-02T06:48:37.360241Z","end":"2026-06-02T06:48:37.543055Z","steps":["trace[618023577] 'agreement among raft nodes before linearized reading' (duration: 182.591308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:37.543199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.872435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-02T06:48:37.543023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.990936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-02T06:48:37.543497Z","caller":"traceutil/trace.go:171","msg":"trace[1870586712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"182.519789ms","start":"2026-06-02T06:48:37.360968Z","end":"2026-06-02T06:48:37.543487Z","steps":["trace[1870586712] 'agreement among raft nodes before linearized reading' (duration: 181.941465ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:37.543397Z","caller":"traceutil/trace.go:171","msg":"trace[535580130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"228.219747ms","start":"2026-06-02T06:48:37.315156Z","end":"2026-06-02T06:48:37.543376Z","steps":["trace[535580130] 'agreement among raft nodes before linearized reading' (duration: 227.678103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:38.3118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.389876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:48:38.31197Z","caller":"traceutil/trace.go:171","msg":"trace[1793003896] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:624; }","duration":"701.070838ms","start":"2026-06-02T06:48:37.610888Z","end":"2026-06-02T06:48:38.311959Z","steps":["trace[1793003896] 'read index received' (duration: 370.393761ms)","trace[1793003896] 'applied index is now lower than readState.Index' (duration: 330.676317ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:38.312039Z","caller":"traceutil/trace.go:171","msg":"trace[32016073] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"754.446163ms","start":"2026-06-02T06:48:37.557586Z","end":"2026-06-02T06:48:38.312032Z","steps":["trace[32016073] 'process raft request' (duration: 754.287442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:38.312081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:37.557581Z","time spent":"754.478923ms","remote":"127.0.0.1:42512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:48:38.312095Z","caller":"traceutil/trace.go:171","msg":"trace[1961597617] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"754.487413ms","start":"2026-06-02T06:48:37.557525Z","end":"2026-06-02T06:48:38.312013Z","steps":["trace[1961597617] 'process raft request' (duration: 423.819015ms)","trace[1961597617] 'compare' (duration: 330.033333ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:38.312224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.33198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8p5x2\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-02T06:48:38.312259Z","caller":"traceutil/trace.go:171","msg":"trace[116024937] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8p5x2; range_end:; response_count:1; response_revision:602; }","duration":"701.38534ms","start":"2026-06-02T06:48:37.610859Z","end":"2026-06-02T06:48:38.312245Z","steps":["trace[116024937] 'agreement among raft nodes before linearized reading' (duration: 701.27263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:38.312274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:37.610839Z","time spent":"701.43121ms","remote":"127.0.0.1:42418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-8p5x2\" "} {"level":"warn","ts":"2026-06-02T06:48:38.312374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:37.557505Z","time spent":"754.745834ms","remote":"127.0.0.1:42512","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-06-02T06:48:38.312399Z","caller":"traceutil/trace.go:171","msg":"trace[2021705850] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"713.831626ms","start":"2026-06-02T06:48:37.598558Z","end":"2026-06-02T06:48:38.31239Z","steps":["trace[2021705850] 'process raft request' (duration: 713.376403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:38.312448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:37.598533Z","time spent":"713.894546ms","remote":"127.0.0.1:42700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:48:38.312217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.781395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-02T06:48:38.312504Z","caller":"traceutil/trace.go:171","msg":"trace[1546389202] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"203.088008ms","start":"2026-06-02T06:48:38.109393Z","end":"2026-06-02T06:48:38.312481Z","steps":["trace[1546389202] 'agreement among raft nodes before linearized reading' (duration: 202.800556ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:56.666863Z","caller":"traceutil/trace.go:171","msg":"trace[485886330] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"168.620243ms","start":"2026-06-02T06:48:56.498218Z","end":"2026-06-02T06:48:56.666838Z","steps":["trace[485886330] 'process raft request' (duration: 168.577402ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:56.666973Z","caller":"traceutil/trace.go:171","msg":"trace[2081181376] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"180.993894ms","start":"2026-06-02T06:48:56.48593Z","end":"2026-06-02T06:48:56.666924Z","steps":["trace[2081181376] 'process raft request' (duration: 124.393678ms)","trace[2081181376] 'compare' (duration: 56.351481ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:22.807875Z","caller":"traceutil/trace.go:171","msg":"trace[202679035] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"149.208785ms","start":"2026-06-02T06:49:22.658642Z","end":"2026-06-02T06:49:22.807851Z","steps":["trace[202679035] 'process raft request' (duration: 149.026197ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:22.966177Z","caller":"traceutil/trace.go:171","msg":"trace[1295750478] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"121.808446ms","start":"2026-06-02T06:49:22.84435Z","end":"2026-06-02T06:49:22.966158Z","steps":["trace[1295750478] 'process raft request' (duration: 52.092234ms)","trace[1295750478] 'compare' (duration: 68.996722ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:22.966191Z","caller":"traceutil/trace.go:171","msg":"trace[1727876265] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"118.517979ms","start":"2026-06-02T06:49:22.847653Z","end":"2026-06-02T06:49:22.966171Z","steps":["trace[1727876265] 'process raft request' (duration: 118.438305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:23.791856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.336939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:49:23.791934Z","caller":"traceutil/trace.go:171","msg":"trace[496643229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1165; }","duration":"549.446604ms","start":"2026-06-02T06:49:23.242468Z","end":"2026-06-02T06:49:23.791915Z","steps":["trace[496643229] 'range keys from in-memory index tree' (duration: 549.269166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:23.791969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:23.242452Z","time spent":"549.509377ms","remote":"127.0.0.1:42280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T06:49:23.792059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.549118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:49:23.792153Z","caller":"traceutil/trace.go:171","msg":"trace[1778420476] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1165; }","duration":"617.688402ms","start":"2026-06-02T06:49:23.17445Z","end":"2026-06-02T06:49:23.792138Z","steps":["trace[1778420476] 'count revisions from in-memory index tree' (duration: 617.487013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:23.792187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:23.174435Z","time spent":"617.743165ms","remote":"127.0.0.1:42438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":50,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-06-02T06:49:38.525551Z","caller":"traceutil/trace.go:171","msg":"trace[1675840109] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"100.831527ms","start":"2026-06-02T06:49:38.424688Z","end":"2026-06-02T06:49:38.52552Z","steps":["trace[1675840109] 'process raft request' (duration: 59.119155ms)","trace[1675840109] 'compare' (duration: 41.561464ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:41.212539Z","caller":"traceutil/trace.go:171","msg":"trace[1842236395] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"156.778152ms","start":"2026-06-02T06:49:41.05574Z","end":"2026-06-02T06:49:41.212518Z","steps":["trace[1842236395] 'process raft request' (duration: 156.650925ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:41.224988Z","caller":"traceutil/trace.go:171","msg":"trace[1347098835] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"155.377421ms","start":"2026-06-02T06:49:41.069594Z","end":"2026-06-02T06:49:41.224971Z","steps":["trace[1347098835] 'process raft request' (duration: 155.3479ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:41.225332Z","caller":"traceutil/trace.go:171","msg":"trace[1444321481] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"167.638616ms","start":"2026-06-02T06:49:41.057659Z","end":"2026-06-02T06:49:41.225298Z","steps":["trace[1444321481] 'process raft request' (duration: 164.358269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.169491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.834136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:49:49.169582Z","caller":"traceutil/trace.go:171","msg":"trace[1400339004] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1434; }","duration":"167.982924ms","start":"2026-06-02T06:49:49.001579Z","end":"2026-06-02T06:49:49.169562Z","steps":["trace[1400339004] 'count revisions from in-memory index tree' (duration: 167.695129ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:49.367607Z","caller":"traceutil/trace.go:171","msg":"trace[310331591] linearizableReadLoop","detail":"{readStateIndex:1483; appliedIndex:1481; }","duration":"111.787853ms","start":"2026-06-02T06:49:49.255785Z","end":"2026-06-02T06:49:49.367573Z","steps":["trace[310331591] 'read index received' (duration: 2.105624ms)","trace[310331591] 'applied index is now lower than readState.Index' (duration: 109.680369ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:49.367759Z","caller":"traceutil/trace.go:171","msg":"trace[743109424] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"119.664027ms","start":"2026-06-02T06:49:49.24805Z","end":"2026-06-02T06:49:49.367714Z","steps":["trace[743109424] 'process raft request' (duration: 106.391131ms)","trace[743109424] 'compare' (duration: 12.977481ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:49:49.367938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.140582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-02T06:49:49.368001Z","caller":"traceutil/trace.go:171","msg":"trace[2103327301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1436; }","duration":"112.223046ms","start":"2026-06-02T06:49:49.255761Z","end":"2026-06-02T06:49:49.367984Z","steps":["trace[2103327301] 'agreement among raft nodes before linearized reading' (duration: 112.010675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:13.670394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.834636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:50:13.67052Z","caller":"traceutil/trace.go:171","msg":"trace[1917258833] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1834; }","duration":"372.017526ms","start":"2026-06-02T06:50:13.298481Z","end":"2026-06-02T06:50:13.670499Z","steps":["trace[1917258833] 'count revisions from in-memory index tree' (duration: 371.747341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:13.670572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:13.298461Z","time spent":"372.099292ms","remote":"127.0.0.1:36172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-02T06:50:13.714977Z","caller":"traceutil/trace.go:171","msg":"trace[664735469] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"234.234156ms","start":"2026-06-02T06:50:13.480706Z","end":"2026-06-02T06:50:13.71494Z","steps":["trace[664735469] 'read index received' (duration: 233.892015ms)","trace[664735469] 'applied index is now lower than readState.Index' (duration: 338.051µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:13.715152Z","caller":"traceutil/trace.go:171","msg":"trace[1130944223] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"388.073178ms","start":"2026-06-02T06:50:13.327039Z","end":"2026-06-02T06:50:13.715112Z","steps":["trace[1130944223] 'process raft request' (duration: 387.60702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:13.715289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.576356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-02T06:50:13.715335Z","caller":"traceutil/trace.go:171","msg":"trace[691366246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1835; }","duration":"234.685214ms","start":"2026-06-02T06:50:13.480638Z","end":"2026-06-02T06:50:13.715324Z","steps":["trace[691366246] 'agreement among raft nodes before linearized reading' (duration: 234.46365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:13.715299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:13.327019Z","time spent":"388.208316ms","remote":"127.0.0.1:42512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:13.725496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.620849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-02T06:50:13.725538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.505809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f3d6ab8-2032-404f-80d1-4c979cebd655\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-02T06:50:13.725574Z","caller":"traceutil/trace.go:171","msg":"trace[576449910] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1836; }","duration":"207.747347ms","start":"2026-06-02T06:50:13.517811Z","end":"2026-06-02T06:50:13.725558Z","steps":["trace[576449910] 'agreement among raft nodes before linearized reading' (duration: 207.554726ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:13.72558Z","caller":"traceutil/trace.go:171","msg":"trace[1831082137] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f3d6ab8-2032-404f-80d1-4c979cebd655; range_end:; response_count:1; response_revision:1836; }","duration":"168.578712ms","start":"2026-06-02T06:50:13.556989Z","end":"2026-06-02T06:50:13.725568Z","steps":["trace[1831082137] 'agreement among raft nodes before linearized reading' (duration: 168.441144ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:14.30045Z","caller":"traceutil/trace.go:171","msg":"trace[1571359647] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"229.711775ms","start":"2026-06-02T06:50:14.07071Z","end":"2026-06-02T06:50:14.300422Z","steps":["trace[1571359647] 'process raft request' (duration: 229.539414ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:14.338195Z","caller":"traceutil/trace.go:171","msg":"trace[1210794686] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1913; }","duration":"261.697278ms","start":"2026-06-02T06:50:14.076478Z","end":"2026-06-02T06:50:14.338176Z","steps":["trace[1210794686] 'read index received' (duration: 223.760199ms)","trace[1210794686] 'applied index is now lower than readState.Index' (duration: 37.936039ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:14.338313Z","caller":"traceutil/trace.go:171","msg":"trace[464034594] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"267.509575ms","start":"2026-06-02T06:50:14.070774Z","end":"2026-06-02T06:50:14.338283Z","steps":["trace[464034594] 'process raft request' (duration: 267.28247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:14.338458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.924712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f3d6ab8-2032-404f-80d1-4c979cebd655\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-02T06:50:14.338514Z","caller":"traceutil/trace.go:171","msg":"trace[437561936] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f3d6ab8-2032-404f-80d1-4c979cebd655; range_end:; response_count:1; response_revision:1841; }","duration":"262.071571ms","start":"2026-06-02T06:50:14.07643Z","end":"2026-06-02T06:50:14.338501Z","steps":["trace[437561936] 'agreement among raft nodes before linearized reading' (duration: 261.838676ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:26.550958Z","caller":"traceutil/trace.go:171","msg":"trace[763946121] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"199.163386ms","start":"2026-06-02T06:50:26.351765Z","end":"2026-06-02T06:50:26.550929Z","steps":["trace[763946121] 'process raft request' (duration: 198.997496ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:26.551373Z","caller":"traceutil/trace.go:171","msg":"trace[20823507] linearizableReadLoop","detail":"{readStateIndex:2026; appliedIndex:2026; }","duration":"154.195349ms","start":"2026-06-02T06:50:26.39716Z","end":"2026-06-02T06:50:26.551355Z","steps":["trace[20823507] 'read index received' (duration: 154.187508ms)","trace[20823507] 'applied index is now lower than readState.Index' (duration: 6.051µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:26.551555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.386591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-02T06:50:26.551598Z","caller":"traceutil/trace.go:171","msg":"trace[603015478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1949; }","duration":"154.488287ms","start":"2026-06-02T06:50:26.397096Z","end":"2026-06-02T06:50:26.551584Z","steps":["trace[603015478] 'agreement among raft nodes before linearized reading' (duration: 154.328117ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:48.031639Z","caller":"traceutil/trace.go:171","msg":"trace[1272925427] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"137.519677ms","start":"2026-06-02T06:50:47.894094Z","end":"2026-06-02T06:50:48.031614Z","steps":["trace[1272925427] 'process raft request' (duration: 137.285451ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:48.051769Z","caller":"traceutil/trace.go:171","msg":"trace[1373203506] linearizableReadLoop","detail":"{readStateIndex:2164; appliedIndex:2163; }","duration":"108.542502ms","start":"2026-06-02T06:50:47.943205Z","end":"2026-06-02T06:50:48.051748Z","steps":["trace[1373203506] 'read index received' (duration: 88.450553ms)","trace[1373203506] 'applied index is now lower than readState.Index' (duration: 20.091189ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:48.051954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.727075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-02T06:50:48.051984Z","caller":"traceutil/trace.go:171","msg":"trace[793877191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2082; }","duration":"108.81347ms","start":"2026-06-02T06:50:47.943163Z","end":"2026-06-02T06:50:48.051976Z","steps":["trace[793877191] 'agreement among raft nodes before linearized reading' (duration: 108.694832ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:48.052038Z","caller":"traceutil/trace.go:171","msg":"trace[1758930922] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"155.012683ms","start":"2026-06-02T06:50:47.896911Z","end":"2026-06-02T06:50:48.051924Z","steps":["trace[1758930922] 'process raft request' (duration: 142.953276ms)","trace[1758930922] 'compare' (duration: 11.757616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:48.411895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.419895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:50:48.411984Z","caller":"traceutil/trace.go:171","msg":"trace[186678700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2085; }","duration":"168.559164ms","start":"2026-06-02T06:50:48.243408Z","end":"2026-06-02T06:50:48.411967Z","steps":["trace[186678700] 'range keys from in-memory index tree' (duration: 168.336569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:48.412087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.917265ms","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-06-02T06:50:48.41219Z","caller":"traceutil/trace.go:171","msg":"trace[1185636096] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2085; }","duration":"118.060045ms","start":"2026-06-02T06:50:48.294104Z","end":"2026-06-02T06:50:48.412164Z","steps":["trace[1185636096] 'range keys from in-memory index tree' (duration: 117.746073ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:49.003004Z","caller":"traceutil/trace.go:171","msg":"trace[574236498] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"298.75806ms","start":"2026-06-02T06:50:48.704226Z","end":"2026-06-02T06:50:49.002984Z","steps":["trace[574236498] 'process raft request' (duration: 298.621741ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:49.254123Z","caller":"traceutil/trace.go:171","msg":"trace[1357888609] linearizableReadLoop","detail":"{readStateIndex:2171; appliedIndex:2168; }","duration":"296.89343ms","start":"2026-06-02T06:50:48.957207Z","end":"2026-06-02T06:50:49.254101Z","steps":["trace[1357888609] 'read index received' (duration: 45.749849ms)","trace[1357888609] 'applied index is now lower than readState.Index' (duration: 251.142271ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:49.254112Z","caller":"traceutil/trace.go:171","msg":"trace[856485930] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"395.194716ms","start":"2026-06-02T06:50:48.858848Z","end":"2026-06-02T06:50:49.254043Z","steps":["trace[856485930] 'process raft request' (duration: 303.009001ms)","trace[856485930] 'compare' (duration: 91.740794ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:49.254212Z","caller":"traceutil/trace.go:171","msg":"trace[2138600421] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"322.847187ms","start":"2026-06-02T06:50:48.931355Z","end":"2026-06-02T06:50:49.254203Z","steps":["trace[2138600421] 'process raft request' (duration: 322.561797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:49.254337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:48.931335Z","time spent":"322.913252ms","remote":"127.0.0.1:42512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:49.254554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:48.858828Z","time spent":"395.387739ms","remote":"127.0.0.1:42340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:50:49.254704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.455948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:50:49.254817Z","caller":"traceutil/trace.go:171","msg":"trace[1767069941] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2089; }","duration":"297.664822ms","start":"2026-06-02T06:50:48.957129Z","end":"2026-06-02T06:50:49.254794Z","steps":["trace[1767069941] 'agreement among raft nodes before linearized reading' (duration: 297.463518ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:49.269688Z","caller":"traceutil/trace.go:171","msg":"trace[530319458] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"173.674325ms","start":"2026-06-02T06:50:49.09599Z","end":"2026-06-02T06:50:49.269664Z","steps":["trace[530319458] 'process raft request' (duration: 173.529784ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:52.7235Z","caller":"traceutil/trace.go:171","msg":"trace[403527912] linearizableReadLoop","detail":"{readStateIndex:2634; appliedIndex:2633; }","duration":"263.99386ms","start":"2026-06-02T06:51:52.459483Z","end":"2026-06-02T06:51:52.723477Z","steps":["trace[403527912] 'read index received' (duration: 229.695873ms)","trace[403527912] 'applied index is now lower than readState.Index' (duration: 34.288297ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:51:52.72356Z","caller":"traceutil/trace.go:171","msg":"trace[782737364] transaction","detail":"{read_only:false; response_revision:2537; number_of_response:1; }","duration":"318.22105ms","start":"2026-06-02T06:51:52.405293Z","end":"2026-06-02T06:51:52.723514Z","steps":["trace[782737364] 'process raft request' (duration: 283.856567ms)","trace[782737364] 'compare' (duration: 33.905639ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:51:52.72369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.189255ms","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-06-02T06:51:52.723712Z","caller":"traceutil/trace.go:171","msg":"trace[2118728633] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2537; }","duration":"264.261949ms","start":"2026-06-02T06:51:52.459443Z","end":"2026-06-02T06:51:52.723705Z","steps":["trace[2118728633] 'agreement among raft nodes before linearized reading' (duration: 264.109858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:52.72372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:51:52.405278Z","time spent":"318.358231ms","remote":"127.0.0.1:42512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:52:25.420226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.605254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:52:25.420303Z","caller":"traceutil/trace.go:171","msg":"trace[221904099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2714; }","duration":"151.7198ms","start":"2026-06-02T06:52:25.268569Z","end":"2026-06-02T06:52:25.420289Z","steps":["trace[221904099] 'range keys from in-memory index tree' (duration: 151.528396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:52:25.420237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.790714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:52:25.420557Z","caller":"traceutil/trace.go:171","msg":"trace[276615736] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2714; }","duration":"137.131015ms","start":"2026-06-02T06:52:25.283384Z","end":"2026-06-02T06:52:25.420515Z","steps":["trace[276615736] 'count revisions from in-memory index tree' (duration: 136.690797ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:52:30.627331Z","caller":"traceutil/trace.go:171","msg":"trace[1903581287] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"236.599008ms","start":"2026-06-02T06:52:30.39071Z","end":"2026-06-02T06:52:30.627309Z","steps":["trace[1903581287] 'process raft request' (duration: 236.478801ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:52:30.628166Z","caller":"traceutil/trace.go:171","msg":"trace[1540610619] linearizableReadLoop","detail":"{readStateIndex:2846; appliedIndex:2844; }","duration":"168.668459ms","start":"2026-06-02T06:52:30.459478Z","end":"2026-06-02T06:52:30.628147Z","steps":["trace[1540610619] 'read index received' (duration: 167.717444ms)","trace[1540610619] 'applied index is now lower than readState.Index' (duration: 950.115µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:52:30.628298Z","caller":"traceutil/trace.go:171","msg":"trace[1083304329] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"236.610768ms","start":"2026-06-02T06:52:30.391678Z","end":"2026-06-02T06:52:30.628289Z","steps":["trace[1083304329] 'process raft request' (duration: 236.360714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:52:30.628501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.200829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-02T06:52:30.628536Z","caller":"traceutil/trace.go:171","msg":"trace[356833884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2741; }","duration":"103.274257ms","start":"2026-06-02T06:52:30.525254Z","end":"2026-06-02T06:52:30.628528Z","steps":["trace[356833884] 'agreement among raft nodes before linearized reading' (duration: 103.157889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:52:30.62871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.235534ms","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-06-02T06:52:30.628733Z","caller":"traceutil/trace.go:171","msg":"trace[1886935116] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2741; }","duration":"169.296443ms","start":"2026-06-02T06:52:30.459431Z","end":"2026-06-02T06:52:30.628728Z","steps":["trace[1886935116] 'agreement among raft nodes before linearized reading' (duration: 169.182396ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:16.40314Z","caller":"traceutil/trace.go:171","msg":"trace[1621023923] linearizableReadLoop","detail":"{readStateIndex:3855; appliedIndex:3854; }","duration":"100.362791ms","start":"2026-06-02T06:55:16.302758Z","end":"2026-06-02T06:55:16.403121Z","steps":["trace[1621023923] 'read index received' (duration: 100.143813ms)","trace[1621023923] 'applied index is now lower than readState.Index' (duration: 218.278µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:16.403206Z","caller":"traceutil/trace.go:171","msg":"trace[774347643] transaction","detail":"{read_only:false; response_revision:3712; number_of_response:1; }","duration":"138.930584ms","start":"2026-06-02T06:55:16.264243Z","end":"2026-06-02T06:55:16.403173Z","steps":["trace[774347643] 'process raft request' (duration: 138.733797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:55:16.403325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.546299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-02T06:55:16.403372Z","caller":"traceutil/trace.go:171","msg":"trace[1426854707] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3712; }","duration":"100.634522ms","start":"2026-06-02T06:55:16.302728Z","end":"2026-06-02T06:55:16.403363Z","steps":["trace[1426854707] 'agreement among raft nodes before linearized reading' (duration: 100.467635ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:24.871384Z","caller":"traceutil/trace.go:171","msg":"trace[1421326384] transaction","detail":"{read_only:false; response_revision:3789; number_of_response:1; }","duration":"105.088393ms","start":"2026-06-02T06:55:24.766267Z","end":"2026-06-02T06:55:24.871355Z","steps":["trace[1421326384] 'process raft request' (duration: 86.242512ms)","trace[1421326384] 'compare' (duration: 18.536849ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:25.075952Z","caller":"traceutil/trace.go:171","msg":"trace[1329937714] transaction","detail":"{read_only:false; response_revision:3794; number_of_response:1; }","duration":"116.258563ms","start":"2026-06-02T06:55:24.959666Z","end":"2026-06-02T06:55:25.075924Z","steps":["trace[1329937714] 'process raft request' (duration: 43.539543ms)","trace[1329937714] 'compare' (duration: 72.543284ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:25.087908Z","caller":"traceutil/trace.go:171","msg":"trace[1222054570] linearizableReadLoop","detail":"{readStateIndex:3944; appliedIndex:3942; }","duration":"110.974388ms","start":"2026-06-02T06:55:24.976918Z","end":"2026-06-02T06:55:25.087892Z","steps":["trace[1222054570] 'read index received' (duration: 26.36877ms)","trace[1222054570] 'applied index is now lower than readState.Index' (duration: 84.604598ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:55:25.088055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.105774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:55:25.088056Z","caller":"traceutil/trace.go:171","msg":"trace[1086684730] transaction","detail":"{read_only:false; response_revision:3795; number_of_response:1; }","duration":"119.748528ms","start":"2026-06-02T06:55:24.968211Z","end":"2026-06-02T06:55:25.087959Z","steps":["trace[1086684730] 'process raft request' (duration: 119.217496ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:25.088133Z","caller":"traceutil/trace.go:171","msg":"trace[186791779] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com; range_end:; response_count:0; response_revision:3795; }","duration":"111.225479ms","start":"2026-06-02T06:55:24.97686Z","end":"2026-06-02T06:55:25.088085Z","steps":["trace[186791779] 'agreement among raft nodes before linearized reading' (duration: 111.128105ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:25.465819Z","caller":"traceutil/trace.go:171","msg":"trace[1780557447] transaction","detail":"{read_only:false; response_revision:3801; number_of_response:1; }","duration":"113.722616ms","start":"2026-06-02T06:55:25.352071Z","end":"2026-06-02T06:55:25.465793Z","steps":["trace[1780557447] 'process raft request' (duration: 113.09211ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:25.697181Z","caller":"traceutil/trace.go:171","msg":"trace[1966285066] transaction","detail":"{read_only:false; response_revision:3804; number_of_response:1; }","duration":"130.425755ms","start":"2026-06-02T06:55:25.566732Z","end":"2026-06-02T06:55:25.697157Z","steps":["trace[1966285066] 'process raft request' (duration: 40.156532ms)","trace[1966285066] 'compare' (duration: 90.154127ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:25.69857Z","caller":"traceutil/trace.go:171","msg":"trace[2043232449] transaction","detail":"{read_only:false; response_revision:3805; number_of_response:1; }","duration":"121.311599ms","start":"2026-06-02T06:55:25.57723Z","end":"2026-06-02T06:55:25.698541Z","steps":["trace[2043232449] 'process raft request' (duration: 120.657252ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:26.209889Z","caller":"traceutil/trace.go:171","msg":"trace[202618755] transaction","detail":"{read_only:false; response_revision:3815; number_of_response:1; }","duration":"185.562884ms","start":"2026-06-02T06:55:26.024293Z","end":"2026-06-02T06:55:26.209856Z","steps":["trace[202618755] 'process raft request' (duration: 95.054426ms)","trace[202618755] 'compare' (duration: 90.052989ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:26.210366Z","caller":"traceutil/trace.go:171","msg":"trace[905118064] linearizableReadLoop","detail":"{readStateIndex:3966; appliedIndex:3963; }","duration":"161.956799ms","start":"2026-06-02T06:55:26.048385Z","end":"2026-06-02T06:55:26.210342Z","steps":["trace[905118064] 'read index received' (duration: 70.978381ms)","trace[905118064] 'applied index is now lower than readState.Index' (duration: 90.977348ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:26.210442Z","caller":"traceutil/trace.go:171","msg":"trace[2065436326] transaction","detail":"{read_only:false; response_revision:3817; number_of_response:1; }","duration":"167.56482ms","start":"2026-06-02T06:55:26.042853Z","end":"2026-06-02T06:55:26.210417Z","steps":["trace[2065436326] 'process raft request' (duration: 167.321441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:55:26.210489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.085204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/thanosrulers.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:55:26.210479Z","caller":"traceutil/trace.go:171","msg":"trace[599262794] transaction","detail":"{read_only:false; response_revision:3816; number_of_response:1; }","duration":"180.191402ms","start":"2026-06-02T06:55:26.030261Z","end":"2026-06-02T06:55:26.210452Z","steps":["trace[599262794] 'process raft request' (duration: 179.487782ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:26.210535Z","caller":"traceutil/trace.go:171","msg":"trace[665101851] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/thanosrulers.monitoring.coreos.com; range_end:; response_count:0; response_revision:3817; }","duration":"162.175988ms","start":"2026-06-02T06:55:26.048346Z","end":"2026-06-02T06:55:26.210522Z","steps":["trace[665101851] 'agreement among raft nodes before linearized reading' (duration: 162.091395ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:26.401262Z","caller":"traceutil/trace.go:171","msg":"trace[1330815108] transaction","detail":"{read_only:false; response_revision:3819; number_of_response:1; }","duration":"127.027897ms","start":"2026-06-02T06:55:26.274179Z","end":"2026-06-02T06:55:26.401207Z","steps":["trace[1330815108] 'process raft request' (duration: 76.354273ms)","trace[1330815108] 'compare' (duration: 49.999006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:05.738107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.584101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:05.738548Z","caller":"traceutil/trace.go:171","msg":"trace[1718579653] transaction","detail":"{read_only:false; response_revision:4061; number_of_response:1; }","duration":"151.064641ms","start":"2026-06-02T06:56:05.587462Z","end":"2026-06-02T06:56:05.738526Z","steps":["trace[1718579653] 'process raft request' (duration: 17.978908ms)","trace[1718579653] 'compare' (duration: 132.479455ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:05.738795Z","caller":"traceutil/trace.go:171","msg":"trace[620917385] transaction","detail":"{read_only:false; response_revision:4062; number_of_response:1; }","duration":"134.537073ms","start":"2026-06-02T06:56:05.604235Z","end":"2026-06-02T06:56:05.738772Z","steps":["trace[620917385] 'process raft request' (duration: 134.030509ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:12.314492Z","caller":"traceutil/trace.go:171","msg":"trace[780485747] transaction","detail":"{read_only:false; response_revision:4450; number_of_response:1; }","duration":"115.594409ms","start":"2026-06-02T06:56:12.19888Z","end":"2026-06-02T06:56:12.314474Z","steps":["trace[780485747] 'process raft request' (duration: 114.99916ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:15.95384Z","caller":"traceutil/trace.go:171","msg":"trace[1439616863] transaction","detail":"{read_only:false; response_revision:4585; number_of_response:1; }","duration":"119.220117ms","start":"2026-06-02T06:56:15.834593Z","end":"2026-06-02T06:56:15.953814Z","steps":["trace[1439616863] 'process raft request' (duration: 83.409543ms)","trace[1439616863] 'compare' (duration: 35.385294ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:19.216599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.489689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:19.216691Z","caller":"traceutil/trace.go:171","msg":"trace[1618527753] linearizableReadLoop","detail":"{readStateIndex:4858; appliedIndex:4857; }","duration":"181.527204ms","start":"2026-06-02T06:56:19.035143Z","end":"2026-06-02T06:56:19.21667Z","steps":["trace[1618527753] 'read index received' (duration: 62.936421ms)","trace[1618527753] 'applied index is now lower than readState.Index' (duration: 118.589953ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:19.216816Z","caller":"traceutil/trace.go:171","msg":"trace[932739745] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"185.177162ms","start":"2026-06-02T06:56:19.03156Z","end":"2026-06-02T06:56:19.216737Z","steps":["trace[932739745] 'process raft request' (duration: 66.487444ms)","trace[932739745] 'compare' (duration: 118.204964ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:19.216896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.758334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-02T06:56:19.216927Z","caller":"traceutil/trace.go:171","msg":"trace[611923824] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4676; }","duration":"181.807777ms","start":"2026-06-02T06:56:19.03511Z","end":"2026-06-02T06:56:19.216918Z","steps":["trace[611923824] 'agreement among raft nodes before linearized reading' (duration: 181.651209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:19.217006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.513529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-02T06:56:19.21708Z","caller":"traceutil/trace.go:171","msg":"trace[443989972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4676; }","duration":"119.623044ms","start":"2026-06-02T06:56:19.097439Z","end":"2026-06-02T06:56:19.217062Z","steps":["trace[443989972] 'agreement among raft nodes before linearized reading' (duration: 119.427365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:26.788114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.695025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:26.788225Z","caller":"traceutil/trace.go:171","msg":"trace[547974898] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:4786; }","duration":"396.896835ms","start":"2026-06-02T06:56:26.391304Z","end":"2026-06-02T06:56:26.788201Z","steps":["trace[547974898] 'count revisions from in-memory index tree' (duration: 396.617852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:26.788283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:26.391294Z","time spent":"396.971669ms","remote":"127.0.0.1:36114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:56:26.788121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.791769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:56:26.788499Z","caller":"traceutil/trace.go:171","msg":"trace[732936043] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:4786; }","duration":"258.203619ms","start":"2026-06-02T06:56:26.530277Z","end":"2026-06-02T06:56:26.78848Z","steps":["trace[732936043] 'count revisions from in-memory index tree' (duration: 257.737276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:26.788501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.193317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-06-02T06:56:26.788543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.077931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2c4fa58-4821-44c5-84d9-57d67cffb985\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-02T06:56:26.788591Z","caller":"traceutil/trace.go:171","msg":"trace[2092592377] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4786; }","duration":"154.343205ms","start":"2026-06-02T06:56:26.634225Z","end":"2026-06-02T06:56:26.788568Z","steps":["trace[2092592377] 'range keys from in-memory index tree' (duration: 153.967157ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:26.788619Z","caller":"traceutil/trace.go:171","msg":"trace[1492792011] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f2c4fa58-4821-44c5-84d9-57d67cffb985; range_end:; response_count:1; response_revision:4786; }","duration":"230.209258ms","start":"2026-06-02T06:56:26.558391Z","end":"2026-06-02T06:56:26.7886Z","steps":["trace[1492792011] 'range keys from in-memory index tree' (duration: 229.847899ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.050022Z","caller":"traceutil/trace.go:171","msg":"trace[329216104] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"120.129785ms","start":"2026-06-02T06:56:28.92981Z","end":"2026-06-02T06:56:29.04994Z","steps":["trace[329216104] 'process raft request' (duration: 119.84289ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:39.325663Z","caller":"traceutil/trace.go:171","msg":"trace[861228259] linearizableReadLoop","detail":"{readStateIndex:5131; appliedIndex:5130; }","duration":"358.334161ms","start":"2026-06-02T06:56:38.967303Z","end":"2026-06-02T06:56:39.325638Z","steps":["trace[861228259] 'read index received' (duration: 358.11714ms)","trace[861228259] 'applied index is now lower than readState.Index' (duration: 215.921µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:39.325784Z","caller":"traceutil/trace.go:171","msg":"trace[71983344] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"441.646259ms","start":"2026-06-02T06:56:38.884127Z","end":"2026-06-02T06:56:39.325773Z","steps":["trace[71983344] 'process raft request' (duration: 441.341274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:39.325899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:38.8841Z","time spent":"441.720012ms","remote":"127.0.0.1:42512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:39.326178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.848238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-06-02T06:56:39.326278Z","caller":"traceutil/trace.go:171","msg":"trace[369821287] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4941; }","duration":"358.987255ms","start":"2026-06-02T06:56:38.967267Z","end":"2026-06-02T06:56:39.326255Z","steps":["trace[369821287] 'agreement among raft nodes before linearized reading' (duration: 358.735352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:39.326339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:38.967252Z","time spent":"359.07454ms","remote":"127.0.0.1:42418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10414,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-02T06:56:39.340943Z","caller":"traceutil/trace.go:171","msg":"trace[1779853286] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"208.369434ms","start":"2026-06-02T06:56:39.132549Z","end":"2026-06-02T06:56:39.340918Z","steps":["trace[1779853286] 'process raft request' (duration: 208.107761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:39.341745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.985311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-06-02T06:56:39.341794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.380445ms","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-06-02T06:56:39.341861Z","caller":"traceutil/trace.go:171","msg":"trace[1289329315] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4942; }","duration":"316.070866ms","start":"2026-06-02T06:56:39.025731Z","end":"2026-06-02T06:56:39.341802Z","steps":["trace[1289329315] 'agreement among raft nodes before linearized reading' (duration: 315.139978ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:39.341858Z","caller":"traceutil/trace.go:171","msg":"trace[1389983786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4942; }","duration":"199.49978ms","start":"2026-06-02T06:56:39.142345Z","end":"2026-06-02T06:56:39.341845Z","steps":["trace[1389983786] 'agreement among raft nodes before linearized reading' (duration: 198.644807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:39.341948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:39.02569Z","time spent":"316.214704ms","remote":"127.0.0.1:42388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-02T06:56:39.451175Z","caller":"traceutil/trace.go:171","msg":"trace[380634013] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"105.093009ms","start":"2026-06-02T06:56:39.346049Z","end":"2026-06-02T06:56:39.451142Z","steps":["trace[380634013] 'process raft request' (duration: 104.839985ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:53.708357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-06-02T06:57:53.776739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"67.034387ms","hash":848813777,"current-db-size-bytes":51650560,"current-db-size":"52 MB","current-db-size-in-use-bytes":27672576,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-02T06:57:53.776855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":848813777,"revision":2865,"compact-revision":-1}