{"level":"warn","ts":"2026-05-05T11:24:21.304113Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T11:24:21.304265Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.204.45.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-05-05T11:24:21.304353Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T11:24:21.304391Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-05T11:24:21.304422Z","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-05-05T11:24:21.305121Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-05-05T11:24:21.305241Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-05-05T11:24:21.309571Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.105934ms"} {"level":"info","ts":"2026-05-05T11:24:21.315053Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-05-05T11:24:21.31518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T11:24:21.315222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-05-05T11:24:21.315252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T11:24:21.315279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-05-05T11:24:21.315335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-05-05T11:24:21.321215Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T11:24:21.322599Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T11:24:21.323822Z","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-05-05T11:24:21.326006Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T11:24:21.32621Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T11:24:21.326356Z","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-05-05T11:24:21.326548Z","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-05-05T11:24:21.326573Z","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-05-05T11:24:21.329021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-05-05T11:24:21.329296Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-05T11:24:21.330856Z","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-05-05T11:24:21.331019Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-05T11:24:21.331094Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-05T11:24:21.331152Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T11:24:21.331232Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T11:24:22.116631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T11:24:22.116711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T11:24:22.116737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-05-05T11:24:22.116757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-05-05T11:24:22.116771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-05T11:24:22.116787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-05-05T11:24:22.116803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-05T11:24:22.120245Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:24:22.12115Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T11:24:22.121406Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:24:22.121525Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:24:22.121881Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:24:22.122055Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:24:22.122119Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:24:22.125441Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T11:24:22.125488Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T11:24:22.12593Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-05-05T11:24:22.126368Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-05T11:24:23.888484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.887883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T11:24:23.888656Z","caller":"traceutil/trace.go:171","msg":"trace[1449616056] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:69; }","duration":"130.12459ms","start":"2026-05-05T11:24:23.758493Z","end":"2026-05-05T11:24:23.888617Z","steps":["trace[1449616056] 'range keys from in-memory index tree' (duration: 129.78757ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:39.254131Z","caller":"traceutil/trace.go:171","msg":"trace[1433635026] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"306.28928ms","start":"2026-05-05T11:24:38.947795Z","end":"2026-05-05T11:24:39.254084Z","steps":["trace[1433635026] 'process raft request' (duration: 306.022483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:39.254401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.380661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:24:39.254242Z","caller":"traceutil/trace.go:171","msg":"trace[1862972677] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"220.206535ms","start":"2026-05-05T11:24:39.033986Z","end":"2026-05-05T11:24:39.254193Z","steps":["trace[1862972677] 'read index received' (duration: 219.783684ms)","trace[1862972677] 'applied index is now lower than readState.Index' (duration: 419.121µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:24:39.254484Z","caller":"traceutil/trace.go:171","msg":"trace[489419886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"220.549325ms","start":"2026-05-05T11:24:39.033917Z","end":"2026-05-05T11:24:39.254466Z","steps":["trace[489419886] 'agreement among raft nodes before linearized reading' (duration: 220.37523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:39.255065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:24:38.94776Z","time spent":"306.63692ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:24:39.459172Z","caller":"traceutil/trace.go:171","msg":"trace[524305405] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"194.081049ms","start":"2026-05-05T11:24:39.265059Z","end":"2026-05-05T11:24:39.45914Z","steps":["trace[524305405] 'process raft request' (duration: 193.879543ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:39.462145Z","caller":"traceutil/trace.go:171","msg":"trace[297849131] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"188.043131ms","start":"2026-05-05T11:24:39.274071Z","end":"2026-05-05T11:24:39.462114Z","steps":["trace[297849131] 'process raft request' (duration: 187.906947ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:54.765834Z","caller":"traceutil/trace.go:171","msg":"trace[1959787839] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"104.37462ms","start":"2026-05-05T11:24:54.661429Z","end":"2026-05-05T11:24:54.765804Z","steps":["trace[1959787839] 'process raft request' (duration: 104.208086ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.457194Z","caller":"traceutil/trace.go:171","msg":"trace[207941135] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"143.238244ms","start":"2026-05-05T11:25:01.313914Z","end":"2026-05-05T11:25:01.457153Z","steps":["trace[207941135] 'read index received' (duration: 142.950456ms)","trace[207941135] 'applied index is now lower than readState.Index' (duration: 286.618µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:25:01.457266Z","caller":"traceutil/trace.go:171","msg":"trace[938064486] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"143.968765ms","start":"2026-05-05T11:25:01.313266Z","end":"2026-05-05T11:25:01.457234Z","steps":["trace[938064486] 'process raft request' (duration: 143.682537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.457344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.403329ms","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-05-05T11:25:01.457378Z","caller":"traceutil/trace.go:171","msg":"trace[993598274] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:683; }","duration":"143.47087ms","start":"2026-05-05T11:25:01.313892Z","end":"2026-05-05T11:25:01.457363Z","steps":["trace[993598274] 'agreement among raft nodes before linearized reading' (duration: 143.399858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.457551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.495211ms","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-05-05T11:25:01.457599Z","caller":"traceutil/trace.go:171","msg":"trace[289541023] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:683; }","duration":"143.558213ms","start":"2026-05-05T11:25:01.314029Z","end":"2026-05-05T11:25:01.457588Z","steps":["trace[289541023] 'agreement among raft nodes before linearized reading' (duration: 143.48151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.457875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.691077ms","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-05-05T11:25:01.457919Z","caller":"traceutil/trace.go:171","msg":"trace[540681040] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:683; }","duration":"143.79052ms","start":"2026-05-05T11:25:01.314118Z","end":"2026-05-05T11:25:01.457908Z","steps":["trace[540681040] 'agreement among raft nodes before linearized reading' (duration: 143.715047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.81519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.923324ms","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":"warn","ts":"2026-05-05T11:25:01.815211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.242241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.81529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.990783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.815305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.887934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.815306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.350517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.815327Z","caller":"traceutil/trace.go:171","msg":"trace[1852613145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:683; }","duration":"115.093789ms","start":"2026-05-05T11:25:01.700195Z","end":"2026-05-05T11:25:01.815289Z","steps":["trace[1852613145] 'range keys from in-memory index tree' (duration: 114.813041ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.815352Z","caller":"traceutil/trace.go:171","msg":"trace[562672935] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:683; }","duration":"298.979247ms","start":"2026-05-05T11:25:01.516353Z","end":"2026-05-05T11:25:01.815332Z","steps":["trace[562672935] 'range keys from in-memory index tree' (duration: 298.833913ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.815367Z","caller":"traceutil/trace.go:171","msg":"trace[676442005] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"285.432489ms","start":"2026-05-05T11:25:01.529915Z","end":"2026-05-05T11:25:01.815347Z","steps":["trace[676442005] 'count revisions from in-memory index tree' (duration: 285.329696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.815405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.080733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.697303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.816806Z","caller":"traceutil/trace.go:171","msg":"trace[1946845188] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:683; }","duration":"211.778986ms","start":"2026-05-05T11:25:01.605012Z","end":"2026-05-05T11:25:01.816791Z","steps":["trace[1946845188] 'range keys from in-memory index tree' (duration: 211.644082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.817004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.93608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.81708Z","caller":"traceutil/trace.go:171","msg":"trace[1267244018] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:683; }","duration":"251.737559ms","start":"2026-05-05T11:25:01.56526Z","end":"2026-05-05T11:25:01.816998Z","steps":["trace[1267244018] 'count revisions from in-memory index tree' (duration: 249.99482ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.817166Z","caller":"traceutil/trace.go:171","msg":"trace[835558756] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"273.135246ms","start":"2026-05-05T11:25:01.543974Z","end":"2026-05-05T11:25:01.817109Z","steps":["trace[835558756] 'count revisions from in-memory index tree' (duration: 272.835448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.816185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.242651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.81758Z","caller":"traceutil/trace.go:171","msg":"trace[517194185] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:683; }","duration":"188.63988ms","start":"2026-05-05T11:25:01.628874Z","end":"2026-05-05T11:25:01.817513Z","steps":["trace[517194185] 'range keys from in-memory index tree' (duration: 187.139408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.81521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.205353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.817842Z","caller":"traceutil/trace.go:171","msg":"trace[1895040376] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:683; }","duration":"188.897277ms","start":"2026-05-05T11:25:01.628914Z","end":"2026-05-05T11:25:01.817812Z","steps":["trace[1895040376] 'count revisions from in-memory index tree' (duration: 186.13631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.817899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.241589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.815244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.786293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.817981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.213822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.817986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.996411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.818064Z","caller":"traceutil/trace.go:171","msg":"trace[2072430485] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:683; }","duration":"301.463686ms","start":"2026-05-05T11:25:01.516536Z","end":"2026-05-05T11:25:01.818Z","steps":["trace[2072430485] 'count revisions from in-memory index tree' (duration: 301.182538ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.816193Z","caller":"traceutil/trace.go:171","msg":"trace[1352703824] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:683; }","duration":"230.071906ms","start":"2026-05-05T11:25:01.585251Z","end":"2026-05-05T11:25:01.815323Z","steps":["trace[1352703824] 'count revisions from in-memory index tree' (duration: 229.88743ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.81812Z","caller":"traceutil/trace.go:171","msg":"trace[509602456] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:683; }","duration":"172.395567ms","start":"2026-05-05T11:25:01.64566Z","end":"2026-05-05T11:25:01.818056Z","steps":["trace[509602456] 'count revisions from in-memory index tree' (duration: 172.070888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.818167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:25:01.516532Z","time spent":"301.61452ms","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T11:25:01.818163Z","caller":"traceutil/trace.go:171","msg":"trace[700773849] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"288.212517ms","start":"2026-05-05T11:25:01.529884Z","end":"2026-05-05T11:25:01.818096Z","steps":["trace[700773849] 'range keys from in-memory index tree' (duration: 287.859937ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.818192Z","caller":"traceutil/trace.go:171","msg":"trace[1150295906] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:683; }","duration":"300.723495ms","start":"2026-05-05T11:25:01.517428Z","end":"2026-05-05T11:25:01.818151Z","steps":["trace[1150295906] 'range keys from in-memory index tree' (duration: 297.751412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.815234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.100642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.8163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.465104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.162459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.4833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.562889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.905257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.901418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.93805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.96224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T11:25:01.816237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.390088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:01.818344Z","caller":"traceutil/trace.go:171","msg":"trace[1433110349] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:683; }","duration":"172.721236ms","start":"2026-05-05T11:25:01.645593Z","end":"2026-05-05T11:25:01.818314Z","steps":["trace[1433110349] 'range keys from in-memory index tree' (duration: 169.885327ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.818356Z","caller":"traceutil/trace.go:171","msg":"trace[1301077151] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"273.509116ms","start":"2026-05-05T11:25:01.544815Z","end":"2026-05-05T11:25:01.818324Z","steps":["trace[1301077151] 'range keys from in-memory index tree' (duration: 270.459722ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.815344Z","caller":"traceutil/trace.go:171","msg":"trace[282989867] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:683; }","duration":"230.426755ms","start":"2026-05-05T11:25:01.584885Z","end":"2026-05-05T11:25:01.815312Z","steps":["trace[282989867] 'range keys from in-memory index tree' (duration: 230.127267ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.818638Z","caller":"traceutil/trace.go:171","msg":"trace[1444564672] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"274.71653ms","start":"2026-05-05T11:25:01.543898Z","end":"2026-05-05T11:25:01.818615Z","steps":["trace[1444564672] 'range keys from in-memory index tree' (duration: 271.420248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:01.818745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:25:01.517423Z","time spent":"301.276921ms","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T11:25:01.818912Z","caller":"traceutil/trace.go:171","msg":"trace[1055628750] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:683; }","duration":"233.11251ms","start":"2026-05-05T11:25:01.585748Z","end":"2026-05-05T11:25:01.81886Z","steps":["trace[1055628750] 'range keys from in-memory index tree' (duration: 230.462097ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.819174Z","caller":"traceutil/trace.go:171","msg":"trace[1596703104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:683; }","duration":"254.233719ms","start":"2026-05-05T11:25:01.564892Z","end":"2026-05-05T11:25:01.819125Z","steps":["trace[1596703104] 'range keys from in-memory index tree' (duration: 250.426343ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.819249Z","caller":"traceutil/trace.go:171","msg":"trace[879947856] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:683; }","duration":"214.474741ms","start":"2026-05-05T11:25:01.604688Z","end":"2026-05-05T11:25:01.819162Z","steps":["trace[879947856] 'count revisions from in-memory index tree' (duration: 211.874528ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.819276Z","caller":"traceutil/trace.go:171","msg":"trace[1165748851] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:683; }","duration":"190.149622ms","start":"2026-05-05T11:25:01.6291Z","end":"2026-05-05T11:25:01.81925Z","steps":["trace[1165748851] 'range keys from in-memory index tree' (duration: 187.058806ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.819582Z","caller":"traceutil/trace.go:171","msg":"trace[673307456] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:683; }","duration":"173.116527ms","start":"2026-05-05T11:25:01.646444Z","end":"2026-05-05T11:25:01.819561Z","steps":["trace[673307456] 'range keys from in-memory index tree' (duration: 169.853827ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.819585Z","caller":"traceutil/trace.go:171","msg":"trace[890440870] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:683; }","duration":"214.890832ms","start":"2026-05-05T11:25:01.604629Z","end":"2026-05-05T11:25:01.819519Z","steps":["trace[890440870] 'range keys from in-memory index tree' (duration: 211.813946ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.81969Z","caller":"traceutil/trace.go:171","msg":"trace[277549403] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"287.59776ms","start":"2026-05-05T11:25:01.531093Z","end":"2026-05-05T11:25:01.818691Z","steps":["trace[277549403] 'range keys from in-memory index tree' (duration: 284.060131ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:01.960781Z","caller":"traceutil/trace.go:171","msg":"trace[736488185] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"134.303855ms","start":"2026-05-05T11:25:01.826451Z","end":"2026-05-05T11:25:01.960755Z","steps":["trace[736488185] 'process raft request' (duration: 134.079319ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:02.011251Z","caller":"traceutil/trace.go:171","msg":"trace[457890440] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"182.962342ms","start":"2026-05-05T11:25:01.828277Z","end":"2026-05-05T11:25:02.01124Z","steps":["trace[457890440] 'process raft request' (duration: 182.707034ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:26:34.102272Z","caller":"traceutil/trace.go:171","msg":"trace[175201095] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"285.476102ms","start":"2026-05-05T11:26:33.816775Z","end":"2026-05-05T11:26:34.102251Z","steps":["trace[175201095] 'process raft request' (duration: 285.326068ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:26:34.104309Z","caller":"traceutil/trace.go:171","msg":"trace[683576864] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1936; }","duration":"116.279082ms","start":"2026-05-05T11:26:33.988Z","end":"2026-05-05T11:26:34.104279Z","steps":["trace[683576864] 'read index received' (duration: 114.139073ms)","trace[683576864] 'applied index is now lower than readState.Index' (duration: 2.139159ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:26:34.104426Z","caller":"traceutil/trace.go:171","msg":"trace[350585641] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"122.35256ms","start":"2026-05-05T11:26:33.982016Z","end":"2026-05-05T11:26:34.104368Z","steps":["trace[350585641] 'process raft request' (duration: 122.141664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:26:34.104466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.452117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T11:26:34.104643Z","caller":"traceutil/trace.go:171","msg":"trace[536695487] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1867; }","duration":"116.661652ms","start":"2026-05-05T11:26:33.987945Z","end":"2026-05-05T11:26:34.104606Z","steps":["trace[536695487] 'agreement among raft nodes before linearized reading' (duration: 116.454376ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:26:46.641258Z","caller":"traceutil/trace.go:171","msg":"trace[1418548286] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"101.28939ms","start":"2026-05-05T11:26:46.539943Z","end":"2026-05-05T11:26:46.641232Z","steps":["trace[1418548286] 'process raft request' (duration: 101.066543ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:26:46.804862Z","caller":"traceutil/trace.go:171","msg":"trace[1909287925] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"157.522648ms","start":"2026-05-05T11:26:46.647297Z","end":"2026-05-05T11:26:46.80482Z","steps":["trace[1909287925] 'process raft request' (duration: 120.829437ms)","trace[1909287925] 'compare' (duration: 36.480765ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:26:46.804905Z","caller":"traceutil/trace.go:171","msg":"trace[503728040] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"157.351983ms","start":"2026-05-05T11:26:46.647527Z","end":"2026-05-05T11:26:46.804879Z","steps":["trace[503728040] 'process raft request' (duration: 157.22622ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:26:46.805222Z","caller":"traceutil/trace.go:171","msg":"trace[1261401310] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2044; }","duration":"152.275583ms","start":"2026-05-05T11:26:46.652933Z","end":"2026-05-05T11:26:46.805209Z","steps":["trace[1261401310] 'read index received' (duration: 80.842866ms)","trace[1261401310] 'applied index is now lower than readState.Index' (duration: 71.431317ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:26:46.805353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.386616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:26:46.805396Z","caller":"traceutil/trace.go:171","msg":"trace[606890888] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1974; }","duration":"152.481699ms","start":"2026-05-05T11:26:46.652903Z","end":"2026-05-05T11:26:46.805384Z","steps":["trace[606890888] 'agreement among raft nodes before linearized reading' (duration: 152.385527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:26:46.828764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.946785ms","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-05-05T11:26:46.828867Z","caller":"traceutil/trace.go:171","msg":"trace[1645815093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1976; }","duration":"156.079359ms","start":"2026-05-05T11:26:46.672767Z","end":"2026-05-05T11:26:46.828847Z","steps":["trace[1645815093] 'agreement among raft nodes before linearized reading' (duration: 155.823032ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.206975Z","caller":"traceutil/trace.go:171","msg":"trace[177095136] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"178.258236ms","start":"2026-05-05T11:27:29.028689Z","end":"2026-05-05T11:27:29.206947Z","steps":["trace[177095136] 'process raft request' (duration: 178.085542ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.27767Z","caller":"traceutil/trace.go:171","msg":"trace[712858327] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"241.825309ms","start":"2026-05-05T11:27:29.035738Z","end":"2026-05-05T11:27:29.277564Z","steps":["trace[712858327] 'read index received' (duration: 171.525163ms)","trace[712858327] 'applied index is now lower than readState.Index' (duration: 70.298546ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:27:29.277706Z","caller":"traceutil/trace.go:171","msg":"trace[127042311] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"248.276044ms","start":"2026-05-05T11:27:29.029379Z","end":"2026-05-05T11:27:29.277655Z","steps":["trace[127042311] 'process raft request' (duration: 247.978386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:27:29.277836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.091786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:27:29.277896Z","caller":"traceutil/trace.go:171","msg":"trace[556591917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2212; }","duration":"242.227369ms","start":"2026-05-05T11:27:29.035651Z","end":"2026-05-05T11:27:29.277879Z","steps":["trace[556591917] 'agreement among raft nodes before linearized reading' (duration: 242.109756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:27:29.278179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.901078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T11:27:29.278291Z","caller":"traceutil/trace.go:171","msg":"trace[1343131764] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2212; }","duration":"174.112104ms","start":"2026-05-05T11:27:29.104164Z","end":"2026-05-05T11:27:29.278276Z","steps":["trace[1343131764] 'agreement among raft nodes before linearized reading' (duration: 173.805826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:27:29.278504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.977806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-05T11:27:29.278519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.941307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T11:27:29.278496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.633198ms","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-05-05T11:27:29.278557Z","caller":"traceutil/trace.go:171","msg":"trace[1148724808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2212; }","duration":"219.069918ms","start":"2026-05-05T11:27:29.059475Z","end":"2026-05-05T11:27:29.278545Z","steps":["trace[1148724808] 'agreement among raft nodes before linearized reading' (duration: 218.926664ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.278563Z","caller":"traceutil/trace.go:171","msg":"trace[1463455029] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2212; }","duration":"102.04154ms","start":"2026-05-05T11:27:29.176509Z","end":"2026-05-05T11:27:29.278551Z","steps":["trace[1463455029] 'agreement among raft nodes before linearized reading' (duration: 101.963418ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.278598Z","caller":"traceutil/trace.go:171","msg":"trace[1244018323] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2212; }","duration":"181.806433ms","start":"2026-05-05T11:27:29.096769Z","end":"2026-05-05T11:27:29.278576Z","steps":["trace[1244018323] 'agreement among raft nodes before linearized reading' (duration: 181.381512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:27:29.278807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.185858ms","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-05-05T11:27:29.278903Z","caller":"traceutil/trace.go:171","msg":"trace[1402084418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2212; }","duration":"224.351522ms","start":"2026-05-05T11:27:29.054527Z","end":"2026-05-05T11:27:29.278878Z","steps":["trace[1402084418] 'agreement among raft nodes before linearized reading' (duration: 223.384176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:27:29.495005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.598226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:27:29.49525Z","caller":"traceutil/trace.go:171","msg":"trace[1529062836] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"211.837921ms","start":"2026-05-05T11:27:29.283372Z","end":"2026-05-05T11:27:29.49521Z","steps":["trace[1529062836] 'process raft request' (duration: 79.686641ms)","trace[1529062836] 'compare' (duration: 131.236285ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:27:29.495667Z","caller":"traceutil/trace.go:171","msg":"trace[476725137] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"211.575824ms","start":"2026-05-05T11:27:29.284065Z","end":"2026-05-05T11:27:29.495641Z","steps":["trace[476725137] 'process raft request' (duration: 211.405669ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.49566Z","caller":"traceutil/trace.go:171","msg":"trace[25190172] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"211.79157ms","start":"2026-05-05T11:27:29.283822Z","end":"2026-05-05T11:27:29.495613Z","steps":["trace[25190172] 'process raft request' (duration: 211.398039ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.495832Z","caller":"traceutil/trace.go:171","msg":"trace[2082622593] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"210.943137ms","start":"2026-05-05T11:27:29.284838Z","end":"2026-05-05T11:27:29.495781Z","steps":["trace[2082622593] 'process raft request' (duration: 210.727631ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:27:29.671755Z","caller":"traceutil/trace.go:171","msg":"trace[1615580250] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"170.627509ms","start":"2026-05-05T11:27:29.501099Z","end":"2026-05-05T11:27:29.671726Z","steps":["trace[1615580250] 'process raft request' (duration: 164.486592ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:28:37.691321Z","caller":"traceutil/trace.go:171","msg":"trace[1526154333] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"117.24962ms","start":"2026-05-05T11:28:37.574031Z","end":"2026-05-05T11:28:37.69128Z","steps":["trace[1526154333] 'process raft request' (duration: 67.953693ms)","trace[1526154333] 'compare' (duration: 48.533996ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:28:38.149341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.67696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:28:38.149535Z","caller":"traceutil/trace.go:171","msg":"trace[1552393458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2785; }","duration":"114.917057ms","start":"2026-05-05T11:28:38.034596Z","end":"2026-05-05T11:28:38.149513Z","steps":["trace[1552393458] 'range keys from in-memory index tree' (duration: 114.611809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:28:38.149571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.098602ms","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-05-05T11:28:38.149652Z","caller":"traceutil/trace.go:171","msg":"trace[1437338967] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2785; }","duration":"132.248827ms","start":"2026-05-05T11:28:38.017383Z","end":"2026-05-05T11:28:38.149632Z","steps":["trace[1437338967] 'range keys from in-memory index tree' (duration: 131.879037ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:28:38.324748Z","caller":"traceutil/trace.go:171","msg":"trace[742343755] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"167.248144ms","start":"2026-05-05T11:28:38.157471Z","end":"2026-05-05T11:28:38.324719Z","steps":["trace[742343755] 'process raft request' (duration: 167.025108ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:31:14.88002Z","caller":"traceutil/trace.go:171","msg":"trace[1487455477] transaction","detail":"{read_only:false; response_revision:3806; number_of_response:1; }","duration":"207.541755ms","start":"2026-05-05T11:31:14.672444Z","end":"2026-05-05T11:31:14.879985Z","steps":["trace[1487455477] 'process raft request' (duration: 147.402661ms)","trace[1487455477] 'compare' (duration: 59.790075ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:31:14.880286Z","caller":"traceutil/trace.go:171","msg":"trace[1298630414] transaction","detail":"{read_only:false; response_revision:3807; number_of_response:1; }","duration":"207.804312ms","start":"2026-05-05T11:31:14.672454Z","end":"2026-05-05T11:31:14.880258Z","steps":["trace[1298630414] 'process raft request' (duration: 207.455402ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:31:14.880623Z","caller":"traceutil/trace.go:171","msg":"trace[179287144] transaction","detail":"{read_only:false; response_revision:3808; number_of_response:1; }","duration":"207.672238ms","start":"2026-05-05T11:31:14.672906Z","end":"2026-05-05T11:31:14.880579Z","steps":["trace[179287144] 'process raft request' (duration: 207.268117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:39.184227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.493814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:32:39.184423Z","caller":"traceutil/trace.go:171","msg":"trace[649003545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4862; }","duration":"151.354777ms","start":"2026-05-05T11:32:39.033032Z","end":"2026-05-05T11:32:39.184387Z","steps":["trace[649003545] 'range keys from in-memory index tree' (duration: 150.379951ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:32:39.361943Z","caller":"traceutil/trace.go:171","msg":"trace[1573748448] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"171.648635ms","start":"2026-05-05T11:32:39.190237Z","end":"2026-05-05T11:32:39.361885Z","steps":["trace[1573748448] 'process raft request' (duration: 171.371857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:43.488458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.07338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-211ef3f6-2a4d-4bf2-a3bb-662ce5724036\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-05-05T11:32:43.488495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.166215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:32:43.488542Z","caller":"traceutil/trace.go:171","msg":"trace[1341150871] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-211ef3f6-2a4d-4bf2-a3bb-662ce5724036; range_end:; response_count:1; response_revision:4990; }","duration":"164.166602ms","start":"2026-05-05T11:32:43.324358Z","end":"2026-05-05T11:32:43.488524Z","steps":["trace[1341150871] 'range keys from in-memory index tree' (duration: 163.949037ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:32:43.48859Z","caller":"traceutil/trace.go:171","msg":"trace[1222754069] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4990; }","duration":"170.314719ms","start":"2026-05-05T11:32:43.318253Z","end":"2026-05-05T11:32:43.488568Z","steps":["trace[1222754069] 'range keys from in-memory index tree' (duration: 170.087562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:43.488707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.333806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-05T11:32:43.488721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.299658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T11:32:43.488816Z","caller":"traceutil/trace.go:171","msg":"trace[3204120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4990; }","duration":"100.439912ms","start":"2026-05-05T11:32:43.388356Z","end":"2026-05-05T11:32:43.488796Z","steps":["trace[3204120] 'range keys from in-memory index tree' (duration: 100.095183ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:32:43.488811Z","caller":"traceutil/trace.go:171","msg":"trace[1221184980] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4990; }","duration":"111.51517ms","start":"2026-05-05T11:32:43.377271Z","end":"2026-05-05T11:32:43.488787Z","steps":["trace[1221184980] 'range keys from in-memory index tree' (duration: 111.10795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:43.844925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.056346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:32:43.845099Z","caller":"traceutil/trace.go:171","msg":"trace[1103358018] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"156.655349ms","start":"2026-05-05T11:32:43.688399Z","end":"2026-05-05T11:32:43.845054Z","steps":["trace[1103358018] 'process raft request' (duration: 21.380327ms)","trace[1103358018] 'compare' (duration: 134.909753ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:32:44.007065Z","caller":"traceutil/trace.go:171","msg":"trace[845153897] linearizableReadLoop","detail":"{readStateIndex:5193; appliedIndex:5191; }","duration":"100.893914ms","start":"2026-05-05T11:32:43.906134Z","end":"2026-05-05T11:32:44.007028Z","steps":["trace[845153897] 'read index received' (duration: 21.086389ms)","trace[845153897] 'applied index is now lower than readState.Index' (duration: 79.805875ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:32:44.007234Z","caller":"traceutil/trace.go:171","msg":"trace[10617465] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"101.313676ms","start":"2026-05-05T11:32:43.905888Z","end":"2026-05-05T11:32:44.007202Z","steps":["trace[10617465] 'process raft request' (duration: 100.873884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:44.007729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.566693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62911"} {"level":"info","ts":"2026-05-05T11:32:44.00779Z","caller":"traceutil/trace.go:171","msg":"trace[501817446] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:5006; }","duration":"101.697047ms","start":"2026-05-05T11:32:43.90608Z","end":"2026-05-05T11:32:44.007777Z","steps":["trace[501817446] 'agreement among raft nodes before linearized reading' (duration: 101.142822ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:32:54.729155Z","caller":"traceutil/trace.go:171","msg":"trace[1409369149] linearizableReadLoop","detail":"{readStateIndex:5426; appliedIndex:5425; }","duration":"153.452864ms","start":"2026-05-05T11:32:54.575671Z","end":"2026-05-05T11:32:54.729124Z","steps":["trace[1409369149] 'read index received' (duration: 153.288559ms)","trace[1409369149] 'applied index is now lower than readState.Index' (duration: 163.025µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:32:54.729275Z","caller":"traceutil/trace.go:171","msg":"trace[1057249539] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"154.887432ms","start":"2026-05-05T11:32:54.574356Z","end":"2026-05-05T11:32:54.729243Z","steps":["trace[1057249539] 'process raft request' (duration: 154.532132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:54.729512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.811483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:124100"} {"level":"info","ts":"2026-05-05T11:32:54.729565Z","caller":"traceutil/trace.go:171","msg":"trace[742510526] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5232; }","duration":"153.914936ms","start":"2026-05-05T11:32:54.575634Z","end":"2026-05-05T11:32:54.729549Z","steps":["trace[742510526] 'agreement among raft nodes before linearized reading' (duration: 153.659649ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:32:55.385518Z","caller":"traceutil/trace.go:171","msg":"trace[2066672293] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"399.061246ms","start":"2026-05-05T11:32:54.986416Z","end":"2026-05-05T11:32:55.385478Z","steps":["trace[2066672293] 'process raft request' (duration: 390.262108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:55.385761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:32:54.986388Z","time spent":"399.24606ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8038,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:32:55.387895Z","caller":"traceutil/trace.go:171","msg":"trace[72744950] linearizableReadLoop","detail":"{readStateIndex:5435; appliedIndex:5433; }","duration":"373.552347ms","start":"2026-05-05T11:32:55.014299Z","end":"2026-05-05T11:32:55.387851Z","steps":["trace[72744950] 'read index received' (duration: 362.399466ms)","trace[72744950] 'applied index is now lower than readState.Index' (duration: 11.151421ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:32:55.388212Z","caller":"traceutil/trace.go:171","msg":"trace[630761964] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"377.657127ms","start":"2026-05-05T11:32:55.010537Z","end":"2026-05-05T11:32:55.388194Z","steps":["trace[630761964] 'process raft request' (duration: 377.000589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:55.388481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:32:55.010504Z","time spent":"377.76256ms","remote":"127.0.0.1:36560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1409,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T11:32:55.388941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.641346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T11:32:55.389003Z","caller":"traceutil/trace.go:171","msg":"trace[1674666542] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:5241; }","duration":"374.770289ms","start":"2026-05-05T11:32:55.014219Z","end":"2026-05-05T11:32:55.388989Z","steps":["trace[1674666542] 'agreement among raft nodes before linearized reading' (duration: 374.550114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:55.389285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:32:55.014193Z","time spent":"374.962745ms","remote":"127.0.0.1:36616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":27,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-05-05T11:32:55.389783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.15096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:32:55.390018Z","caller":"traceutil/trace.go:171","msg":"trace[690050192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5241; }","duration":"158.372676ms","start":"2026-05-05T11:32:55.231552Z","end":"2026-05-05T11:32:55.389925Z","steps":["trace[690050192] 'agreement among raft nodes before linearized reading' (duration: 158.103529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:32:55.390162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.182188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T11:32:55.390248Z","caller":"traceutil/trace.go:171","msg":"trace[1957761945] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:5241; }","duration":"139.291601ms","start":"2026-05-05T11:32:55.250939Z","end":"2026-05-05T11:32:55.390231Z","steps":["trace[1957761945] 'agreement among raft nodes before linearized reading' (duration: 139.066735ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:33:03.264139Z","caller":"traceutil/trace.go:171","msg":"trace[1120862466] linearizableReadLoop","detail":"{readStateIndex:5596; appliedIndex:5595; }","duration":"124.220974ms","start":"2026-05-05T11:33:03.139889Z","end":"2026-05-05T11:33:03.26411Z","steps":["trace[1120862466] 'read index received' (duration: 124.005058ms)","trace[1120862466] 'applied index is now lower than readState.Index' (duration: 214.766µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:33:03.264202Z","caller":"traceutil/trace.go:171","msg":"trace[231354644] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"186.876166ms","start":"2026-05-05T11:33:03.077283Z","end":"2026-05-05T11:33:03.264159Z","steps":["trace[231354644] 'process raft request' (duration: 186.63636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:33:03.264445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.508362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-05-05T11:33:03.264518Z","caller":"traceutil/trace.go:171","msg":"trace[1410378609] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5397; }","duration":"124.679037ms","start":"2026-05-05T11:33:03.139821Z","end":"2026-05-05T11:33:03.2645Z","steps":["trace[1410378609] 'agreement among raft nodes before linearized reading' (duration: 124.44042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:33:03.264686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.09051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2d4d952a-5898-4db6-af35-7edc3c4fadf9\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-05T11:33:03.264828Z","caller":"traceutil/trace.go:171","msg":"trace[1891929795] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2d4d952a-5898-4db6-af35-7edc3c4fadf9; range_end:; response_count:1; response_revision:5397; }","duration":"111.282344ms","start":"2026-05-05T11:33:03.153508Z","end":"2026-05-05T11:33:03.264791Z","steps":["trace[1891929795] 'agreement among raft nodes before linearized reading' (duration: 110.877863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:33:03.488059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.481094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:33:03.488326Z","caller":"traceutil/trace.go:171","msg":"trace[1686627700] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"217.270856ms","start":"2026-05-05T11:33:03.271018Z","end":"2026-05-05T11:33:03.488289Z","steps":["trace[1686627700] 'process raft request' (duration: 73.436183ms)","trace[1686627700] 'compare' (duration: 143.34392ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:33:03.48839Z","caller":"traceutil/trace.go:171","msg":"trace[499055217] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"216.406994ms","start":"2026-05-05T11:33:03.271963Z","end":"2026-05-05T11:33:03.48837Z","steps":["trace[499055217] 'process raft request' (duration: 216.330411ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:33:03.488451Z","caller":"traceutil/trace.go:171","msg":"trace[2117561687] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"216.857125ms","start":"2026-05-05T11:33:03.27158Z","end":"2026-05-05T11:33:03.488437Z","steps":["trace[2117561687] 'process raft request' (duration: 216.67219ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:33:03.488372Z","caller":"traceutil/trace.go:171","msg":"trace[507153005] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"216.955278ms","start":"2026-05-05T11:33:03.271389Z","end":"2026-05-05T11:33:03.488344Z","steps":["trace[507153005] 'process raft request' (duration: 216.792693ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:33:03.488719Z","caller":"traceutil/trace.go:171","msg":"trace[741696273] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"216.606438ms","start":"2026-05-05T11:33:03.272094Z","end":"2026-05-05T11:33:03.488701Z","steps":["trace[741696273] 'process raft request' (duration: 216.381072ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:33:03.48888Z","caller":"traceutil/trace.go:171","msg":"trace[1523357314] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"216.861856ms","start":"2026-05-05T11:33:03.272006Z","end":"2026-05-05T11:33:03.488868Z","steps":["trace[1523357314] 'process raft request' (duration: 216.325712ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:33:03.488983Z","caller":"traceutil/trace.go:171","msg":"trace[1891163396] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"213.528676ms","start":"2026-05-05T11:33:03.275439Z","end":"2026-05-05T11:33:03.488968Z","steps":["trace[1891163396] 'process raft request' (duration: 213.155566ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:34:22.15404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3027} {"level":"info","ts":"2026-05-05T11:34:22.238406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3027,"took":"82.486171ms","hash":4117434987,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":31670272,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-05T11:34:22.238494Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4117434987,"revision":3027,"compact-revision":-1} {"level":"warn","ts":"2026-05-05T11:39:14.364111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.910921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:39:14.364345Z","caller":"traceutil/trace.go:171","msg":"trace[1367072892] transaction","detail":"{read_only:false; response_revision:8251; number_of_response:1; }","duration":"572.128652ms","start":"2026-05-05T11:39:13.79218Z","end":"2026-05-05T11:39:14.364308Z","steps":["trace[1367072892] 'process raft request' (duration: 350.910733ms)","trace[1367072892] 'compare' (duration: 220.639663ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:39:14.364394Z","caller":"traceutil/trace.go:171","msg":"trace[628641631] transaction","detail":"{read_only:false; response_revision:8252; number_of_response:1; }","duration":"379.545254ms","start":"2026-05-05T11:39:13.984833Z","end":"2026-05-05T11:39:14.364378Z","steps":["trace[628641631] 'process raft request' (duration: 379.443431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.364642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:13.984808Z","time spent":"379.806901ms","remote":"127.0.0.1:36556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T11:39:14.364659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:13.792161Z","time spent":"572.238725ms","remote":"127.0.0.1:36412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":664,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:39:14.364621Z","caller":"traceutil/trace.go:171","msg":"trace[1701407316] linearizableReadLoop","detail":"{readStateIndex:8539; appliedIndex:8538; }","duration":"571.784552ms","start":"2026-05-05T11:39:13.792608Z","end":"2026-05-05T11:39:14.364393Z","steps":["trace[1701407316] 'read index received' (duration: 350.45086ms)","trace[1701407316] 'applied index is now lower than readState.Index' (duration: 221.328842ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:39:14.364905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.275396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19444"} {"level":"info","ts":"2026-05-05T11:39:14.364994Z","caller":"traceutil/trace.go:171","msg":"trace[1302092187] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8252; }","duration":"572.41796ms","start":"2026-05-05T11:39:13.792551Z","end":"2026-05-05T11:39:14.364969Z","steps":["trace[1302092187] 'agreement among raft nodes before linearized reading' (duration: 572.133172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.365033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:13.792535Z","time spent":"572.492681ms","remote":"127.0.0.1:36482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19467,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-05T11:39:14.36531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.276121ms","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-05-05T11:39:14.365343Z","caller":"traceutil/trace.go:171","msg":"trace[448559084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8253; }","duration":"355.351233ms","start":"2026-05-05T11:39:14.009984Z","end":"2026-05-05T11:39:14.365335Z","steps":["trace[448559084] 'agreement among raft nodes before linearized reading' (duration: 355.217309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.365365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:14.009971Z","time spent":"355.389763ms","remote":"127.0.0.1:36556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T11:39:14.365512Z","caller":"traceutil/trace.go:171","msg":"trace[70584115] transaction","detail":"{read_only:false; response_revision:8253; number_of_response:1; }","duration":"205.943027ms","start":"2026-05-05T11:39:14.159562Z","end":"2026-05-05T11:39:14.365505Z","steps":["trace[70584115] 'process raft request' (duration: 205.532076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.36581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.906774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:39:14.365875Z","caller":"traceutil/trace.go:171","msg":"trace[587649608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8253; }","duration":"331.017897ms","start":"2026-05-05T11:39:14.034837Z","end":"2026-05-05T11:39:14.365855Z","steps":["trace[587649608] 'agreement among raft nodes before linearized reading' (duration: 330.913974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.365913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:14.034811Z","time spent":"331.094039ms","remote":"127.0.0.1:36302","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-05-05T11:39:14.366017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.094927ms","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-05-05T11:39:14.366075Z","caller":"traceutil/trace.go:171","msg":"trace[177171547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8253; }","duration":"322.190419ms","start":"2026-05-05T11:39:14.043868Z","end":"2026-05-05T11:39:14.366058Z","steps":["trace[177171547] 'agreement among raft nodes before linearized reading' (duration: 321.901641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.366127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:14.043858Z","time spent":"322.255632ms","remote":"127.0.0.1:36556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T11:39:14.366151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.520604ms","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-05-05T11:39:14.366179Z","caller":"traceutil/trace.go:171","msg":"trace[746324884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8253; }","duration":"330.577205ms","start":"2026-05-05T11:39:14.035595Z","end":"2026-05-05T11:39:14.366172Z","steps":["trace[746324884] 'agreement among raft nodes before linearized reading' (duration: 330.499243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.366191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.128096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-05-05T11:39:14.366198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:14.035571Z","time spent":"330.622797ms","remote":"127.0.0.1:36556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T11:39:14.366218Z","caller":"traceutil/trace.go:171","msg":"trace[1250605474] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8253; }","duration":"130.210648ms","start":"2026-05-05T11:39:14.235998Z","end":"2026-05-05T11:39:14.366208Z","steps":["trace[1250605474] 'agreement among raft nodes before linearized reading' (duration: 130.132146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.366397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.502996ms","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-05-05T11:39:14.366496Z","caller":"traceutil/trace.go:171","msg":"trace[1360406242] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8253; }","duration":"329.64271ms","start":"2026-05-05T11:39:14.036829Z","end":"2026-05-05T11:39:14.366472Z","steps":["trace[1360406242] 'agreement among raft nodes before linearized reading' (duration: 329.310391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:14.366552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:39:14.036821Z","time spent":"329.721432ms","remote":"127.0.0.1:36556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T11:39:22.160971Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6118} {"level":"info","ts":"2026-05-05T11:39:22.258584Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6118,"took":"94.981509ms","hash":2697204423,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":23580672,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-05T11:39:22.258872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2697204423,"revision":6118,"compact-revision":3027} {"level":"info","ts":"2026-05-05T11:39:26.888068Z","caller":"traceutil/trace.go:171","msg":"trace[1655866961] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"112.378548ms","start":"2026-05-05T11:39:26.775663Z","end":"2026-05-05T11:39:26.888041Z","steps":["trace[1655866961] 'process raft request' (duration: 112.186132ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:39:28.563188Z","caller":"traceutil/trace.go:171","msg":"trace[500304508] transaction","detail":"{read_only:false; response_revision:8326; number_of_response:1; }","duration":"148.10422ms","start":"2026-05-05T11:39:28.415051Z","end":"2026-05-05T11:39:28.563156Z","steps":["trace[500304508] 'process raft request' (duration: 147.939125ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:39:28.565447Z","caller":"traceutil/trace.go:171","msg":"trace[1562033422] linearizableReadLoop","detail":"{readStateIndex:8619; appliedIndex:8617; }","duration":"122.168031ms","start":"2026-05-05T11:39:28.443265Z","end":"2026-05-05T11:39:28.565433Z","steps":["trace[1562033422] 'read index received' (duration: 119.720795ms)","trace[1562033422] 'applied index is now lower than readState.Index' (duration: 2.446026ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:39:28.565512Z","caller":"traceutil/trace.go:171","msg":"trace[14439283] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"144.019339ms","start":"2026-05-05T11:39:28.421486Z","end":"2026-05-05T11:39:28.565506Z","steps":["trace[14439283] 'process raft request' (duration: 143.864585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:28.565709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.621452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-05T11:39:28.565802Z","caller":"traceutil/trace.go:171","msg":"trace[1102187890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8327; }","duration":"116.720704ms","start":"2026-05-05T11:39:28.449055Z","end":"2026-05-05T11:39:28.565775Z","steps":["trace[1102187890] 'agreement among raft nodes before linearized reading' (duration: 116.483848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:28.565726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.122592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jp8s6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-05-05T11:39:28.565882Z","caller":"traceutil/trace.go:171","msg":"trace[86068882] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jp8s6; range_end:; response_count:1; response_revision:8327; }","duration":"108.336878ms","start":"2026-05-05T11:39:28.457537Z","end":"2026-05-05T11:39:28.565874Z","steps":["trace[86068882] 'agreement among raft nodes before linearized reading' (duration: 108.058141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:28.565919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.629013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-05T11:39:28.566016Z","caller":"traceutil/trace.go:171","msg":"trace[1824329574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8327; }","duration":"122.791167ms","start":"2026-05-05T11:39:28.443204Z","end":"2026-05-05T11:39:28.565995Z","steps":["trace[1824329574] 'agreement among raft nodes before linearized reading' (duration: 122.481289ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:39:56.776055Z","caller":"traceutil/trace.go:171","msg":"trace[1278222194] transaction","detail":"{read_only:false; response_revision:8532; number_of_response:1; }","duration":"105.588014ms","start":"2026-05-05T11:39:56.670441Z","end":"2026-05-05T11:39:56.776029Z","steps":["trace[1278222194] 'process raft request' (duration: 105.338338ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:39:56.796297Z","caller":"traceutil/trace.go:171","msg":"trace[2010300191] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"125.263015ms","start":"2026-05-05T11:39:56.671007Z","end":"2026-05-05T11:39:56.79627Z","steps":["trace[2010300191] 'process raft request' (duration: 123.179458ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:39:59.162572Z","caller":"traceutil/trace.go:171","msg":"trace[1241207724] transaction","detail":"{read_only:false; response_revision:8548; number_of_response:1; }","duration":"106.546531ms","start":"2026-05-05T11:39:59.056001Z","end":"2026-05-05T11:39:59.162548Z","steps":["trace[1241207724] 'process raft request' (duration: 106.393317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:39:59.382757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.21572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T11:39:59.382862Z","caller":"traceutil/trace.go:171","msg":"trace[735200410] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8548; }","duration":"126.413276ms","start":"2026-05-05T11:39:59.256426Z","end":"2026-05-05T11:39:59.38284Z","steps":["trace[735200410] 'count revisions from in-memory index tree' (duration: 126.101956ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:40:09.099159Z","caller":"traceutil/trace.go:171","msg":"trace[2092804603] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8644; }","duration":"113.326522ms","start":"2026-05-05T11:40:08.985809Z","end":"2026-05-05T11:40:09.099135Z","steps":["trace[2092804603] 'process raft request' (duration: 108.961055ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:40:09.109727Z","caller":"traceutil/trace.go:171","msg":"trace[1476800944] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"123.487127ms","start":"2026-05-05T11:40:08.986198Z","end":"2026-05-05T11:40:09.109685Z","steps":["trace[1476800944] 'process raft request' (duration: 123.23131ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:40:09.543551Z","caller":"traceutil/trace.go:171","msg":"trace[1346749885] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"127.174726ms","start":"2026-05-05T11:40:09.416347Z","end":"2026-05-05T11:40:09.543522Z","steps":["trace[1346749885] 'process raft request' (duration: 126.983791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:40:09.682434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.926131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T11:40:09.682554Z","caller":"traceutil/trace.go:171","msg":"trace[122298539] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8647; }","duration":"113.145578ms","start":"2026-05-05T11:40:09.569379Z","end":"2026-05-05T11:40:09.682524Z","steps":["trace[122298539] 'count revisions from in-memory index tree' (duration: 112.803329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:40:10.644378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.630535ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T11:40:10.644531Z","caller":"traceutil/trace.go:171","msg":"trace[941690829] linearizableReadLoop","detail":"{readStateIndex:8959; appliedIndex:8958; }","duration":"110.085716ms","start":"2026-05-05T11:40:10.534419Z","end":"2026-05-05T11:40:10.644505Z","steps":["trace[941690829] 'read index received' (duration: 4.191933ms)","trace[941690829] 'applied index is now lower than readState.Index' (duration: 105.891663ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:40:10.644924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.474116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-05T11:40:10.645025Z","caller":"traceutil/trace.go:171","msg":"trace[1965135111] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8653; }","duration":"110.601229ms","start":"2026-05-05T11:40:10.534401Z","end":"2026-05-05T11:40:10.645003Z","steps":["trace[1965135111] 'agreement among raft nodes before linearized reading' (duration: 110.238189ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:40:23.168399Z","caller":"traceutil/trace.go:171","msg":"trace[1764198251] linearizableReadLoop","detail":"{readStateIndex:9067; appliedIndex:9066; }","duration":"102.692986ms","start":"2026-05-05T11:40:23.065676Z","end":"2026-05-05T11:40:23.168369Z","steps":["trace[1764198251] 'read index received' (duration: 102.186392ms)","trace[1764198251] 'applied index is now lower than readState.Index' (duration: 505.514µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:40:23.168561Z","caller":"traceutil/trace.go:171","msg":"trace[962339242] transaction","detail":"{read_only:false; response_revision:8757; number_of_response:1; }","duration":"103.55602ms","start":"2026-05-05T11:40:23.064992Z","end":"2026-05-05T11:40:23.168548Z","steps":["trace[962339242] 'process raft request' (duration: 103.21542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:40:23.168914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.20794ms","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-05-05T11:40:23.169015Z","caller":"traceutil/trace.go:171","msg":"trace[1149816385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8757; }","duration":"103.333444ms","start":"2026-05-05T11:40:23.065659Z","end":"2026-05-05T11:40:23.168993Z","steps":["trace[1149816385] 'agreement among raft nodes before linearized reading' (duration: 103.159939ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:40:26.420951Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023cb.wal"} {"level":"info","ts":"2026-05-05T11:42:01.790503Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T11:42:01.796981Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-05T11:42:01.797128Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-05T11:44:22.167454Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8294} {"level":"info","ts":"2026-05-05T11:44:22.255094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8294,"took":"84.796216ms","hash":589741822,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":25374720,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-05-05T11:44:22.25519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":589741822,"revision":8294,"compact-revision":6118} {"level":"warn","ts":"2026-05-05T11:44:53.272874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.875737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jp8s6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-05-05T11:44:53.272987Z","caller":"traceutil/trace.go:171","msg":"trace[2087783639] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jp8s6; range_end:; response_count:1; response_revision:11156; }","duration":"102.051612ms","start":"2026-05-05T11:44:53.170913Z","end":"2026-05-05T11:44:53.272965Z","steps":["trace[2087783639] 'range keys from in-memory index tree' (duration: 101.667371ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:45:12.244959Z","caller":"traceutil/trace.go:171","msg":"trace[1712313334] transaction","detail":"{read_only:false; response_revision:11259; number_of_response:1; }","duration":"120.719195ms","start":"2026-05-05T11:45:12.124185Z","end":"2026-05-05T11:45:12.244905Z","steps":["trace[1712313334] 'process raft request' (duration: 86.097812ms)","trace[1712313334] 'compare' (duration: 34.429978ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:49:22.180923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10788} {"level":"info","ts":"2026-05-05T11:49:22.262553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10788,"took":"79.290907ms","hash":2591362405,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":26689536,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-05T11:49:22.262621Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2591362405,"revision":10788,"compact-revision":8294} {"level":"info","ts":"2026-05-05T11:54:22.187991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12864} {"level":"info","ts":"2026-05-05T11:54:22.268326Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12864,"took":"77.600151ms","hash":2439544100,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":24244224,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-05T11:54:22.268388Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2439544100,"revision":12864,"compact-revision":10788} {"level":"info","ts":"2026-05-05T11:59:22.195045Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14671} {"level":"info","ts":"2026-05-05T11:59:22.266882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14671,"took":"69.199915ms","hash":2046932772,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":20897792,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-05T11:59:22.266965Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2046932772,"revision":14671,"compact-revision":12864} {"level":"info","ts":"2026-05-05T12:03:15.918312Z","caller":"traceutil/trace.go:171","msg":"trace[223456598] transaction","detail":"{read_only:false; response_revision:17413; number_of_response:1; }","duration":"115.763915ms","start":"2026-05-05T12:03:15.802515Z","end":"2026-05-05T12:03:15.918279Z","steps":["trace[223456598] 'process raft request' (duration: 115.574809ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T12:04:22.202105Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16194} {"level":"info","ts":"2026-05-05T12:04:22.272219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16194,"took":"67.492751ms","hash":1159502562,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":20537344,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-05-05T12:04:22.272291Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1159502562,"revision":16194,"compact-revision":14671} {"level":"info","ts":"2026-05-05T12:09:22.209426Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17747} {"level":"info","ts":"2026-05-05T12:09:22.23674Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T12:09:22.24284Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-05T12:09:22.242992Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-05T12:09:22.281591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17747,"took":"69.613639ms","hash":1751398073,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":20602880,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-05T12:09:22.281648Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1751398073,"revision":17747,"compact-revision":16194} {"level":"info","ts":"2026-05-05T12:14:22.216628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19302} {"level":"info","ts":"2026-05-05T12:14:22.283768Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19302,"took":"64.904871ms","hash":3869687051,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":20574208,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-05T12:14:22.283849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3869687051,"revision":19302,"compact-revision":17747} {"level":"info","ts":"2026-05-05T12:19:22.223171Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20848} {"level":"info","ts":"2026-05-05T12:19:22.295551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20848,"took":"69.688501ms","hash":1003139613,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":20512768,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-05-05T12:19:22.295632Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1003139613,"revision":20848,"compact-revision":19302}