{"level":"warn","ts":"2026-04-13T21:00:04.245967Z","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-13T21:00:04.246074Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.17: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.17:2380","--initial-cluster=instance=https://199.19.213.17:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.17:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.17: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-13T21:00:04.246206Z","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-13T21:00:04.246218Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.17:2380"]} {"level":"info","ts":"2026-04-13T21:00:04.246258Z","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-13T21:00:04.246997Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.17:2379"]} {"level":"info","ts":"2026-04-13T21:00:04.247125Z","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.17:2380"],"listen-peer-urls":["https://199.19.213.17:2380"],"advertise-client-urls":["https://199.19.213.17:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.17:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.17: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-13T21:00:04.252802Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.359912ms"} {"level":"info","ts":"2026-04-13T21:00:04.259011Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"27c4b87f3ea730e3","cluster-id":"cdce983f4a7486fe"} {"level":"info","ts":"2026-04-13T21:00:04.25915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T21:00:04.259241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 became follower at term 0"} {"level":"info","ts":"2026-04-13T21:00:04.259264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 27c4b87f3ea730e3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T21:00:04.259301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 became follower at term 1"} {"level":"info","ts":"2026-04-13T21:00:04.259382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 switched to configuration voters=(2865618119565979875)"} {"level":"warn","ts":"2026-04-13T21:00:04.268603Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T21:00:04.270832Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T21:00:04.27183Z","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-13T21:00:04.273637Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"27c4b87f3ea730e3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T21:00:04.274324Z","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-13T21:00:04.274399Z","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-13T21:00:04.274408Z","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-13T21:00:04.274557Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"27c4b87f3ea730e3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T21:00:04.276768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 switched to configuration voters=(2865618119565979875)"} {"level":"info","ts":"2026-04-13T21:00:04.276928Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdce983f4a7486fe","local-member-id":"27c4b87f3ea730e3","added-peer-id":"27c4b87f3ea730e3","added-peer-peer-urls":["https://199.19.213.17:2380"]} {"level":"info","ts":"2026-04-13T21:00:04.280816Z","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-13T21:00:04.281017Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.17:2380"} {"level":"info","ts":"2026-04-13T21:00:04.281055Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.17:2380"} {"level":"info","ts":"2026-04-13T21:00:04.281371Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"27c4b87f3ea730e3","initial-advertise-peer-urls":["https://199.19.213.17:2380"],"listen-peer-urls":["https://199.19.213.17:2380"],"advertise-client-urls":["https://199.19.213.17:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.17:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T21:00:04.281499Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T21:00:04.460396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T21:00:04.460463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T21:00:04.460497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 received MsgPreVoteResp from 27c4b87f3ea730e3 at term 1"} {"level":"info","ts":"2026-04-13T21:00:04.460515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 became candidate at term 2"} {"level":"info","ts":"2026-04-13T21:00:04.460522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 received MsgVoteResp from 27c4b87f3ea730e3 at term 2"} {"level":"info","ts":"2026-04-13T21:00:04.460533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"27c4b87f3ea730e3 became leader at term 2"} {"level":"info","ts":"2026-04-13T21:00:04.460544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 27c4b87f3ea730e3 elected leader 27c4b87f3ea730e3 at term 2"} {"level":"info","ts":"2026-04-13T21:00:04.462649Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:04.46486Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"27c4b87f3ea730e3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.17:2379]}","request-path":"/0/members/27c4b87f3ea730e3/attributes","cluster-id":"cdce983f4a7486fe","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T21:00:04.465079Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:00:04.465141Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:00:04.465611Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T21:00:04.465649Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T21:00:04.467936Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdce983f4a7486fe","local-member-id":"27c4b87f3ea730e3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:04.468056Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:04.468091Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:04.468976Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.17:2379"} {"level":"info","ts":"2026-04-13T21:00:04.468972Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T21:00:07.700651Z","caller":"traceutil/trace.go:171","msg":"trace[1596191175] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"131.472367ms","start":"2026-04-13T21:00:07.569144Z","end":"2026-04-13T21:00:07.700616Z","steps":["trace[1596191175] 'process raft request' (duration: 71.097314ms)","trace[1596191175] 'compare' (duration: 60.158843ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:09.124578Z","caller":"traceutil/trace.go:171","msg":"trace[783702813] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"129.474634ms","start":"2026-04-13T21:00:08.995081Z","end":"2026-04-13T21:00:09.124555Z","steps":["trace[783702813] 'process raft request' (duration: 129.354754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:14.508175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.366919ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-04-13T21:00:36.674008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.255689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-04-13T21:00:36.674092Z","caller":"traceutil/trace.go:171","msg":"trace[26151818] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:491; }","duration":"105.373909ms","start":"2026-04-13T21:00:36.5687Z","end":"2026-04-13T21:00:36.674074Z","steps":["trace[26151818] 'agreement among raft nodes before linearized reading' (duration: 96.206757ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:40.435361Z","caller":"traceutil/trace.go:171","msg":"trace[1824186827] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"110.279088ms","start":"2026-04-13T21:00:40.325012Z","end":"2026-04-13T21:00:40.435291Z","steps":["trace[1824186827] 'process raft request' (duration: 109.328425ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:43.886266Z","caller":"traceutil/trace.go:171","msg":"trace[1669576985] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"157.716406ms","start":"2026-04-13T21:00:43.728531Z","end":"2026-04-13T21:00:43.886247Z","steps":["trace[1669576985] 'read index received' (duration: 157.010724ms)","trace[1669576985] 'applied index is now lower than readState.Index' (duration: 705.002µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:43.887036Z","caller":"traceutil/trace.go:171","msg":"trace[2125648569] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"188.526353ms","start":"2026-04-13T21:00:43.698502Z","end":"2026-04-13T21:00:43.887029Z","steps":["trace[2125648569] 'process raft request' (duration: 187.247499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.887221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.676779ms","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-13T21:00:43.887242Z","caller":"traceutil/trace.go:171","msg":"trace[853865365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"158.761169ms","start":"2026-04-13T21:00:43.728476Z","end":"2026-04-13T21:00:43.887237Z","steps":["trace[853865365] 'agreement among raft nodes before linearized reading' (duration: 158.668119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.887342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.080184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:43.887361Z","caller":"traceutil/trace.go:171","msg":"trace[1588253345] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:579; }","duration":"157.104714ms","start":"2026-04-13T21:00:43.730251Z","end":"2026-04-13T21:00:43.887356Z","steps":["trace[1588253345] 'agreement among raft nodes before linearized reading' (duration: 157.071844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.889398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.348429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:43.88942Z","caller":"traceutil/trace.go:171","msg":"trace[1138850225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"109.396459ms","start":"2026-04-13T21:00:43.780017Z","end":"2026-04-13T21:00:43.889413Z","steps":["trace[1138850225] 'agreement among raft nodes before linearized reading' (duration: 109.352239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.889507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.477729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T21:00:43.889523Z","caller":"traceutil/trace.go:171","msg":"trace[986170402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:579; }","duration":"129.538799ms","start":"2026-04-13T21:00:43.75998Z","end":"2026-04-13T21:00:43.889519Z","steps":["trace[986170402] 'agreement among raft nodes before linearized reading' (duration: 129.497529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.889616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.78016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:43.889634Z","caller":"traceutil/trace.go:171","msg":"trace[880547090] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:579; }","duration":"158.82044ms","start":"2026-04-13T21:00:43.730809Z","end":"2026-04-13T21:00:43.88963Z","steps":["trace[880547090] 'agreement among raft nodes before linearized reading' (duration: 158.79187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.889693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.263552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:43.88971Z","caller":"traceutil/trace.go:171","msg":"trace[975624052] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:579; }","duration":"159.303423ms","start":"2026-04-13T21:00:43.730402Z","end":"2026-04-13T21:00:43.889706Z","steps":["trace[975624052] 'agreement among raft nodes before linearized reading' (duration: 159.278013ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:44.33592Z","caller":"traceutil/trace.go:171","msg":"trace[247269522] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"317.649815ms","start":"2026-04-13T21:00:44.018242Z","end":"2026-04-13T21:00:44.335892Z","steps":["trace[247269522] 'read index received' (duration: 317.417974ms)","trace[247269522] 'applied index is now lower than readState.Index' (duration: 230.731µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:44.336048Z","caller":"traceutil/trace.go:171","msg":"trace[1677559739] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"367.194396ms","start":"2026-04-13T21:00:43.968842Z","end":"2026-04-13T21:00:44.336036Z","steps":["trace[1677559739] 'process raft request' (duration: 366.900155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.336467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.209027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-56scl\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-13T21:00:44.336562Z","caller":"traceutil/trace.go:171","msg":"trace[1610373615] range","detail":"{range_begin:/registry/pods/kube-system/cilium-56scl; range_end:; response_count:1; response_revision:582; }","duration":"318.348048ms","start":"2026-04-13T21:00:44.018191Z","end":"2026-04-13T21:00:44.336539Z","steps":["trace[1610373615] 'agreement among raft nodes before linearized reading' (duration: 318.052496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.3366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:44.018165Z","time spent":"318.427118ms","remote":"127.0.0.1:33758","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-56scl\" "} {"level":"warn","ts":"2026-04-13T21:00:44.336617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:43.968819Z","time spent":"367.261796ms","remote":"127.0.0.1:33810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:00:44.336802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.193837ms","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-13T21:00:44.336867Z","caller":"traceutil/trace.go:171","msg":"trace[1736381803] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"225.290288ms","start":"2026-04-13T21:00:44.111558Z","end":"2026-04-13T21:00:44.336848Z","steps":["trace[1736381803] 'agreement among raft nodes before linearized reading' (duration: 225.153407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.337101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.792474ms","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-04-13T21:00:44.337134Z","caller":"traceutil/trace.go:171","msg":"trace[1815784244] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"137.852314ms","start":"2026-04-13T21:00:44.199271Z","end":"2026-04-13T21:00:44.337124Z","steps":["trace[1815784244] 'agreement among raft nodes before linearized reading' (duration: 137.797594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.337219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.94748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:44.337257Z","caller":"traceutil/trace.go:171","msg":"trace[240711363] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:582; }","duration":"287.02252ms","start":"2026-04-13T21:00:44.050225Z","end":"2026-04-13T21:00:44.337248Z","steps":["trace[240711363] 'agreement among raft nodes before linearized reading' (duration: 286.96956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.337283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.426817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:00:44.337285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.400817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:00:44.337263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.1341ms","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-13T21:00:44.337316Z","caller":"traceutil/trace.go:171","msg":"trace[579376247] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"196.476607ms","start":"2026-04-13T21:00:44.140831Z","end":"2026-04-13T21:00:44.337308Z","steps":["trace[579376247] 'agreement among raft nodes before linearized reading' (duration: 196.424957ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:44.337326Z","caller":"traceutil/trace.go:171","msg":"trace[1986618218] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"196.451907ms","start":"2026-04-13T21:00:44.140863Z","end":"2026-04-13T21:00:44.337315Z","steps":["trace[1986618218] 'agreement among raft nodes before linearized reading' (duration: 196.391567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.337471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.163956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:44.33751Z","caller":"traceutil/trace.go:171","msg":"trace[1189823119] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"138.227056ms","start":"2026-04-13T21:00:44.199271Z","end":"2026-04-13T21:00:44.337498Z","steps":["trace[1189823119] 'agreement among raft nodes before linearized reading' (duration: 138.169985ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:44.337564Z","caller":"traceutil/trace.go:171","msg":"trace[1887580742] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"255.26276ms","start":"2026-04-13T21:00:44.082068Z","end":"2026-04-13T21:00:44.33733Z","steps":["trace[1887580742] 'agreement among raft nodes before linearized reading' (duration: 255.12562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.337671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.687618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:44.337709Z","caller":"traceutil/trace.go:171","msg":"trace[603459755] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:582; }","duration":"196.738278ms","start":"2026-04-13T21:00:44.140961Z","end":"2026-04-13T21:00:44.337699Z","steps":["trace[603459755] 'agreement among raft nodes before linearized reading' (duration: 196.681978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.33776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.848052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:44.337795Z","caller":"traceutil/trace.go:171","msg":"trace[678851178] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:582; }","duration":"287.905653ms","start":"2026-04-13T21:00:44.049879Z","end":"2026-04-13T21:00:44.337785Z","steps":["trace[678851178] 'agreement among raft nodes before linearized reading' (duration: 287.851452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.337949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.360804ms","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-13T21:00:44.338002Z","caller":"traceutil/trace.go:171","msg":"trace[1288109258] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"227.417754ms","start":"2026-04-13T21:00:44.110572Z","end":"2026-04-13T21:00:44.33799Z","steps":["trace[1288109258] 'agreement among raft nodes before linearized reading' (duration: 227.304684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.338133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.549455ms","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-13T21:00:44.338175Z","caller":"traceutil/trace.go:171","msg":"trace[1467997413] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"227.592505ms","start":"2026-04-13T21:00:44.110572Z","end":"2026-04-13T21:00:44.338165Z","steps":["trace[1467997413] 'agreement among raft nodes before linearized reading' (duration: 227.496584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.338546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.505868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:44.338605Z","caller":"traceutil/trace.go:171","msg":"trace[1695647325] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:582; }","duration":"288.757736ms","start":"2026-04-13T21:00:44.049832Z","end":"2026-04-13T21:00:44.33859Z","steps":["trace[1695647325] 'agreement among raft nodes before linearized reading' (duration: 286.434988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.338994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.593261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:44.339055Z","caller":"traceutil/trace.go:171","msg":"trace[142510285] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"139.151848ms","start":"2026-04-13T21:00:44.199886Z","end":"2026-04-13T21:00:44.339038Z","steps":["trace[142510285] 'agreement among raft nodes before linearized reading' (duration: 136.53064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:44.344437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.339814ms","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-13T21:00:44.344486Z","caller":"traceutil/trace.go:171","msg":"trace[2106276421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:582; }","duration":"262.400854ms","start":"2026-04-13T21:00:44.082073Z","end":"2026-04-13T21:00:44.344474Z","steps":["trace[2106276421] 'agreement among raft nodes before linearized reading' (duration: 255.28758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:23.369655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.057386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-13T21:02:23.369794Z","caller":"traceutil/trace.go:171","msg":"trace[564477486] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1825; }","duration":"101.27175ms","start":"2026-04-13T21:02:23.268496Z","end":"2026-04-13T21:02:23.369768Z","steps":["trace[564477486] 'range keys from in-memory index tree' (duration: 100.854063ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:23.979755Z","caller":"traceutil/trace.go:171","msg":"trace[1442013903] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1905; }","duration":"325.62197ms","start":"2026-04-13T21:02:23.654096Z","end":"2026-04-13T21:02:23.979718Z","steps":["trace[1442013903] 'read index received' (duration: 308.038363ms)","trace[1442013903] 'applied index is now lower than readState.Index' (duration: 17.581737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:02:23.979914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.808363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8eacaa82-c5a2-4cc1-8b77-5d517d932ed4\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-04-13T21:02:23.979881Z","caller":"traceutil/trace.go:171","msg":"trace[571858118] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"407.252039ms","start":"2026-04-13T21:02:23.572584Z","end":"2026-04-13T21:02:23.979836Z","steps":["trace[571858118] 'process raft request' (duration: 389.620011ms)","trace[571858118] 'compare' (duration: 16.808034ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:23.979959Z","caller":"traceutil/trace.go:171","msg":"trace[1231631188] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8eacaa82-c5a2-4cc1-8b77-5d517d932ed4; range_end:; response_count:1; response_revision:1829; }","duration":"325.922365ms","start":"2026-04-13T21:02:23.654024Z","end":"2026-04-13T21:02:23.979946Z","steps":["trace[1231631188] 'agreement among raft nodes before linearized reading' (duration: 325.826703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:23.98Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:23.653994Z","time spent":"325.998036ms","remote":"127.0.0.1:33758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8eacaa82-c5a2-4cc1-8b77-5d517d932ed4\" "} {"level":"warn","ts":"2026-04-13T21:02:23.980646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:02:23.572551Z","time spent":"407.441552ms","remote":"127.0.0.1:33758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:02:58.055016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.532631ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:02:58.055147Z","caller":"traceutil/trace.go:171","msg":"trace[2086950620] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2153; }","duration":"104.970945ms","start":"2026-04-13T21:02:57.95016Z","end":"2026-04-13T21:02:58.055131Z","steps":["trace[2086950620] 'read index received' (duration: 44.011µs)","trace[2086950620] 'applied index is now lower than readState.Index' (duration: 104.925444ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:02:58.055235Z","caller":"traceutil/trace.go:171","msg":"trace[1182928012] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"243.703028ms","start":"2026-04-13T21:02:57.811486Z","end":"2026-04-13T21:02:58.055189Z","steps":["trace[1182928012] 'process raft request' (duration: 76.892744ms)","trace[1182928012] 'compare' (duration: 166.284338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:02:58.055368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.212687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.17\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-13T21:02:58.055403Z","caller":"traceutil/trace.go:171","msg":"trace[1959724992] range","detail":"{range_begin:/registry/masterleases/199.19.213.17; range_end:; response_count:1; response_revision:2070; }","duration":"105.280208ms","start":"2026-04-13T21:02:57.950112Z","end":"2026-04-13T21:02:58.055392Z","steps":["trace[1959724992] 'agreement among raft nodes before linearized reading' (duration: 105.068915ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:02:58.369865Z","caller":"traceutil/trace.go:171","msg":"trace[10915800] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"125.491102ms","start":"2026-04-13T21:02:58.244348Z","end":"2026-04-13T21:02:58.369839Z","steps":["trace[10915800] 'process raft request' (duration: 115.561326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:02:58.609535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.705993ms","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-13T21:02:58.609647Z","caller":"traceutil/trace.go:171","msg":"trace[342490302] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2072; }","duration":"138.849345ms","start":"2026-04-13T21:02:58.470774Z","end":"2026-04-13T21:02:58.609623Z","steps":["trace[342490302] 'range keys from in-memory index tree' (duration: 138.40002ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:39.817296Z","caller":"traceutil/trace.go:171","msg":"trace[482408922] transaction","detail":"{read_only:false; response_revision:2301; number_of_response:1; }","duration":"605.557601ms","start":"2026-04-13T21:03:39.211663Z","end":"2026-04-13T21:03:39.817221Z","steps":["trace[482408922] 'process raft request' (duration: 605.42641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:39.817488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:39.211627Z","time spent":"605.735042ms","remote":"127.0.0.1:33850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:03:39.822426Z","caller":"traceutil/trace.go:171","msg":"trace[1520818258] transaction","detail":"{read_only:false; response_revision:2303; number_of_response:1; }","duration":"372.255062ms","start":"2026-04-13T21:03:39.450159Z","end":"2026-04-13T21:03:39.822414Z","steps":["trace[1520818258] 'process raft request' (duration: 372.173571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:39.822479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:39.450124Z","time spent":"372.330843ms","remote":"127.0.0.1:33850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:03:39.822528Z","caller":"traceutil/trace.go:171","msg":"trace[411078518] transaction","detail":"{read_only:false; response_revision:2302; number_of_response:1; }","duration":"572.074288ms","start":"2026-04-13T21:03:39.250336Z","end":"2026-04-13T21:03:39.82241Z","steps":["trace[411078518] 'process raft request' (duration: 571.913677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:39.822981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:03:39.250295Z","time spent":"572.533153ms","remote":"127.0.0.1:33850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:40.759665Z","caller":"traceutil/trace.go:171","msg":"trace[1220322745] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"137.247681ms","start":"2026-04-13T21:04:40.622394Z","end":"2026-04-13T21:04:40.759642Z","steps":["trace[1220322745] 'process raft request' (duration: 137.065709ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:08:34.721021Z","caller":"traceutil/trace.go:171","msg":"trace[468159107] linearizableReadLoop","detail":"{readStateIndex:4779; appliedIndex:4778; }","duration":"139.2536ms","start":"2026-04-13T21:08:34.581747Z","end":"2026-04-13T21:08:34.721001Z","steps":["trace[468159107] 'read index received' (duration: 138.950195ms)","trace[468159107] 'applied index is now lower than readState.Index' (duration: 302.445µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:08:34.721134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.393163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:08:34.721112Z","caller":"traceutil/trace.go:171","msg":"trace[231137574] transaction","detail":"{read_only:false; response_revision:4596; number_of_response:1; }","duration":"167.107219ms","start":"2026-04-13T21:08:34.553973Z","end":"2026-04-13T21:08:34.72108Z","steps":["trace[231137574] 'process raft request' (duration: 166.837875ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:08:34.721167Z","caller":"traceutil/trace.go:171","msg":"trace[2059952400] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4596; }","duration":"139.471954ms","start":"2026-04-13T21:08:34.581687Z","end":"2026-04-13T21:08:34.721159Z","steps":["trace[2059952400] 'agreement among raft nodes before linearized reading' (duration: 139.397763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:34.721316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.292769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T21:08:34.721435Z","caller":"traceutil/trace.go:171","msg":"trace[952283606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4596; }","duration":"125.463071ms","start":"2026-04-13T21:08:34.595959Z","end":"2026-04-13T21:08:34.721422Z","steps":["trace[952283606] 'agreement among raft nodes before linearized reading' (duration: 125.206867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:37.880926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.029266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:08:37.881034Z","caller":"traceutil/trace.go:171","msg":"trace[1926738817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4658; }","duration":"108.179459ms","start":"2026-04-13T21:08:37.772834Z","end":"2026-04-13T21:08:37.881014Z","steps":["trace[1926738817] 'agreement among raft nodes before linearized reading' (duration: 107.999076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:38.009341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.757761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-13T21:08:38.010542Z","caller":"traceutil/trace.go:171","msg":"trace[2057730516] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4662; }","duration":"100.922344ms","start":"2026-04-13T21:08:37.908511Z","end":"2026-04-13T21:08:38.009434Z","steps":["trace[2057730516] 'agreement among raft nodes before linearized reading' (duration: 100.729131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:43.677641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.912464ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T21:08:43.67812Z","caller":"traceutil/trace.go:171","msg":"trace[984504280] linearizableReadLoop","detail":"{readStateIndex:4971; appliedIndex:4970; }","duration":"238.897837ms","start":"2026-04-13T21:08:43.439203Z","end":"2026-04-13T21:08:43.678101Z","steps":["trace[984504280] 'read index received' (duration: 86.513534ms)","trace[984504280] 'applied index is now lower than readState.Index' (duration: 152.383003ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:08:43.678359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.143992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:08:43.678417Z","caller":"traceutil/trace.go:171","msg":"trace[770581641] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4784; }","duration":"239.241243ms","start":"2026-04-13T21:08:43.439159Z","end":"2026-04-13T21:08:43.6784Z","steps":["trace[770581641] 'agreement among raft nodes before linearized reading' (duration: 239.04176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:43.678892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.946163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-f77b9ff8b-69ggq\" ","response":"range_response_count:1 size:11251"} {"level":"info","ts":"2026-04-13T21:08:43.678975Z","caller":"traceutil/trace.go:171","msg":"trace[831235766] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-f77b9ff8b-69ggq; range_end:; response_count:1; response_revision:4784; }","duration":"159.070326ms","start":"2026-04-13T21:08:43.519885Z","end":"2026-04-13T21:08:43.678955Z","steps":["trace[831235766] 'agreement among raft nodes before linearized reading' (duration: 158.851722ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:08:43.678969Z","caller":"traceutil/trace.go:171","msg":"trace[954542272] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"158.362174ms","start":"2026-04-13T21:08:43.520592Z","end":"2026-04-13T21:08:43.678954Z","steps":["trace[954542272] 'process raft request' (duration: 157.156743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:43.67924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.71837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a02ae536-6758-4b5c-aa00-a33306731f55\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-13T21:08:43.67929Z","caller":"traceutil/trace.go:171","msg":"trace[344266556] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a02ae536-6758-4b5c-aa00-a33306731f55; range_end:; response_count:1; response_revision:4784; }","duration":"145.799652ms","start":"2026-04-13T21:08:43.533477Z","end":"2026-04-13T21:08:43.679277Z","steps":["trace[344266556] 'agreement among raft nodes before linearized reading' (duration: 145.68794ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:08:43.816904Z","caller":"traceutil/trace.go:171","msg":"trace[351665074] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"106.676404ms","start":"2026-04-13T21:08:43.710173Z","end":"2026-04-13T21:08:43.816849Z","steps":["trace[351665074] 'process raft request' (duration: 72.482219ms)","trace[351665074] 'compare' (duration: 33.811889ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:09:33.240082Z","caller":"traceutil/trace.go:171","msg":"trace[1825758159] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"102.410361ms","start":"2026-04-13T21:09:33.137641Z","end":"2026-04-13T21:09:33.240052Z","steps":["trace[1825758159] 'process raft request' (duration: 102.34261ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:09:33.240086Z","caller":"traceutil/trace.go:171","msg":"trace[1255049391] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"111.188282ms","start":"2026-04-13T21:09:33.128856Z","end":"2026-04-13T21:09:33.240045Z","steps":["trace[1255049391] 'process raft request' (duration: 110.919228ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:09:33.240119Z","caller":"traceutil/trace.go:171","msg":"trace[1876259111] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"106.570202ms","start":"2026-04-13T21:09:33.133515Z","end":"2026-04-13T21:09:33.240085Z","steps":["trace[1876259111] 'process raft request' (duration: 106.41672ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:10:04.708168Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2857} {"level":"info","ts":"2026-04-13T21:10:04.783165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2857,"took":"73.292083ms","hash":1340970133,"current-db-size-bytes":54030336,"current-db-size":"54 MB","current-db-size-in-use-bytes":28938240,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-13T21:10:04.783286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1340970133,"revision":2857,"compact-revision":-1} {"level":"info","ts":"2026-04-13T21:12:24.289135Z","caller":"traceutil/trace.go:171","msg":"trace[155641140] transaction","detail":"{read_only:false; response_revision:6497; number_of_response:1; }","duration":"121.80018ms","start":"2026-04-13T21:12:24.167309Z","end":"2026-04-13T21:12:24.289109Z","steps":["trace[155641140] 'process raft request' (duration: 42.044758ms)","trace[155641140] 'compare' (duration: 79.63369ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:12:53.457008Z","caller":"traceutil/trace.go:171","msg":"trace[1098154819] transaction","detail":"{read_only:false; response_revision:6700; number_of_response:1; }","duration":"135.203513ms","start":"2026-04-13T21:12:53.321783Z","end":"2026-04-13T21:12:53.456987Z","steps":["trace[1098154819] 'process raft request' (duration: 135.073561ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:04.714551Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5543} {"level":"info","ts":"2026-04-13T21:15:04.788424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5543,"took":"71.783341ms","hash":2871381765,"current-db-size-bytes":54030336,"current-db-size":"54 MB","current-db-size-in-use-bytes":18202624,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-13T21:15:04.788484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2871381765,"revision":5543,"compact-revision":2857}