{"level":"warn","ts":"2026-04-20T08:05:21.981351Z","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-20T08:05:21.98146Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.176: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.176:2380","--initial-cluster=instance=https://199.19.213.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.176: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-20T08:05:21.981537Z","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-20T08:05:21.981545Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.176:2380"]} {"level":"info","ts":"2026-04-20T08:05:21.981565Z","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-20T08:05:21.982266Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"]} {"level":"info","ts":"2026-04-20T08:05:21.982338Z","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.176:2380"],"listen-peer-urls":["https://199.19.213.176:2380"],"advertise-client-urls":["https://199.19.213.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.176: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-20T08:05:21.986152Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.565853ms"} {"level":"info","ts":"2026-04-20T08:05:21.993863Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e120e57916b9bd4","cluster-id":"e644555f29703ff6"} {"level":"info","ts":"2026-04-20T08:05:21.994035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T08:05:21.994058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became follower at term 0"} {"level":"info","ts":"2026-04-20T08:05:21.994072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e120e57916b9bd4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T08:05:21.994081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became follower at term 1"} {"level":"info","ts":"2026-04-20T08:05:21.994124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=(7931417663017556948)"} {"level":"warn","ts":"2026-04-20T08:05:22.003268Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T08:05:22.005921Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T08:05:22.007164Z","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-20T08:05:22.010031Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e120e57916b9bd4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T08:05:22.010292Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e120e57916b9bd4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T08:05:22.010562Z","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-20T08:05:22.011069Z","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-20T08:05:22.011089Z","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-20T08:05:22.011697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=(7931417663017556948)"} {"level":"info","ts":"2026-04-20T08:05:22.012115Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e644555f29703ff6","local-member-id":"6e120e57916b9bd4","added-peer-id":"6e120e57916b9bd4","added-peer-peer-urls":["https://199.19.213.176:2380"]} {"level":"info","ts":"2026-04-20T08:05:22.015451Z","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-20T08:05:22.015613Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.176:2380"} {"level":"info","ts":"2026-04-20T08:05:22.015646Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.176:2380"} {"level":"info","ts":"2026-04-20T08:05:22.015733Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e120e57916b9bd4","initial-advertise-peer-urls":["https://199.19.213.176:2380"],"listen-peer-urls":["https://199.19.213.176:2380"],"advertise-client-urls":["https://199.19.213.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T08:05:22.015767Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T08:05:22.294917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T08:05:22.294983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T08:05:22.295028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 received MsgPreVoteResp from 6e120e57916b9bd4 at term 1"} {"level":"info","ts":"2026-04-20T08:05:22.295049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became candidate at term 2"} {"level":"info","ts":"2026-04-20T08:05:22.295061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 received MsgVoteResp from 6e120e57916b9bd4 at term 2"} {"level":"info","ts":"2026-04-20T08:05:22.295084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became leader at term 2"} {"level":"info","ts":"2026-04-20T08:05:22.295128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e120e57916b9bd4 elected leader 6e120e57916b9bd4 at term 2"} {"level":"info","ts":"2026-04-20T08:05:22.29624Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:22.296891Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e120e57916b9bd4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.176:2379]}","request-path":"/0/members/6e120e57916b9bd4/attributes","cluster-id":"e644555f29703ff6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T08:05:22.297113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:05:22.297172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:05:22.29754Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e644555f29703ff6","local-member-id":"6e120e57916b9bd4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:22.297785Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:22.297836Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:22.301047Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.176:2379"} {"level":"info","ts":"2026-04-20T08:05:22.301296Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T08:05:22.303242Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T08:05:22.303275Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T08:05:36.450867Z","caller":"traceutil/trace.go:171","msg":"trace[930701514] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"207.012058ms","start":"2026-04-20T08:05:36.243467Z","end":"2026-04-20T08:05:36.450479Z","steps":["trace[930701514] 'process raft request' (duration: 206.836602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:38.888616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.191404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-20T08:05:38.888718Z","caller":"traceutil/trace.go:171","msg":"trace[483131432] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:374; }","duration":"321.286398ms","start":"2026-04-20T08:05:38.567409Z","end":"2026-04-20T08:05:38.888696Z","steps":["trace[483131432] 'range keys from in-memory index tree' (duration: 320.879704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:38.888774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:38.567337Z","time spent":"321.427233ms","remote":"127.0.0.1:57052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7326,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-04-20T08:05:38.888509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.783535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-04-20T08:05:38.889029Z","caller":"traceutil/trace.go:171","msg":"trace[1343840520] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:374; }","duration":"316.288372ms","start":"2026-04-20T08:05:38.572638Z","end":"2026-04-20T08:05:38.888927Z","steps":["trace[1343840520] 'range keys from in-memory index tree' (duration: 315.680022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:38.888495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.699353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:05:38.8892Z","caller":"traceutil/trace.go:171","msg":"trace[235176061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:374; }","duration":"168.49917ms","start":"2026-04-20T08:05:38.720686Z","end":"2026-04-20T08:05:38.889185Z","steps":["trace[235176061] 'range keys from in-memory index tree' (duration: 167.483255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:38.889255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:38.572619Z","time spent":"316.582721ms","remote":"127.0.0.1:57050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4398,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-20T08:05:59.553871Z","caller":"traceutil/trace.go:171","msg":"trace[1649675534] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"242.575137ms","start":"2026-04-20T08:05:59.311259Z","end":"2026-04-20T08:05:59.553834Z","steps":["trace[1649675534] 'process raft request' (duration: 242.326561ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:05:59.851038Z","caller":"traceutil/trace.go:171","msg":"trace[1782261410] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"130.5121ms","start":"2026-04-20T08:05:59.720491Z","end":"2026-04-20T08:05:59.851003Z","steps":["trace[1782261410] 'read index received' (duration: 129.555825ms)","trace[1782261410] 'applied index is now lower than readState.Index' (duration: 955.155µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:05:59.851141Z","caller":"traceutil/trace.go:171","msg":"trace[620479152] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"538.580583ms","start":"2026-04-20T08:05:59.312514Z","end":"2026-04-20T08:05:59.851095Z","steps":["trace[620479152] 'process raft request' (duration: 537.789032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:59.851188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.673004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:05:59.851249Z","caller":"traceutil/trace.go:171","msg":"trace[1732848399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"130.805499ms","start":"2026-04-20T08:05:59.720427Z","end":"2026-04-20T08:05:59.851233Z","steps":["trace[1732848399] 'agreement among raft nodes before linearized reading' (duration: 130.694286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:59.851875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:59.312473Z","time spent":"538.774458ms","remote":"127.0.0.1:56948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:06:00.825013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.310858ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:06:00.825113Z","caller":"traceutil/trace.go:171","msg":"trace[889827752] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"752.913992ms","start":"2026-04-20T08:06:00.072182Z","end":"2026-04-20T08:06:00.825096Z","steps":["trace[889827752] 'read index received' (duration: 376.317197ms)","trace[889827752] 'applied index is now lower than readState.Index' (duration: 376.595835ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:06:00.825255Z","caller":"traceutil/trace.go:171","msg":"trace[978144838] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"912.340228ms","start":"2026-04-20T08:05:59.912906Z","end":"2026-04-20T08:06:00.825246Z","steps":["trace[978144838] 'process raft request' (duration: 535.61386ms)","trace[978144838] 'compare' (duration: 376.136863ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:06:00.825297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:59.912873Z","time spent":"912.40797ms","remote":"127.0.0.1:57226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T08:06:00.825521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.337283ms","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-04-20T08:06:00.825546Z","caller":"traceutil/trace.go:171","msg":"trace[301599969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"753.403335ms","start":"2026-04-20T08:06:00.072135Z","end":"2026-04-20T08:06:00.825539Z","steps":["trace[301599969] 'agreement among raft nodes before linearized reading' (duration: 753.251361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.825566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:06:00.072113Z","time spent":"753.448737ms","remote":"127.0.0.1:57116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T08:06:00.825728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.807054ms","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-20T08:06:00.82575Z","caller":"traceutil/trace.go:171","msg":"trace[1409435269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"748.855845ms","start":"2026-04-20T08:06:00.076889Z","end":"2026-04-20T08:06:00.825744Z","steps":["trace[1409435269] 'agreement among raft nodes before linearized reading' (duration: 748.795993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.825804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:06:00.076874Z","time spent":"748.926407ms","remote":"127.0.0.1:57116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T08:06:00.825829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.4553ms","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-20T08:06:00.827167Z","caller":"traceutil/trace.go:171","msg":"trace[1077515715] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"106.538282ms","start":"2026-04-20T08:06:00.719326Z","end":"2026-04-20T08:06:00.825864Z","steps":["trace[1077515715] 'agreement among raft nodes before linearized reading' (duration: 106.410528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.827206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.697162ms","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-20T08:06:00.827381Z","caller":"traceutil/trace.go:171","msg":"trace[1767931741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"147.846676ms","start":"2026-04-20T08:06:00.67947Z","end":"2026-04-20T08:06:00.827316Z","steps":["trace[1767931741] 'agreement among raft nodes before linearized reading' (duration: 146.410898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.827406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.723342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.827593Z","caller":"traceutil/trace.go:171","msg":"trace[1120711374] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"207.946697ms","start":"2026-04-20T08:06:00.619566Z","end":"2026-04-20T08:06:00.827513Z","steps":["trace[1120711374] 'agreement among raft nodes before linearized reading' (duration: 206.330835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.828292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.348222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.828352Z","caller":"traceutil/trace.go:171","msg":"trace[645384037] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"156.437214ms","start":"2026-04-20T08:06:00.671889Z","end":"2026-04-20T08:06:00.828326Z","steps":["trace[645384037] 'agreement among raft nodes before linearized reading' (duration: 156.353262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.828494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.399193ms","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-20T08:06:00.828685Z","caller":"traceutil/trace.go:171","msg":"trace[1414899424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"156.643729ms","start":"2026-04-20T08:06:00.671892Z","end":"2026-04-20T08:06:00.828536Z","steps":["trace[1414899424] 'agreement among raft nodes before linearized reading' (duration: 156.348152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.828672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.518875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.828885Z","caller":"traceutil/trace.go:171","msg":"trace[323733385] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"108.73803ms","start":"2026-04-20T08:06:00.720127Z","end":"2026-04-20T08:06:00.828865Z","steps":["trace[323733385] 'agreement among raft nodes before linearized reading' (duration: 108.407591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.829245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.85796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.829301Z","caller":"traceutil/trace.go:171","msg":"trace[1513688482] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"109.937422ms","start":"2026-04-20T08:06:00.71935Z","end":"2026-04-20T08:06:00.829288Z","steps":["trace[1513688482] 'agreement among raft nodes before linearized reading' (duration: 109.85124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.829389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.306604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.829524Z","caller":"traceutil/trace.go:171","msg":"trace[679455057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"209.445027ms","start":"2026-04-20T08:06:00.620026Z","end":"2026-04-20T08:06:00.829471Z","steps":["trace[679455057] 'agreement among raft nodes before linearized reading' (duration: 209.240222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.829936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.187547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.829987Z","caller":"traceutil/trace.go:171","msg":"trace[716402819] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"210.242158ms","start":"2026-04-20T08:06:00.61972Z","end":"2026-04-20T08:06:00.829963Z","steps":["trace[716402819] 'agreement among raft nodes before linearized reading' (duration: 210.176637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.830167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.91319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:06:00.830375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.269502ms","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-20T08:06:00.830403Z","caller":"traceutil/trace.go:171","msg":"trace[593129690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"753.347314ms","start":"2026-04-20T08:06:00.077048Z","end":"2026-04-20T08:06:00.830396Z","steps":["trace[593129690] 'agreement among raft nodes before linearized reading' (duration: 753.137028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:00.830427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:06:00.077019Z","time spent":"753.402075ms","remote":"127.0.0.1:57116","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-20T08:06:00.831952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.594552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:00.832119Z","caller":"traceutil/trace.go:171","msg":"trace[1722882138] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"243.694245ms","start":"2026-04-20T08:06:00.588307Z","end":"2026-04-20T08:06:00.832001Z","steps":["trace[1722882138] 'agreement among raft nodes before linearized reading' (duration: 243.541201ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:06:00.830283Z","caller":"traceutil/trace.go:171","msg":"trace[330214197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"244.050514ms","start":"2026-04-20T08:06:00.586158Z","end":"2026-04-20T08:06:00.830209Z","steps":["trace[330214197] 'agreement among raft nodes before linearized reading' (duration: 243.743606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:17.16005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.058329ms","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-20T08:06:17.16017Z","caller":"traceutil/trace.go:171","msg":"trace[659341421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:748; }","duration":"221.267663ms","start":"2026-04-20T08:06:16.938873Z","end":"2026-04-20T08:06:17.16014Z","steps":["trace[659341421] 'range keys from in-memory index tree' (duration: 220.508747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:17.160422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.161691ms","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-20T08:06:17.160509Z","caller":"traceutil/trace.go:171","msg":"trace[872098990] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:748; }","duration":"193.251672ms","start":"2026-04-20T08:06:16.967224Z","end":"2026-04-20T08:06:17.160476Z","steps":["trace[872098990] 'range keys from in-memory index tree' (duration: 193.017847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:17.160612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.695273ms","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-20T08:06:17.160735Z","caller":"traceutil/trace.go:171","msg":"trace[1873698027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"200.871427ms","start":"2026-04-20T08:06:16.959836Z","end":"2026-04-20T08:06:17.160707Z","steps":["trace[1873698027] 'range keys from in-memory index tree' (duration: 200.521429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:17.160696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.190287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:06:17.160991Z","caller":"traceutil/trace.go:171","msg":"trace[322609101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:748; }","duration":"441.526725ms","start":"2026-04-20T08:06:16.719441Z","end":"2026-04-20T08:06:17.160936Z","steps":["trace[322609101] 'range keys from in-memory index tree' (duration: 441.030484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:17.161124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:06:16.719417Z","time spent":"441.686609ms","remote":"127.0.0.1:56856","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-20T08:06:17.160724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.704213ms","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-20T08:06:17.161368Z","caller":"traceutil/trace.go:171","msg":"trace[335870833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:748; }","duration":"201.560513ms","start":"2026-04-20T08:06:16.959785Z","end":"2026-04-20T08:06:17.161346Z","steps":["trace[335870833] 'range keys from in-memory index tree' (duration: 200.372366ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:06:46.66199Z","caller":"traceutil/trace.go:171","msg":"trace[966563101] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"219.940766ms","start":"2026-04-20T08:06:46.442015Z","end":"2026-04-20T08:06:46.661955Z","steps":["trace[966563101] 'process raft request' (duration: 219.732072ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:09.952325Z","caller":"traceutil/trace.go:171","msg":"trace[1073091343] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"205.677498ms","start":"2026-04-20T08:07:09.746608Z","end":"2026-04-20T08:07:09.952286Z","steps":["trace[1073091343] 'process raft request' (duration: 205.449654ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:33.749763Z","caller":"traceutil/trace.go:171","msg":"trace[1994906049] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"130.70459ms","start":"2026-04-20T08:07:33.619021Z","end":"2026-04-20T08:07:33.749726Z","steps":["trace[1994906049] 'process raft request' (duration: 130.410586ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:33.876202Z","caller":"traceutil/trace.go:171","msg":"trace[609639695] linearizableReadLoop","detail":"{readStateIndex:1876; appliedIndex:1874; }","duration":"165.802083ms","start":"2026-04-20T08:07:33.710359Z","end":"2026-04-20T08:07:33.876161Z","steps":["trace[609639695] 'read index received' (duration: 39.07257ms)","trace[609639695] 'applied index is now lower than readState.Index' (duration: 126.727443ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:07:33.876306Z","caller":"traceutil/trace.go:171","msg":"trace[311235290] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"255.315343ms","start":"2026-04-20T08:07:33.620962Z","end":"2026-04-20T08:07:33.876278Z","steps":["trace[311235290] 'process raft request' (duration: 254.984838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:33.876513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.125767ms","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-20T08:07:33.876644Z","caller":"traceutil/trace.go:171","msg":"trace[1147223652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1805; }","duration":"166.331971ms","start":"2026-04-20T08:07:33.710292Z","end":"2026-04-20T08:07:33.876624Z","steps":["trace[1147223652] 'agreement among raft nodes before linearized reading' (duration: 166.021776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:33.876681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.627078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T08:07:33.876944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.121552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-179fdbf4-6b46-45cf-b25b-2f1e59c8d6bf\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-20T08:07:33.876993Z","caller":"traceutil/trace.go:171","msg":"trace[1314041205] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-179fdbf4-6b46-45cf-b25b-2f1e59c8d6bf; range_end:; response_count:1; response_revision:1805; }","duration":"113.198674ms","start":"2026-04-20T08:07:33.763781Z","end":"2026-04-20T08:07:33.87698Z","steps":["trace[1314041205] 'agreement among raft nodes before linearized reading' (duration: 113.077962ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:33.877036Z","caller":"traceutil/trace.go:171","msg":"trace[150406468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1805; }","duration":"162.827472ms","start":"2026-04-20T08:07:33.713942Z","end":"2026-04-20T08:07:33.876769Z","steps":["trace[150406468] 'agreement among raft nodes before linearized reading' (duration: 162.432596ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:34.05637Z","caller":"traceutil/trace.go:171","msg":"trace[1403911550] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"173.140053ms","start":"2026-04-20T08:07:33.883183Z","end":"2026-04-20T08:07:34.056323Z","steps":["trace[1403911550] 'process raft request' (duration: 165.265173ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:34.056566Z","caller":"traceutil/trace.go:171","msg":"trace[1520237143] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"170.622868ms","start":"2026-04-20T08:07:33.885896Z","end":"2026-04-20T08:07:34.056519Z","steps":["trace[1520237143] 'process raft request' (duration: 170.313344ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:08:03.452175Z","caller":"traceutil/trace.go:171","msg":"trace[1285761679] linearizableReadLoop","detail":"{readStateIndex:2102; appliedIndex:2101; }","duration":"127.538856ms","start":"2026-04-20T08:08:03.324614Z","end":"2026-04-20T08:08:03.452153Z","steps":["trace[1285761679] 'read index received' (duration: 127.441464ms)","trace[1285761679] 'applied index is now lower than readState.Index' (duration: 96.432µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:08:03.452216Z","caller":"traceutil/trace.go:171","msg":"trace[202399283] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"153.835918ms","start":"2026-04-20T08:08:03.298362Z","end":"2026-04-20T08:08:03.452198Z","steps":["trace[202399283] 'process raft request' (duration: 153.613745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:08:03.452456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.812179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-20T08:08:03.452489Z","caller":"traceutil/trace.go:171","msg":"trace[374925079] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2024; }","duration":"127.928121ms","start":"2026-04-20T08:08:03.32455Z","end":"2026-04-20T08:08:03.452478Z","steps":["trace[374925079] 'agreement among raft nodes before linearized reading' (duration: 127.698768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:08:04.431235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.381364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:08:04.431713Z","caller":"traceutil/trace.go:171","msg":"trace[920002607] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"229.425708ms","start":"2026-04-20T08:08:04.202262Z","end":"2026-04-20T08:08:04.431688Z","steps":["trace[920002607] 'process raft request' (duration: 229.110024ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:08:04.431809Z","caller":"traceutil/trace.go:171","msg":"trace[600147395] linearizableReadLoop","detail":"{readStateIndex:2105; appliedIndex:2104; }","duration":"307.430813ms","start":"2026-04-20T08:08:04.124297Z","end":"2026-04-20T08:08:04.431728Z","steps":["trace[600147395] 'read index received' (duration: 105.457992ms)","trace[600147395] 'applied index is now lower than readState.Index' (duration: 201.964761ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:08:04.432014Z","caller":"traceutil/trace.go:171","msg":"trace[467916956] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"320.60589ms","start":"2026-04-20T08:08:04.111389Z","end":"2026-04-20T08:08:04.431995Z","steps":["trace[467916956] 'process raft request' (duration: 118.342455ms)","trace[467916956] 'compare' (duration: 200.953389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:08:04.432164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:08:04.111354Z","time spent":"320.696421ms","remote":"127.0.0.1:57116","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-20T08:08:04.432216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.91578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-20T08:08:04.432231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.595839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T08:08:04.432271Z","caller":"traceutil/trace.go:171","msg":"trace[1980362366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2028; }","duration":"307.99925ms","start":"2026-04-20T08:08:04.124255Z","end":"2026-04-20T08:08:04.432254Z","steps":["trace[1980362366] 'agreement among raft nodes before linearized reading' (duration: 307.843089ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:08:04.432361Z","caller":"traceutil/trace.go:171","msg":"trace[581014919] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2028; }","duration":"198.785781ms","start":"2026-04-20T08:08:04.233553Z","end":"2026-04-20T08:08:04.432339Z","steps":["trace[581014919] 'agreement among raft nodes before linearized reading' (duration: 198.596838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:08:04.432495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:08:04.124237Z","time spent":"308.190873ms","remote":"127.0.0.1:57116","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-20T08:08:04.432252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.53555ms","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-04-20T08:08:04.432619Z","caller":"traceutil/trace.go:171","msg":"trace[1707763899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2028; }","duration":"195.923795ms","start":"2026-04-20T08:08:04.236678Z","end":"2026-04-20T08:08:04.432602Z","steps":["trace[1707763899] 'agreement among raft nodes before linearized reading' (duration: 195.422669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:08:04.837958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.673867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:08:04.838072Z","caller":"traceutil/trace.go:171","msg":"trace[960200461] linearizableReadLoop","detail":"{readStateIndex:2108; appliedIndex:2107; }","duration":"119.737422ms","start":"2026-04-20T08:08:04.718314Z","end":"2026-04-20T08:08:04.838051Z","steps":["trace[960200461] 'read index received' (duration: 80.741µs)","trace[960200461] 'applied index is now lower than readState.Index' (duration: 119.655461ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:08:04.838125Z","caller":"traceutil/trace.go:171","msg":"trace[1604742862] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"399.11953ms","start":"2026-04-20T08:08:04.438964Z","end":"2026-04-20T08:08:04.838083Z","steps":["trace[1604742862] 'process raft request' (duration: 254.22999ms)","trace[1604742862] 'compare' (duration: 144.547186ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:08:04.838249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.935494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:08:04.838281Z","caller":"traceutil/trace.go:171","msg":"trace[974406689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2030; }","duration":"120.004896ms","start":"2026-04-20T08:08:04.718267Z","end":"2026-04-20T08:08:04.838271Z","steps":["trace[974406689] 'agreement among raft nodes before linearized reading' (duration: 119.873234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:08:04.838353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:08:04.438939Z","time spent":"399.311443ms","remote":"127.0.0.1:57116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:08:04.838572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.58713ms","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-20T08:08:04.838603Z","caller":"traceutil/trace.go:171","msg":"trace[162372311] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2030; }","duration":"119.649541ms","start":"2026-04-20T08:08:04.718944Z","end":"2026-04-20T08:08:04.838594Z","steps":["trace[162372311] 'agreement among raft nodes before linearized reading' (duration: 119.503449ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:09:14.140117Z","caller":"traceutil/trace.go:171","msg":"trace[531983637] transaction","detail":"{read_only:false; response_revision:2503; number_of_response:1; }","duration":"294.112567ms","start":"2026-04-20T08:09:13.845973Z","end":"2026-04-20T08:09:14.140086Z","steps":["trace[531983637] 'process raft request' (duration: 293.840274ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:09:46.148893Z","caller":"traceutil/trace.go:171","msg":"trace[1231122241] transaction","detail":"{read_only:false; response_revision:2679; number_of_response:1; }","duration":"250.917772ms","start":"2026-04-20T08:09:45.897952Z","end":"2026-04-20T08:09:46.14887Z","steps":["trace[1231122241] 'process raft request' (duration: 250.792838ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:09:51.306913Z","caller":"traceutil/trace.go:171","msg":"trace[91186240] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"128.125693ms","start":"2026-04-20T08:09:51.178729Z","end":"2026-04-20T08:09:51.306855Z","steps":["trace[91186240] 'process raft request' (duration: 127.514063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:06.059858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.346455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-66d7363e-e2f5-4fd9-b069-e123b61f85a4\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-04-20T08:14:06.05996Z","caller":"traceutil/trace.go:171","msg":"trace[1912816146] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-66d7363e-e2f5-4fd9-b069-e123b61f85a4; range_end:; response_count:1; response_revision:4656; }","duration":"170.514888ms","start":"2026-04-20T08:14:05.889428Z","end":"2026-04-20T08:14:06.059943Z","steps":["trace[1912816146] 'range keys from in-memory index tree' (duration: 169.951249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:06.060098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.309466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-20T08:14:06.06013Z","caller":"traceutil/trace.go:171","msg":"trace[1473888792] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4656; }","duration":"274.362967ms","start":"2026-04-20T08:14:05.785757Z","end":"2026-04-20T08:14:06.06012Z","steps":["trace[1473888792] 'range keys from in-memory index tree' (duration: 274.219985ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.06066Z","caller":"traceutil/trace.go:171","msg":"trace[933340625] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"104.789162ms","start":"2026-04-20T08:14:05.955853Z","end":"2026-04-20T08:14:06.060642Z","steps":["trace[933340625] 'process raft request' (duration: 64.542887ms)","trace[933340625] 'compare' (duration: 39.30364ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:14.418248Z","caller":"traceutil/trace.go:171","msg":"trace[17478647] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"401.468872ms","start":"2026-04-20T08:14:14.016746Z","end":"2026-04-20T08:14:14.418215Z","steps":["trace[17478647] 'process raft request' (duration: 401.126786ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:14.418316Z","caller":"traceutil/trace.go:171","msg":"trace[1228929303] linearizableReadLoop","detail":"{readStateIndex:4997; appliedIndex:4992; }","duration":"399.687713ms","start":"2026-04-20T08:14:14.018615Z","end":"2026-04-20T08:14:14.418303Z","steps":["trace[1228929303] 'read index received' (duration: 3.77313ms)","trace[1228929303] 'applied index is now lower than readState.Index' (duration: 395.913643ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:14.418383Z","caller":"traceutil/trace.go:171","msg":"trace[2058308334] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"400.599807ms","start":"2026-04-20T08:14:14.017776Z","end":"2026-04-20T08:14:14.418376Z","steps":["trace[2058308334] 'process raft request' (duration: 400.381474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.418432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.016723Z","time spent":"401.627614ms","remote":"127.0.0.1:56964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1351,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T08:14:14.418473Z","caller":"traceutil/trace.go:171","msg":"trace[1685288071] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"400.358204ms","start":"2026-04-20T08:14:14.018109Z","end":"2026-04-20T08:14:14.418467Z","steps":["trace[1685288071] 'process raft request' (duration: 400.12592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.418509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.018101Z","time spent":"400.385784ms","remote":"127.0.0.1:57042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:14:14.418795Z","caller":"traceutil/trace.go:171","msg":"trace[1677291434] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"399.618452ms","start":"2026-04-20T08:14:14.019166Z","end":"2026-04-20T08:14:14.418785Z","steps":["trace[1677291434] 'process raft request' (duration: 399.097033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.418447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.01777Z","time spent":"400.628087ms","remote":"127.0.0.1:57128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1392,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:14.418844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.01914Z","time spent":"399.681752ms","remote":"127.0.0.1:57128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:14.418976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.351043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-86649c56f7-fpgjs\" ","response":"range_response_count:1 size:11257"} {"level":"info","ts":"2026-04-20T08:14:14.419025Z","caller":"traceutil/trace.go:171","msg":"trace[1937833841] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-86649c56f7-fpgjs; range_end:; response_count:1; response_revision:4814; }","duration":"400.424014ms","start":"2026-04-20T08:14:14.018589Z","end":"2026-04-20T08:14:14.419013Z","steps":["trace[1937833841] 'agreement among raft nodes before linearized reading' (duration: 400.249621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.419081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.018582Z","time spent":"400.491645ms","remote":"127.0.0.1:57052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":11280,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-86649c56f7-fpgjs\" "} {"level":"info","ts":"2026-04-20T08:14:14.419857Z","caller":"traceutil/trace.go:171","msg":"trace[95351394] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"402.580428ms","start":"2026-04-20T08:14:14.016889Z","end":"2026-04-20T08:14:14.41947Z","steps":["trace[95351394] 'process raft request' (duration: 401.142226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.420299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.016884Z","time spent":"403.096387ms","remote":"127.0.0.1:57042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1272,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:14:14.666146Z","caller":"traceutil/trace.go:171","msg":"trace[1342396828] linearizableReadLoop","detail":"{readStateIndex:5000; appliedIndex:4998; }","duration":"247.768267ms","start":"2026-04-20T08:14:14.418348Z","end":"2026-04-20T08:14:14.666116Z","steps":["trace[1342396828] 'read index received' (duration: 225.034196ms)","trace[1342396828] 'applied index is now lower than readState.Index' (duration: 22.732491ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:14.666523Z","caller":"traceutil/trace.go:171","msg":"trace[338882716] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"507.12486ms","start":"2026-04-20T08:14:14.159347Z","end":"2026-04-20T08:14:14.666472Z","steps":["trace[338882716] 'process raft request' (duration: 506.707113ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:14.66674Z","caller":"traceutil/trace.go:171","msg":"trace[131172808] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"560.159033ms","start":"2026-04-20T08:14:14.106565Z","end":"2026-04-20T08:14:14.666725Z","steps":["trace[131172808] 'process raft request' (duration: 536.801622ms)","trace[131172808] 'compare' (duration: 21.99787ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:14.666833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.159329Z","time spent":"507.357853ms","remote":"127.0.0.1:57116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:14.666858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.106533Z","time spent":"560.241155ms","remote":"127.0.0.1:57116","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-20T08:14:14.666915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.768514ms","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-20T08:14:14.666951Z","caller":"traceutil/trace.go:171","msg":"trace[1179940609] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4816; }","duration":"645.866955ms","start":"2026-04-20T08:14:14.021069Z","end":"2026-04-20T08:14:14.666936Z","steps":["trace[1179940609] 'agreement among raft nodes before linearized reading' (duration: 645.159114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.666971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.02106Z","time spent":"645.906876ms","remote":"127.0.0.1:56948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1154,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"warn","ts":"2026-04-20T08:14:14.667183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.871393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-20T08:14:14.667202Z","caller":"traceutil/trace.go:171","msg":"trace[1558116340] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4816; }","duration":"514.936455ms","start":"2026-04-20T08:14:14.152259Z","end":"2026-04-20T08:14:14.667196Z","steps":["trace[1558116340] 'agreement among raft nodes before linearized reading' (duration: 514.839563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.66724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.152233Z","time spent":"514.996625ms","remote":"127.0.0.1:57116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T08:14:14.667775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.091453ms","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-20T08:14:14.66784Z","caller":"traceutil/trace.go:171","msg":"trace[115290275] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4816; }","duration":"287.231154ms","start":"2026-04-20T08:14:14.380592Z","end":"2026-04-20T08:14:14.667823Z","steps":["trace[115290275] 'agreement among raft nodes before linearized reading' (duration: 286.9558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.667886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.41986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2348486"} {"level":"info","ts":"2026-04-20T08:14:14.667923Z","caller":"traceutil/trace.go:171","msg":"trace[1812966088] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4816; }","duration":"384.504132ms","start":"2026-04-20T08:14:14.283409Z","end":"2026-04-20T08:14:14.667913Z","steps":["trace[1812966088] 'agreement among raft nodes before linearized reading' (duration: 383.576047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:14.667946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:14.283387Z","time spent":"384.552242ms","remote":"127.0.0.1:56964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2348509,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-04-20T08:14:14.684908Z","caller":"traceutil/trace.go:171","msg":"trace[861438813] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"211.808777ms","start":"2026-04-20T08:14:14.473072Z","end":"2026-04-20T08:14:14.684881Z","steps":["trace[861438813] 'process raft request' (duration: 211.739376ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:14.685033Z","caller":"traceutil/trace.go:171","msg":"trace[1043099676] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"253.346317ms","start":"2026-04-20T08:14:14.431653Z","end":"2026-04-20T08:14:14.684999Z","steps":["trace[1043099676] 'process raft request' (duration: 253.081192ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:14.684923Z","caller":"traceutil/trace.go:171","msg":"trace[231610483] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"259.096448ms","start":"2026-04-20T08:14:14.425808Z","end":"2026-04-20T08:14:14.684905Z","steps":["trace[231610483] 'process raft request' (duration: 258.826424ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:14.684971Z","caller":"traceutil/trace.go:171","msg":"trace[445869724] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"259.519245ms","start":"2026-04-20T08:14:14.425444Z","end":"2026-04-20T08:14:14.684963Z","steps":["trace[445869724] 'process raft request' (duration: 259.052068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.058107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.957034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:14:15.058247Z","caller":"traceutil/trace.go:171","msg":"trace[1199972925] linearizableReadLoop","detail":"{readStateIndex:5014; appliedIndex:5013; }","duration":"208.29246ms","start":"2026-04-20T08:14:14.849933Z","end":"2026-04-20T08:14:15.058225Z","steps":["trace[1199972925] 'read index received' (duration: 107.186994ms)","trace[1199972925] 'applied index is now lower than readState.Index' (duration: 101.103646ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:15.058785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.736436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-20T08:14:15.05892Z","caller":"traceutil/trace.go:171","msg":"trace[885764978] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4830; }","duration":"208.923089ms","start":"2026-04-20T08:14:14.849967Z","end":"2026-04-20T08:14:15.05889Z","steps":["trace[885764978] 'agreement among raft nodes before linearized reading' (duration: 208.570833ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.058978Z","caller":"traceutil/trace.go:171","msg":"trace[1240554882] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"209.684611ms","start":"2026-04-20T08:14:14.849212Z","end":"2026-04-20T08:14:15.058896Z","steps":["trace[1240554882] 'process raft request' (duration: 107.826743ms)","trace[1240554882] 'compare' (duration: 100.624879ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:15.059284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.979862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-20T08:14:15.059345Z","caller":"traceutil/trace.go:171","msg":"trace[2071928133] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4830; }","duration":"206.058804ms","start":"2026-04-20T08:14:14.853271Z","end":"2026-04-20T08:14:15.05933Z","steps":["trace[2071928133] 'agreement among raft nodes before linearized reading' (duration: 205.907962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.059436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.468878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/rabbitmq-keystone-peer-discovery\" ","response":"range_response_count:1 size:814"} {"level":"info","ts":"2026-04-20T08:14:15.05953Z","caller":"traceutil/trace.go:171","msg":"trace[1550965329] range","detail":"{range_begin:/registry/roles/openstack/rabbitmq-keystone-peer-discovery; range_end:; response_count:1; response_revision:4830; }","duration":"209.60587ms","start":"2026-04-20T08:14:14.849903Z","end":"2026-04-20T08:14:15.059508Z","steps":["trace[1550965329] 'agreement among raft nodes before linearized reading' (duration: 209.386156ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.180377Z","caller":"traceutil/trace.go:171","msg":"trace[1630522152] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"103.709846ms","start":"2026-04-20T08:14:15.076623Z","end":"2026-04-20T08:14:15.180333Z","steps":["trace[1630522152] 'process raft request' (duration: 81.657637ms)","trace[1630522152] 'compare' (duration: 21.753225ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:15.180591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.26404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:14:15.180768Z","caller":"traceutil/trace.go:171","msg":"trace[467180516] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4832; }","duration":"115.462973ms","start":"2026-04-20T08:14:15.065264Z","end":"2026-04-20T08:14:15.180727Z","steps":["trace[467180516] 'agreement among raft nodes before linearized reading' (duration: 115.230069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.181068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.984956ms","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-20T08:14:15.181414Z","caller":"traceutil/trace.go:171","msg":"trace[1439740542] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4832; }","duration":"117.128378ms","start":"2026-04-20T08:14:15.064028Z","end":"2026-04-20T08:14:15.181157Z","steps":["trace[1439740542] 'agreement among raft nodes before linearized reading' (duration: 116.645131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.181171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.23603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/rabbitmq-cluster-operator-openstack\" ","response":"range_response_count:1 size:1874"} {"level":"info","ts":"2026-04-20T08:14:15.182129Z","caller":"traceutil/trace.go:171","msg":"trace[905970468] range","detail":"{range_begin:/registry/clusterroles/rabbitmq-cluster-operator-openstack; range_end:; response_count:1; response_revision:4832; }","duration":"118.192966ms","start":"2026-04-20T08:14:15.063913Z","end":"2026-04-20T08:14:15.182106Z","steps":["trace[905970468] 'agreement among raft nodes before linearized reading' (duration: 117.105808ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.35729Z","caller":"traceutil/trace.go:171","msg":"trace[1717856635] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"168.793098ms","start":"2026-04-20T08:14:15.18846Z","end":"2026-04-20T08:14:15.357253Z","steps":["trace[1717856635] 'process raft request' (duration: 165.481256ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.36453Z","caller":"traceutil/trace.go:171","msg":"trace[418009919] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"175.370343ms","start":"2026-04-20T08:14:15.189138Z","end":"2026-04-20T08:14:15.364508Z","steps":["trace[418009919] 'process raft request' (duration: 175.17272ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.364568Z","caller":"traceutil/trace.go:171","msg":"trace[477316906] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"175.095339ms","start":"2026-04-20T08:14:15.189454Z","end":"2026-04-20T08:14:15.364549Z","steps":["trace[477316906] 'process raft request' (duration: 174.991107ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.364731Z","caller":"traceutil/trace.go:171","msg":"trace[1764940418] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"174.969767ms","start":"2026-04-20T08:14:15.18975Z","end":"2026-04-20T08:14:15.36472Z","steps":["trace[1764940418] 'process raft request' (duration: 174.740123ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.36506Z","caller":"traceutil/trace.go:171","msg":"trace[66602091] linearizableReadLoop","detail":"{readStateIndex:5018; appliedIndex:5016; }","duration":"175.666428ms","start":"2026-04-20T08:14:15.18936Z","end":"2026-04-20T08:14:15.365026Z","steps":["trace[66602091] 'read index received' (duration: 164.602882ms)","trace[66602091] 'applied index is now lower than readState.Index' (duration: 11.062356ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:15.365176Z","caller":"traceutil/trace.go:171","msg":"trace[495956791] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"174.605681ms","start":"2026-04-20T08:14:15.190508Z","end":"2026-04-20T08:14:15.365113Z","steps":["trace[495956791] 'process raft request' (duration: 174.164884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.365365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.983592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:699"} {"level":"warn","ts":"2026-04-20T08:14:15.365432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.000953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6b280bc5-7df9-43ee-8595-e3f679729af5\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-04-20T08:14:15.365498Z","caller":"traceutil/trace.go:171","msg":"trace[310810125] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6b280bc5-7df9-43ee-8595-e3f679729af5; range_end:; response_count:1; response_revision:4838; }","duration":"176.114505ms","start":"2026-04-20T08:14:15.189368Z","end":"2026-04-20T08:14:15.365482Z","steps":["trace[310810125] 'agreement among raft nodes before linearized reading' (duration: 175.940762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.365531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.893077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61662"} {"level":"info","ts":"2026-04-20T08:14:15.365564Z","caller":"traceutil/trace.go:171","msg":"trace[1842542808] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4838; }","duration":"171.936788ms","start":"2026-04-20T08:14:15.193618Z","end":"2026-04-20T08:14:15.365555Z","steps":["trace[1842542808] 'agreement among raft nodes before linearized reading' (duration: 171.785226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.365616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.420232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-20T08:14:15.365678Z","caller":"traceutil/trace.go:171","msg":"trace[933437879] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4838; }","duration":"173.516924ms","start":"2026-04-20T08:14:15.19215Z","end":"2026-04-20T08:14:15.365667Z","steps":["trace[933437879] 'agreement among raft nodes before linearized reading' (duration: 173.25639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:15.365706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.481039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-20T08:14:15.365736Z","caller":"traceutil/trace.go:171","msg":"trace[1978321530] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4838; }","duration":"174.54862ms","start":"2026-04-20T08:14:15.19118Z","end":"2026-04-20T08:14:15.365728Z","steps":["trace[1978321530] 'agreement among raft nodes before linearized reading' (duration: 174.462848ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:15.365447Z","caller":"traceutil/trace.go:171","msg":"trace[579251040] range","detail":"{range_begin:/registry/clusterroles/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:4838; }","duration":"176.097604ms","start":"2026-04-20T08:14:15.18933Z","end":"2026-04-20T08:14:15.365428Z","steps":["trace[579251040] 'agreement among raft nodes before linearized reading' (duration: 175.959492ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:16.789457Z","caller":"traceutil/trace.go:171","msg":"trace[1962554838] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"115.439709ms","start":"2026-04-20T08:14:16.673988Z","end":"2026-04-20T08:14:16.789428Z","steps":["trace[1962554838] 'process raft request' (duration: 115.251736ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:27.581776Z","caller":"traceutil/trace.go:171","msg":"trace[1873538687] linearizableReadLoop","detail":"{readStateIndex:5222; appliedIndex:5221; }","duration":"153.882538ms","start":"2026-04-20T08:14:27.427864Z","end":"2026-04-20T08:14:27.581747Z","steps":["trace[1873538687] 'read index received' (duration: 153.663204ms)","trace[1873538687] 'applied index is now lower than readState.Index' (duration: 218.404µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:27.58212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.219043ms","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-20T08:14:27.581917Z","caller":"traceutil/trace.go:171","msg":"trace[1410400139] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"165.665292ms","start":"2026-04-20T08:14:27.416205Z","end":"2026-04-20T08:14:27.58187Z","steps":["trace[1410400139] 'process raft request' (duration: 165.397188ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:27.5822Z","caller":"traceutil/trace.go:171","msg":"trace[317566874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5031; }","duration":"154.392766ms","start":"2026-04-20T08:14:27.427789Z","end":"2026-04-20T08:14:27.582181Z","steps":["trace[317566874] 'agreement among raft nodes before linearized reading' (duration: 154.135412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:27.790933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.947245ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:14:27.791229Z","caller":"traceutil/trace.go:171","msg":"trace[278605114] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"203.536716ms","start":"2026-04-20T08:14:27.587641Z","end":"2026-04-20T08:14:27.791177Z","steps":["trace[278605114] 'process raft request' (duration: 55.242135ms)","trace[278605114] 'compare' (duration: 147.492608ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:27.807231Z","caller":"traceutil/trace.go:171","msg":"trace[893373444] linearizableReadLoop","detail":"{readStateIndex:5224; appliedIndex:5222; }","duration":"216.717412ms","start":"2026-04-20T08:14:27.590491Z","end":"2026-04-20T08:14:27.807208Z","steps":["trace[893373444] 'read index received' (duration: 52.424421ms)","trace[893373444] 'applied index is now lower than readState.Index' (duration: 164.291461ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:27.807338Z","caller":"traceutil/trace.go:171","msg":"trace[256569831] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"219.036519ms","start":"2026-04-20T08:14:27.588276Z","end":"2026-04-20T08:14:27.807313Z","steps":["trace[256569831] 'process raft request' (duration: 218.809445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:27.807508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.984506ms","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-20T08:14:27.807561Z","caller":"traceutil/trace.go:171","msg":"trace[395047878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5033; }","duration":"217.071307ms","start":"2026-04-20T08:14:27.590472Z","end":"2026-04-20T08:14:27.807543Z","steps":["trace[395047878] 'agreement among raft nodes before linearized reading' (duration: 216.878694ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:22.393492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2869} {"level":"info","ts":"2026-04-20T08:15:22.467394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2869,"took":"72.082512ms","hash":3289843426,"current-db-size-bytes":53055488,"current-db-size":"53 MB","current-db-size-in-use-bytes":28897280,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T08:15:22.467461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3289843426,"revision":2869,"compact-revision":-1} {"level":"info","ts":"2026-04-20T08:20:22.399641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5471} {"level":"info","ts":"2026-04-20T08:20:22.476281Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5471,"took":"74.544323ms","hash":4211716279,"current-db-size-bytes":53055488,"current-db-size":"53 MB","current-db-size-in-use-bytes":18358272,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T08:20:22.476369Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4211716279,"revision":5471,"compact-revision":2869}