{"level":"warn","ts":"2026-04-27T01:23:07.540212Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T01:23:07.540336Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T01:23:07.540415Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T01:23:07.540433Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-27T01:23:07.540456Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T01:23:07.541228Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-04-27T01:23:07.541319Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T01:23:07.543836Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.254997ms"} {"level":"info","ts":"2026-04-27T01:23:07.549861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-04-27T01:23:07.549934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T01:23:07.549956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-04-27T01:23:07.549965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T01:23:07.549976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-04-27T01:23:07.550016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-04-27T01:23:07.557242Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T01:23:07.558619Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T01:23:07.560079Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T01:23:07.562775Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T01:23:07.563481Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T01:23:07.563596Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T01:23:07.56364Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T01:23:07.563651Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T01:23:07.56589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-04-27T01:23:07.56607Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-27T01:23:07.569348Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T01:23:07.569594Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T01:23:07.569625Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T01:23:07.569735Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-27T01:23:07.569752Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-27T01:23:08.550534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T01:23:08.550598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T01:23:08.550633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-04-27T01:23:08.550658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-04-27T01:23:08.55067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-27T01:23:08.550687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-04-27T01:23:08.550707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-27T01:23:08.551784Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:08.552692Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T01:23:08.552732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:23:08.552913Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:23:08.553041Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T01:23:08.553143Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T01:23:08.554467Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:08.554661Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:08.554704Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:08.556205Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T01:23:08.557052Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"warn","ts":"2026-04-27T01:23:12.036079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.367754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:23:12.036261Z","caller":"traceutil/trace.go:171","msg":"trace[1624792312] linearizableReadLoop","detail":"{readStateIndex:191; appliedIndex:190; }","duration":"108.677668ms","start":"2026-04-27T01:23:11.927561Z","end":"2026-04-27T01:23:12.036238Z","steps":["trace[1624792312] 'read index received' (duration: 38.43µs)","trace[1624792312] 'applied index is now lower than readState.Index' (duration: 108.637588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:12.036477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.882502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:12.036413Z","caller":"traceutil/trace.go:171","msg":"trace[945413164] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"579.357428ms","start":"2026-04-27T01:23:11.456943Z","end":"2026-04-27T01:23:12.036301Z","steps":["trace[945413164] 'process raft request' (duration: 209.461843ms)","trace[945413164] 'compare' (duration: 368.160322ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:23:12.036524Z","caller":"traceutil/trace.go:171","msg":"trace[1775270112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:187; }","duration":"109.025382ms","start":"2026-04-27T01:23:11.927487Z","end":"2026-04-27T01:23:12.036512Z","steps":["trace[1775270112] 'agreement among raft nodes before linearized reading' (duration: 108.85315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:12.036702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:11.456934Z","time spent":"579.648702ms","remote":"127.0.0.1:36244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":793,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T01:23:41.647697Z","caller":"traceutil/trace.go:171","msg":"trace[857021660] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"203.763823ms","start":"2026-04-27T01:23:41.443906Z","end":"2026-04-27T01:23:41.64767Z","steps":["trace[857021660] 'process raft request' (duration: 202.848007ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:41.647743Z","caller":"traceutil/trace.go:171","msg":"trace[285059311] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"194.683136ms","start":"2026-04-27T01:23:41.453033Z","end":"2026-04-27T01:23:41.647716Z","steps":["trace[285059311] 'process raft request' (duration: 194.572605ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:41.654696Z","caller":"traceutil/trace.go:171","msg":"trace[377480918] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:522; }","duration":"121.271131ms","start":"2026-04-27T01:23:41.533404Z","end":"2026-04-27T01:23:41.654675Z","steps":["trace[377480918] 'read index received' (duration: 113.379232ms)","trace[377480918] 'applied index is now lower than readState.Index' (duration: 7.890919ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:41.654829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.406482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T01:23:41.65487Z","caller":"traceutil/trace.go:171","msg":"trace[1724165260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:503; }","duration":"121.454303ms","start":"2026-04-27T01:23:41.533396Z","end":"2026-04-27T01:23:41.654851Z","steps":["trace[1724165260] 'agreement among raft nodes before linearized reading' (duration: 121.356333ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:41.655303Z","caller":"traceutil/trace.go:171","msg":"trace[953996098] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"158.810093ms","start":"2026-04-27T01:23:41.496481Z","end":"2026-04-27T01:23:41.655291Z","steps":["trace[953996098] 'process raft request' (duration: 157.976088ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:41.655455Z","caller":"traceutil/trace.go:171","msg":"trace[1172566549] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"102.721486ms","start":"2026-04-27T01:23:41.552724Z","end":"2026-04-27T01:23:41.655446Z","steps":["trace[1172566549] 'process raft request' (duration: 101.886532ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:41.816704Z","caller":"traceutil/trace.go:171","msg":"trace[1192132321] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"122.016646ms","start":"2026-04-27T01:23:41.694098Z","end":"2026-04-27T01:23:41.816114Z","steps":["trace[1192132321] 'process raft request' (duration: 115.873188ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:41.817098Z","caller":"traceutil/trace.go:171","msg":"trace[403832297] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"115.010332ms","start":"2026-04-27T01:23:41.702076Z","end":"2026-04-27T01:23:41.817086Z","steps":["trace[403832297] 'process raft request' (duration: 114.570929ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:47.729668Z","caller":"traceutil/trace.go:171","msg":"trace[267010976] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"417.993549ms","start":"2026-04-27T01:23:47.311634Z","end":"2026-04-27T01:23:47.729628Z","steps":["trace[267010976] 'process raft request' (duration: 378.515967ms)","trace[267010976] 'compare' (duration: 39.051218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:47.730414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:47.311596Z","time spent":"418.224508ms","remote":"127.0.0.1:36010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:23:48.052832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.328681ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-27T01:23:48.053198Z","caller":"traceutil/trace.go:171","msg":"trace[1025428476] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"390.463718ms","start":"2026-04-27T01:23:47.662665Z","end":"2026-04-27T01:23:48.053128Z","steps":["trace[1025428476] 'read index received' (duration: 27.231819ms)","trace[1025428476] 'applied index is now lower than readState.Index' (duration: 363.229099ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:23:48.053233Z","caller":"traceutil/trace.go:171","msg":"trace[1798316917] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"268.420058ms","start":"2026-04-27T01:23:47.784766Z","end":"2026-04-27T01:23:48.053186Z","steps":["trace[1798316917] 'process raft request' (duration: 268.20505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.053454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.071776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:23:48.053551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.450453ms","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":"warn","ts":"2026-04-27T01:23:48.053494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.588094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T01:23:48.053596Z","caller":"traceutil/trace.go:171","msg":"trace[453219049] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:575; }","duration":"251.529466ms","start":"2026-04-27T01:23:47.802054Z","end":"2026-04-27T01:23:48.053584Z","steps":["trace[453219049] 'agreement among raft nodes before linearized reading' (duration: 251.463253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.053595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.797213ms","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":"warn","ts":"2026-04-27T01:23:48.053692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.273218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.053726Z","caller":"traceutil/trace.go:171","msg":"trace[795424499] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"120.31508ms","start":"2026-04-27T01:23:47.933399Z","end":"2026-04-27T01:23:48.053714Z","steps":["trace[795424499] 'agreement among raft nodes before linearized reading' (duration: 120.271488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.053789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.095249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.053874Z","caller":"traceutil/trace.go:171","msg":"trace[930717243] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:575; }","duration":"186.147151ms","start":"2026-04-27T01:23:47.867673Z","end":"2026-04-27T01:23:48.05382Z","steps":["trace[930717243] 'agreement among raft nodes before linearized reading' (duration: 186.084548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.053935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.469403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.053976Z","caller":"traceutil/trace.go:171","msg":"trace[1701640515] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:575; }","duration":"291.545565ms","start":"2026-04-27T01:23:47.762418Z","end":"2026-04-27T01:23:48.053964Z","steps":["trace[1701640515] 'agreement among raft nodes before linearized reading' (duration: 291.494584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.053647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.346057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.053597Z","caller":"traceutil/trace.go:171","msg":"trace[2122825209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"337.74665ms","start":"2026-04-27T01:23:47.715842Z","end":"2026-04-27T01:23:48.053588Z","steps":["trace[2122825209] 'agreement among raft nodes before linearized reading' (duration: 337.479801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.256939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054183Z","caller":"traceutil/trace.go:171","msg":"trace[1185048183] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:575; }","duration":"292.320451ms","start":"2026-04-27T01:23:47.761854Z","end":"2026-04-27T01:23:48.054175Z","steps":["trace[1185048183] 'agreement among raft nodes before linearized reading' (duration: 292.26833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:47.715784Z","time spent":"338.382911ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T01:23:48.054166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.398866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:23:48.054288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.644187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054317Z","caller":"traceutil/trace.go:171","msg":"trace[1197008484] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:575; }","duration":"150.606664ms","start":"2026-04-27T01:23:47.903675Z","end":"2026-04-27T01:23:48.054282Z","steps":["trace[1197008484] 'agreement among raft nodes before linearized reading' (duration: 150.265053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.924904ms","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":"warn","ts":"2026-04-27T01:23:48.054394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.262418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054418Z","caller":"traceutil/trace.go:171","msg":"trace[1949957522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:575; }","duration":"151.055479ms","start":"2026-04-27T01:23:47.903346Z","end":"2026-04-27T01:23:48.054401Z","steps":["trace[1949957522] 'agreement among raft nodes before linearized reading' (duration: 150.807341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.621144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054576Z","caller":"traceutil/trace.go:171","msg":"trace[1069519926] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"121.688096ms","start":"2026-04-27T01:23:47.932876Z","end":"2026-04-27T01:23:48.054564Z","steps":["trace[1069519926] 'agreement among raft nodes before linearized reading' (duration: 121.631594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.053889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.874497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054696Z","caller":"traceutil/trace.go:171","msg":"trace[7590066] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:575; }","duration":"252.702666ms","start":"2026-04-27T01:23:47.801981Z","end":"2026-04-27T01:23:48.054684Z","steps":["trace[7590066] 'agreement among raft nodes before linearized reading' (duration: 251.876038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.546974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054775Z","caller":"traceutil/trace.go:171","msg":"trace[821534212] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:575; }","duration":"187.100113ms","start":"2026-04-27T01:23:47.867659Z","end":"2026-04-27T01:23:48.054759Z","steps":["trace[821534212] 'agreement among raft nodes before linearized reading' (duration: 186.501382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.050955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.054945Z","caller":"traceutil/trace.go:171","msg":"trace[1607997815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:575; }","duration":"228.150269ms","start":"2026-04-27T01:23:47.826785Z","end":"2026-04-27T01:23:48.054935Z","steps":["trace[1607997815] 'agreement among raft nodes before linearized reading' (duration: 228.046545ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:48.054339Z","caller":"traceutil/trace.go:171","msg":"trace[1032938415] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:575; }","duration":"186.722929ms","start":"2026-04-27T01:23:47.867602Z","end":"2026-04-27T01:23:48.054325Z","steps":["trace[1032938415] 'agreement among raft nodes before linearized reading' (duration: 186.659707ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:48.053551Z","caller":"traceutil/trace.go:171","msg":"trace[488545350] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:575; }","duration":"150.213671ms","start":"2026-04-27T01:23:47.903315Z","end":"2026-04-27T01:23:48.053528Z","steps":["trace[488545350] 'agreement among raft nodes before linearized reading' (duration: 150.035465ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:48.054118Z","caller":"traceutil/trace.go:171","msg":"trace[1514427402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:575; }","duration":"115.753712ms","start":"2026-04-27T01:23:47.938267Z","end":"2026-04-27T01:23:48.054021Z","steps":["trace[1514427402] 'agreement among raft nodes before linearized reading' (duration: 115.349589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.054368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.592451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.055253Z","caller":"traceutil/trace.go:171","msg":"trace[1127194624] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:575; }","duration":"293.507713ms","start":"2026-04-27T01:23:47.761733Z","end":"2026-04-27T01:23:48.055241Z","steps":["trace[1127194624] 'agreement among raft nodes before linearized reading' (duration: 292.602322ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:48.053722Z","caller":"traceutil/trace.go:171","msg":"trace[407623984] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:575; }","duration":"226.982419ms","start":"2026-04-27T01:23:47.826709Z","end":"2026-04-27T01:23:48.053691Z","steps":["trace[407623984] 'agreement among raft nodes before linearized reading' (duration: 226.762602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.05574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.077567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:48.055801Z","caller":"traceutil/trace.go:171","msg":"trace[2012258791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"393.189311ms","start":"2026-04-27T01:23:47.662597Z","end":"2026-04-27T01:23:48.055787Z","steps":["trace[2012258791] 'agreement among raft nodes before linearized reading' (duration: 390.687397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.055833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:47.662575Z","time spent":"393.251562ms","remote":"127.0.0.1:35904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T01:23:48.054434Z","caller":"traceutil/trace.go:171","msg":"trace[1443581174] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:575; }","duration":"227.31919ms","start":"2026-04-27T01:23:47.827104Z","end":"2026-04-27T01:23:48.054423Z","steps":["trace[1443581174] 'agreement among raft nodes before linearized reading' (duration: 227.259648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:48.222668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.165979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T01:23:48.222771Z","caller":"traceutil/trace.go:171","msg":"trace[218558645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"123.307293ms","start":"2026-04-27T01:23:48.099439Z","end":"2026-04-27T01:23:48.222747Z","steps":["trace[218558645] 'range keys from in-memory index tree' (duration: 123.006984ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:48.701782Z","caller":"traceutil/trace.go:171","msg":"trace[793986505] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"144.837518ms","start":"2026-04-27T01:23:48.556921Z","end":"2026-04-27T01:23:48.701759Z","steps":["trace[793986505] 'read index received' (duration: 143.899496ms)","trace[793986505] 'applied index is now lower than readState.Index' (duration: 936.572µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:48.702196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.225341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T01:23:48.702315Z","caller":"traceutil/trace.go:171","msg":"trace[1521210992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"145.380787ms","start":"2026-04-27T01:23:48.556897Z","end":"2026-04-27T01:23:48.702278Z","steps":["trace[1521210992] 'agreement among raft nodes before linearized reading' (duration: 145.010294ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:48.703016Z","caller":"traceutil/trace.go:171","msg":"trace[1159629077] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"202.301958ms","start":"2026-04-27T01:23:48.500516Z","end":"2026-04-27T01:23:48.702818Z","steps":["trace[1159629077] 'process raft request' (duration: 200.63049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.303792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.972727Z","time spent":"331.057098ms","remote":"127.0.0.1:41158","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-27T01:23:49.303893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.833051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304008Z","caller":"traceutil/trace.go:171","msg":"trace[282893307] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"539.015237ms","start":"2026-04-27T01:23:48.764957Z","end":"2026-04-27T01:23:49.303972Z","steps":["trace[282893307] 'range keys from in-memory index tree' (duration: 538.715457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.764929Z","time spent":"539.12378ms","remote":"127.0.0.1:41118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T01:23:49.304032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.910384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304144Z","caller":"traceutil/trace.go:171","msg":"trace[987346258] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:582; }","duration":"539.064099ms","start":"2026-04-27T01:23:48.765055Z","end":"2026-04-27T01:23:49.304119Z","steps":["trace[987346258] 'count revisions from in-memory index tree' (duration: 538.80777ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:49.304159Z","caller":"traceutil/trace.go:171","msg":"trace[1562105036] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"425.826388ms","start":"2026-04-27T01:23:48.878308Z","end":"2026-04-27T01:23:49.304134Z","steps":["trace[1562105036] 'read index received' (duration: 397.39268ms)","trace[1562105036] 'applied index is now lower than readState.Index' (duration: 28.432328ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:49.304203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.764979Z","time spent":"539.211693ms","remote":"127.0.0.1:41118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T01:23:49.304207Z","caller":"traceutil/trace.go:171","msg":"trace[503578487] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"521.202149ms","start":"2026-04-27T01:23:48.782965Z","end":"2026-04-27T01:23:49.304167Z","steps":["trace[503578487] 'process raft request' (duration: 492.837824ms)","trace[503578487] 'compare' (duration: 27.959472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:49.304354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.023154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:23:49.304356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.782946Z","time spent":"521.337234ms","remote":"127.0.0.1:36384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T01:23:49.304377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.970083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304403Z","caller":"traceutil/trace.go:171","msg":"trace[1288174020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:583; }","duration":"426.122227ms","start":"2026-04-27T01:23:48.878265Z","end":"2026-04-27T01:23:49.304387Z","steps":["trace[1288174020] 'agreement among raft nodes before linearized reading' (duration: 425.980543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.30441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.76772ms","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-04-27T01:23:49.304431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.878239Z","time spent":"426.18595ms","remote":"127.0.0.1:41126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-27T01:23:49.30446Z","caller":"traceutil/trace.go:171","msg":"trace[1900338972] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"277.863253ms","start":"2026-04-27T01:23:49.026577Z","end":"2026-04-27T01:23:49.30444Z","steps":["trace[1900338972] 'agreement among raft nodes before linearized reading' (duration: 277.795331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.3045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.764302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304529Z","caller":"traceutil/trace.go:171","msg":"trace[2080839368] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:583; }","duration":"302.808614ms","start":"2026-04-27T01:23:49.001711Z","end":"2026-04-27T01:23:49.304519Z","steps":["trace[2080839368] 'agreement among raft nodes before linearized reading' (duration: 302.771163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:49.0017Z","time spent":"302.858545ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T01:23:49.304629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.262402ms","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":"info","ts":"2026-04-27T01:23:49.304653Z","caller":"traceutil/trace.go:171","msg":"trace[663364965] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"258.334465ms","start":"2026-04-27T01:23:49.046312Z","end":"2026-04-27T01:23:49.304646Z","steps":["trace[663364965] 'agreement among raft nodes before linearized reading' (duration: 258.292194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.106546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304724Z","caller":"traceutil/trace.go:171","msg":"trace[1957733211] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"367.220779ms","start":"2026-04-27T01:23:48.937491Z","end":"2026-04-27T01:23:49.304712Z","steps":["trace[1957733211] 'agreement among raft nodes before linearized reading' (duration: 367.124506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.937441Z","time spent":"367.307792ms","remote":"127.0.0.1:41142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T01:23:49.304789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.387686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:23:49.304797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.921999ms","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":"info","ts":"2026-04-27T01:23:49.30482Z","caller":"traceutil/trace.go:171","msg":"trace[242126720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:583; }","duration":"426.430737ms","start":"2026-04-27T01:23:48.87838Z","end":"2026-04-27T01:23:49.304811Z","steps":["trace[242126720] 'agreement among raft nodes before linearized reading' (duration: 426.378936ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:49.304834Z","caller":"traceutil/trace.go:171","msg":"trace[2054513003] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"259.973711ms","start":"2026-04-27T01:23:49.04485Z","end":"2026-04-27T01:23:49.304823Z","steps":["trace[2054513003] 'agreement among raft nodes before linearized reading' (duration: 259.917308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.963035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:23:49.30485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.878375Z","time spent":"426.46659ms","remote":"127.0.0.1:41126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"info","ts":"2026-04-27T01:23:49.304879Z","caller":"traceutil/trace.go:171","msg":"trace[267528824] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"368.138531ms","start":"2026-04-27T01:23:48.936727Z","end":"2026-04-27T01:23:49.304866Z","steps":["trace[267528824] 'agreement among raft nodes before linearized reading' (duration: 367.965165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.549809ms","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":"info","ts":"2026-04-27T01:23:49.304923Z","caller":"traceutil/trace.go:171","msg":"trace[1114831160] 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:583; }","duration":"238.5742ms","start":"2026-04-27T01:23:49.066342Z","end":"2026-04-27T01:23:49.304916Z","steps":["trace[1114831160] 'agreement among raft nodes before linearized reading' (duration: 238.534629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.936706Z","time spent":"368.203254ms","remote":"127.0.0.1:41142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T01:23:49.304927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.925302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304962Z","caller":"traceutil/trace.go:171","msg":"trace[457957500] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:583; }","duration":"303.996465ms","start":"2026-04-27T01:23:49.000956Z","end":"2026-04-27T01:23:49.304952Z","steps":["trace[457957500] 'agreement among raft nodes before linearized reading' (duration: 303.938083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:49.000933Z","time spent":"304.052327ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T01:23:49.305001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.168097ms","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":"info","ts":"2026-04-27T01:23:49.305032Z","caller":"traceutil/trace.go:171","msg":"trace[353123973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"260.231239ms","start":"2026-04-27T01:23:49.044791Z","end":"2026-04-27T01:23:49.305023Z","steps":["trace[353123973] 'agreement among raft nodes before linearized reading' (duration: 260.177418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.305041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.664037ms","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-04-27T01:23:49.305062Z","caller":"traceutil/trace.go:171","msg":"trace[226454607] 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:583; }","duration":"239.706679ms","start":"2026-04-27T01:23:49.065349Z","end":"2026-04-27T01:23:49.305056Z","steps":["trace[226454607] 'agreement among raft nodes before linearized reading' (duration: 239.669097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.305098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.316887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.304417Z","caller":"traceutil/trace.go:171","msg":"trace[1861749320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:583; }","duration":"426.049355ms","start":"2026-04-27T01:23:48.878356Z","end":"2026-04-27T01:23:49.304406Z","steps":["trace[1861749320] 'agreement among raft nodes before linearized reading' (duration: 425.918301ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:49.305131Z","caller":"traceutil/trace.go:171","msg":"trace[948367566] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"368.38706ms","start":"2026-04-27T01:23:48.936733Z","end":"2026-04-27T01:23:49.305121Z","steps":["trace[948367566] 'agreement among raft nodes before linearized reading' (duration: 368.331608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.30515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.878351Z","time spent":"426.78723ms","remote":"127.0.0.1:41126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T01:23:49.305166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.936708Z","time spent":"368.449252ms","remote":"127.0.0.1:41142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T01:23:49.30518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.201882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.305223Z","caller":"traceutil/trace.go:171","msg":"trace[682712569] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:583; }","duration":"304.271934ms","start":"2026-04-27T01:23:49.000933Z","end":"2026-04-27T01:23:49.305205Z","steps":["trace[682712569] 'agreement among raft nodes before linearized reading' (duration: 304.210692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.304461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.048999ms","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-04-27T01:23:49.305288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:49.000917Z","time spent":"304.354277ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T01:23:49.305158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.816102ms","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-04-27T01:23:49.305308Z","caller":"traceutil/trace.go:171","msg":"trace[1144455857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"278.910348ms","start":"2026-04-27T01:23:49.026385Z","end":"2026-04-27T01:23:49.305295Z","steps":["trace[1144455857] 'agreement among raft nodes before linearized reading' (duration: 278.051139ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:49.305336Z","caller":"traceutil/trace.go:171","msg":"trace[1434941906] 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:583; }","duration":"240.016788ms","start":"2026-04-27T01:23:49.065308Z","end":"2026-04-27T01:23:49.305325Z","steps":["trace[1434941906] 'agreement among raft nodes before linearized reading' (duration: 239.823212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.305635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.258956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-95jfr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-27T01:23:49.305707Z","caller":"traceutil/trace.go:171","msg":"trace[1722462393] range","detail":"{range_begin:/registry/pods/kube-system/cilium-95jfr; range_end:; response_count:1; response_revision:583; }","duration":"334.334559ms","start":"2026-04-27T01:23:48.971363Z","end":"2026-04-27T01:23:49.305698Z","steps":["trace[1722462393] 'agreement among raft nodes before linearized reading' (duration: 334.010708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:49.305774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:48.971331Z","time spent":"334.392961ms","remote":"127.0.0.1:36100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-95jfr\" "} {"level":"info","ts":"2026-04-27T01:23:49.601374Z","caller":"traceutil/trace.go:171","msg":"trace[1276674739] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"284.136024ms","start":"2026-04-27T01:23:49.317188Z","end":"2026-04-27T01:23:49.601324Z","steps":["trace[1276674739] 'read index received' (duration: 202.625908ms)","trace[1276674739] 'applied index is now lower than readState.Index' (duration: 81.508416ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:49.601648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.422184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:49.601699Z","caller":"traceutil/trace.go:171","msg":"trace[302083060] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:584; }","duration":"284.505908ms","start":"2026-04-27T01:23:49.317174Z","end":"2026-04-27T01:23:49.60168Z","steps":["trace[302083060] 'agreement among raft nodes before linearized reading' (duration: 284.311921ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:49.601979Z","caller":"traceutil/trace.go:171","msg":"trace[148827099] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"288.674728ms","start":"2026-04-27T01:23:49.313273Z","end":"2026-04-27T01:23:49.601948Z","steps":["trace[148827099] 'process raft request' (duration: 206.419876ms)","trace[148827099] 'compare' (duration: 81.461315ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:23:49.602247Z","caller":"traceutil/trace.go:171","msg":"trace[1467135162] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"281.63176ms","start":"2026-04-27T01:23:49.320587Z","end":"2026-04-27T01:23:49.602219Z","steps":["trace[1467135162] 'process raft request' (duration: 281.408072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:50.27697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.964232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-27T01:23:50.27712Z","caller":"traceutil/trace.go:171","msg":"trace[169057986] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:590; }","duration":"155.188209ms","start":"2026-04-27T01:23:50.121903Z","end":"2026-04-27T01:23:50.277091Z","steps":["trace[169057986] 'range keys from in-memory index tree' (duration: 154.798117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:52.35926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.671642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:23:52.360577Z","caller":"traceutil/trace.go:171","msg":"trace[1333766425] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"173.971442ms","start":"2026-04-27T01:23:52.186583Z","end":"2026-04-27T01:23:52.360554Z","steps":["trace[1333766425] 'process raft request' (duration: 37.914894ms)","trace[1333766425] 'compare' (duration: 134.507868ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:24:37.503381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.959726ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-27T01:25:30.638519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.979291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-27T01:25:30.638612Z","caller":"traceutil/trace.go:171","msg":"trace[1763642527] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"330.133204ms","start":"2026-04-27T01:25:30.308458Z","end":"2026-04-27T01:25:30.638591Z","steps":["trace[1763642527] 'range keys from in-memory index tree' (duration: 329.735828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:30.638776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.934383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T01:25:30.638834Z","caller":"traceutil/trace.go:171","msg":"trace[694132060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1837; }","duration":"411.045614ms","start":"2026-04-27T01:25:30.227772Z","end":"2026-04-27T01:25:30.638818Z","steps":["trace[694132060] 'range keys from in-memory index tree' (duration: 410.766051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:30.638655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.308434Z","time spent":"330.212994ms","remote":"127.0.0.1:54168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-27T01:25:30.638866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.227734Z","time spent":"411.124966ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T01:25:30.639045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.093273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-04-27T01:25:30.63914Z","caller":"traceutil/trace.go:171","msg":"trace[379430446] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1837; }","duration":"382.246075ms","start":"2026-04-27T01:25:30.256873Z","end":"2026-04-27T01:25:30.639119Z","steps":["trace[379430446] 'range keys from in-memory index tree' (duration: 381.84283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:30.639186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.256846Z","time spent":"382.330396ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":551,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-27T01:25:30.644465Z","caller":"traceutil/trace.go:171","msg":"trace[1206459729] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"297.193657ms","start":"2026-04-27T01:25:30.347251Z","end":"2026-04-27T01:25:30.644445Z","steps":["trace[1206459729] 'process raft request' (duration: 297.062895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:30.644684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.910883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T01:25:30.644729Z","caller":"traceutil/trace.go:171","msg":"trace[759510025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1838; }","duration":"175.022385ms","start":"2026-04-27T01:25:30.469696Z","end":"2026-04-27T01:25:30.644718Z","steps":["trace[759510025] 'agreement among raft nodes before linearized reading' (duration: 174.843593ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:30.64451Z","caller":"traceutil/trace.go:171","msg":"trace[1115834220] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1913; }","duration":"174.722811ms","start":"2026-04-27T01:25:30.469768Z","end":"2026-04-27T01:25:30.644491Z","steps":["trace[1115834220] 'read index received' (duration: 174.705551ms)","trace[1115834220] 'applied index is now lower than readState.Index' (duration: 16.28µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:25:31.144178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.216282ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:25:31.144399Z","caller":"traceutil/trace.go:171","msg":"trace[1096129369] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1913; }","duration":"499.332796ms","start":"2026-04-27T01:25:30.645051Z","end":"2026-04-27T01:25:31.144384Z","steps":["trace[1096129369] 'read index received' (duration: 350.922331ms)","trace[1096129369] 'applied index is now lower than readState.Index' (duration: 148.409675ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:25:31.14446Z","caller":"traceutil/trace.go:171","msg":"trace[2040892868] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"500.815157ms","start":"2026-04-27T01:25:30.643637Z","end":"2026-04-27T01:25:31.144452Z","steps":["trace[2040892868] 'process raft request' (duration: 500.631075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.144511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.643613Z","time spent":"500.873947ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:25:31.144529Z","caller":"traceutil/trace.go:171","msg":"trace[1371294998] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"594.009928ms","start":"2026-04-27T01:25:30.550487Z","end":"2026-04-27T01:25:31.144497Z","steps":["trace[1371294998] 'process raft request' (duration: 445.39914ms)","trace[1371294998] 'compare' (duration: 148.02092ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:25:31.144681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.550467Z","time spent":"594.135399ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:25:31.144704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.000384ms","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-04-27T01:25:31.144758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.710435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7062a44e-740f-4863-9004-5cbbcdd87f95\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-27T01:25:31.144768Z","caller":"traceutil/trace.go:171","msg":"trace[444931116] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1841; }","duration":"580.068125ms","start":"2026-04-27T01:25:30.564685Z","end":"2026-04-27T01:25:31.144753Z","steps":["trace[444931116] 'agreement among raft nodes before linearized reading' (duration: 579.853212ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:31.144788Z","caller":"traceutil/trace.go:171","msg":"trace[766912424] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7062a44e-740f-4863-9004-5cbbcdd87f95; range_end:; response_count:1; response_revision:1841; }","duration":"601.740875ms","start":"2026-04-27T01:25:30.543039Z","end":"2026-04-27T01:25:31.14478Z","steps":["trace[766912424] 'agreement among raft nodes before linearized reading' (duration: 601.626834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.144806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.564654Z","time spent":"580.144626ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-27T01:25:31.144865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.695744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7062a44e-740f-4863-9004-5cbbcdd87f95\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-27T01:25:31.144884Z","caller":"traceutil/trace.go:171","msg":"trace[998024964] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7062a44e-740f-4863-9004-5cbbcdd87f95; range_end:; response_count:1; response_revision:1841; }","duration":"627.758635ms","start":"2026-04-27T01:25:30.51712Z","end":"2026-04-27T01:25:31.144879Z","steps":["trace[998024964] 'agreement among raft nodes before linearized reading' (duration: 627.704874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.1449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.517097Z","time spent":"627.799546ms","remote":"127.0.0.1:36100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7062a44e-740f-4863-9004-5cbbcdd87f95\" "} {"level":"info","ts":"2026-04-27T01:25:31.144909Z","caller":"traceutil/trace.go:171","msg":"trace[1149821901] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"501.01342ms","start":"2026-04-27T01:25:30.643882Z","end":"2026-04-27T01:25:31.144895Z","steps":["trace[1149821901] 'process raft request' (duration: 500.462363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.144971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.643873Z","time spent":"501.05925ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:25:31.144813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.542956Z","time spent":"601.849937ms","remote":"127.0.0.1:36100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7062a44e-740f-4863-9004-5cbbcdd87f95\" "} {"level":"info","ts":"2026-04-27T01:25:31.153875Z","caller":"traceutil/trace.go:171","msg":"trace[1467771907] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"505.972148ms","start":"2026-04-27T01:25:30.647888Z","end":"2026-04-27T01:25:31.15386Z","steps":["trace[1467771907] 'process raft request' (duration: 505.777605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.153955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.647868Z","time spent":"506.045109ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:25:31.153988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.970523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:25:31.153946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.891514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T01:25:31.154025Z","caller":"traceutil/trace.go:171","msg":"trace[1563371116] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1843; }","duration":"396.032785ms","start":"2026-04-27T01:25:30.757984Z","end":"2026-04-27T01:25:31.154017Z","steps":["trace[1563371116] 'agreement among raft nodes before linearized reading' (duration: 395.976714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.154053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.757965Z","time spent":"396.081345ms","remote":"127.0.0.1:41108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T01:25:31.154035Z","caller":"traceutil/trace.go:171","msg":"trace[1154024476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1843; }","duration":"508.000206ms","start":"2026-04-27T01:25:30.646022Z","end":"2026-04-27T01:25:31.154022Z","steps":["trace[1154024476] 'agreement among raft nodes before linearized reading' (duration: 507.790533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.154127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:30.64601Z","time spent":"508.106407ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T01:25:31.154198Z","caller":"traceutil/trace.go:171","msg":"trace[805004693] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"207.529513ms","start":"2026-04-27T01:25:30.946658Z","end":"2026-04-27T01:25:31.154187Z","steps":["trace[805004693] 'process raft request' (duration: 207.103518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:31.154084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.967368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T01:25:31.154275Z","caller":"traceutil/trace.go:171","msg":"trace[984525643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1843; }","duration":"283.207081ms","start":"2026-04-27T01:25:30.871053Z","end":"2026-04-27T01:25:31.15426Z","steps":["trace[984525643] 'agreement among raft nodes before linearized reading' (duration: 282.820296ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:44.88732Z","caller":"traceutil/trace.go:171","msg":"trace[804771601] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2044; }","duration":"146.437261ms","start":"2026-04-27T01:25:44.740859Z","end":"2026-04-27T01:25:44.887296Z","steps":["trace[804771601] 'read index received' (duration: 146.191758ms)","trace[804771601] 'applied index is now lower than readState.Index' (duration: 244.393µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:25:44.887372Z","caller":"traceutil/trace.go:171","msg":"trace[1012815492] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"193.040409ms","start":"2026-04-27T01:25:44.694302Z","end":"2026-04-27T01:25:44.887342Z","steps":["trace[1012815492] 'process raft request' (duration: 192.817937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:44.887588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.714015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-27T01:25:44.887643Z","caller":"traceutil/trace.go:171","msg":"trace[1084400678] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1966; }","duration":"146.838517ms","start":"2026-04-27T01:25:44.740789Z","end":"2026-04-27T01:25:44.887627Z","steps":["trace[1084400678] 'agreement among raft nodes before linearized reading' (duration: 146.648004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:26:02.651682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.151546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:26:02.652104Z","caller":"traceutil/trace.go:171","msg":"trace[576294231] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"408.305084ms","start":"2026-04-27T01:26:02.243508Z","end":"2026-04-27T01:26:02.651813Z","steps":["trace[576294231] 'process raft request' (duration: 285.892835ms)","trace[576294231] 'compare' (duration: 121.957844ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:26:02.652201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:26:02.243489Z","time spent":"408.67288ms","remote":"127.0.0.1:35934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:27:12.046501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.57327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:27:12.046578Z","caller":"traceutil/trace.go:171","msg":"trace[475090711] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2549; }","duration":"239.721822ms","start":"2026-04-27T01:27:11.80684Z","end":"2026-04-27T01:27:12.046562Z","steps":["trace[475090711] 'count revisions from in-memory index tree' (duration: 239.422128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:27:12.046945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.067129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T01:27:12.04697Z","caller":"traceutil/trace.go:171","msg":"trace[188799553] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2549; }","duration":"114.149679ms","start":"2026-04-27T01:27:11.932815Z","end":"2026-04-27T01:27:12.046965Z","steps":["trace[188799553] 'range keys from in-memory index tree' (duration: 113.888986ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:27:47.792566Z","caller":"traceutil/trace.go:171","msg":"trace[419170558] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"110.712066ms","start":"2026-04-27T01:27:47.681817Z","end":"2026-04-27T01:27:47.792529Z","steps":["trace[419170558] 'process raft request' (duration: 65.823426ms)","trace[419170558] 'compare' (duration: 43.084524ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:27:48.182377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.136404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:27:48.182693Z","caller":"traceutil/trace.go:171","msg":"trace[1868076362] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"308.972191ms","start":"2026-04-27T01:27:47.873668Z","end":"2026-04-27T01:27:48.18264Z","steps":["trace[1868076362] 'process raft request' (duration: 142.456384ms)","trace[1868076362] 'compare' (duration: 165.279925ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:27:48.182878Z","caller":"traceutil/trace.go:171","msg":"trace[1629544743] transaction","detail":"{read_only:false; response_revision:2746; number_of_response:1; }","duration":"309.150082ms","start":"2026-04-27T01:27:47.873703Z","end":"2026-04-27T01:27:48.182853Z","steps":["trace[1629544743] 'process raft request' (duration: 308.92065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:27:48.183033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:27:47.873674Z","time spent":"309.290403ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:27:48.183089Z","caller":"traceutil/trace.go:171","msg":"trace[1691836058] linearizableReadLoop","detail":"{readStateIndex:2855; appliedIndex:2851; }","duration":"273.76477ms","start":"2026-04-27T01:27:47.909313Z","end":"2026-04-27T01:27:48.183077Z","steps":["trace[1691836058] 'read index received' (duration: 106.82878ms)","trace[1691836058] 'applied index is now lower than readState.Index' (duration: 166.93502ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:27:48.182899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:27:47.873626Z","time spent":"309.169042ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:27:48.183271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.952812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-27T01:27:48.183317Z","caller":"traceutil/trace.go:171","msg":"trace[395532730] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2748; }","duration":"274.040513ms","start":"2026-04-27T01:27:47.909264Z","end":"2026-04-27T01:27:48.183305Z","steps":["trace[395532730] 'agreement among raft nodes before linearized reading' (duration: 273.854582ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:27:48.183308Z","caller":"traceutil/trace.go:171","msg":"trace[2105426989] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"308.259993ms","start":"2026-04-27T01:27:47.875007Z","end":"2026-04-27T01:27:48.183267Z","steps":["trace[2105426989] 'process raft request' (duration: 307.763289ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:27:48.183459Z","caller":"traceutil/trace.go:171","msg":"trace[493535550] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"308.057921ms","start":"2026-04-27T01:27:47.875364Z","end":"2026-04-27T01:27:48.183422Z","steps":["trace[493535550] 'process raft request' (duration: 307.625068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:27:48.183521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:27:47.874986Z","time spent":"308.423925ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:27:48.183649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:27:47.875355Z","time spent":"308.190644ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:27:48.316923Z","caller":"traceutil/trace.go:171","msg":"trace[958761527] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"127.708764ms","start":"2026-04-27T01:27:48.189174Z","end":"2026-04-27T01:27:48.316883Z","steps":["trace[958761527] 'process raft request' (duration: 110.842196ms)","trace[958761527] 'compare' (duration: 16.689406ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:36.553301Z","caller":"traceutil/trace.go:171","msg":"trace[1717201776] linearizableReadLoop","detail":"{readStateIndex:4665; appliedIndex:4664; }","duration":"122.311418ms","start":"2026-04-27T01:31:36.43095Z","end":"2026-04-27T01:31:36.553262Z","steps":["trace[1717201776] 'read index received' (duration: 120.22615ms)","trace[1717201776] 'applied index is now lower than readState.Index' (duration: 2.084068ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:36.553383Z","caller":"traceutil/trace.go:171","msg":"trace[2142511090] transaction","detail":"{read_only:false; response_revision:4486; number_of_response:1; }","duration":"135.59533ms","start":"2026-04-27T01:31:36.41775Z","end":"2026-04-27T01:31:36.553346Z","steps":["trace[2142511090] 'process raft request' (duration: 133.41439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:36.553491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.493852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:31:36.553572Z","caller":"traceutil/trace.go:171","msg":"trace[1174060948] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:0; response_revision:4486; }","duration":"122.639564ms","start":"2026-04-27T01:31:36.430915Z","end":"2026-04-27T01:31:36.553542Z","steps":["trace[1174060948] 'agreement among raft nodes before linearized reading' (duration: 122.495782ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.725089Z","caller":"traceutil/trace.go:171","msg":"trace[1077346737] linearizableReadLoop","detail":"{readStateIndex:4829; appliedIndex:4828; }","duration":"136.740451ms","start":"2026-04-27T01:31:41.588321Z","end":"2026-04-27T01:31:41.725061Z","steps":["trace[1077346737] 'read index received' (duration: 127.376035ms)","trace[1077346737] 'applied index is now lower than readState.Index' (duration: 9.362916ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:41.725134Z","caller":"traceutil/trace.go:171","msg":"trace[1361920961] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"138.89158ms","start":"2026-04-27T01:31:41.586213Z","end":"2026-04-27T01:31:41.725105Z","steps":["trace[1361920961] 'process raft request' (duration: 129.471724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.725332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.986474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-27T01:31:41.725374Z","caller":"traceutil/trace.go:171","msg":"trace[1067204210] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4646; }","duration":"137.072075ms","start":"2026-04-27T01:31:41.58829Z","end":"2026-04-27T01:31:41.725362Z","steps":["trace[1067204210] 'agreement among raft nodes before linearized reading' (duration: 136.898892ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.751741Z","caller":"traceutil/trace.go:171","msg":"trace[2042520193] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"162.157546ms","start":"2026-04-27T01:31:41.589565Z","end":"2026-04-27T01:31:41.751723Z","steps":["trace[2042520193] 'process raft request' (duration: 161.862442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.75207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.901784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-27T01:31:41.752168Z","caller":"traceutil/trace.go:171","msg":"trace[1528691565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4649; }","duration":"122.987605ms","start":"2026-04-27T01:31:41.629136Z","end":"2026-04-27T01:31:41.752123Z","steps":["trace[1528691565] 'agreement among raft nodes before linearized reading' (duration: 122.831612ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.75227Z","caller":"traceutil/trace.go:171","msg":"trace[1009790002] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"156.585049ms","start":"2026-04-27T01:31:41.595666Z","end":"2026-04-27T01:31:41.752251Z","steps":["trace[1009790002] 'process raft request' (duration: 155.883859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.752597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.909629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-27T01:31:41.752674Z","caller":"traceutil/trace.go:171","msg":"trace[1059434488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4649; }","duration":"110.024239ms","start":"2026-04-27T01:31:41.642609Z","end":"2026-04-27T01:31:41.752633Z","steps":["trace[1059434488] 'agreement among raft nodes before linearized reading' (duration: 109.909288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.752761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.489471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T01:31:41.752811Z","caller":"traceutil/trace.go:171","msg":"trace[1861333160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4649; }","duration":"123.607822ms","start":"2026-04-27T01:31:41.629191Z","end":"2026-04-27T01:31:41.752799Z","steps":["trace[1861333160] 'agreement among raft nodes before linearized reading' (duration: 123.43304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.751909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.426717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-27T01:31:41.753028Z","caller":"traceutil/trace.go:171","msg":"trace[1679489240] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4649; }","duration":"106.546242ms","start":"2026-04-27T01:31:41.646442Z","end":"2026-04-27T01:31:41.752988Z","steps":["trace[1679489240] 'agreement among raft nodes before linearized reading' (duration: 105.307195ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.896597Z","caller":"traceutil/trace.go:171","msg":"trace[1206835908] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"135.93635ms","start":"2026-04-27T01:31:41.760639Z","end":"2026-04-27T01:31:41.896575Z","steps":["trace[1206835908] 'process raft request' (duration: 135.843999ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.896802Z","caller":"traceutil/trace.go:171","msg":"trace[1176990258] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"136.105842ms","start":"2026-04-27T01:31:41.760675Z","end":"2026-04-27T01:31:41.89678Z","steps":["trace[1176990258] 'process raft request' (duration: 135.864409ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.897241Z","caller":"traceutil/trace.go:171","msg":"trace[154533699] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"135.547495ms","start":"2026-04-27T01:31:41.761677Z","end":"2026-04-27T01:31:41.897224Z","steps":["trace[154533699] 'process raft request' (duration: 135.030949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.897539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.093305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"} {"level":"info","ts":"2026-04-27T01:31:41.897584Z","caller":"traceutil/trace.go:171","msg":"trace[695293229] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4654; }","duration":"137.166986ms","start":"2026-04-27T01:31:41.760406Z","end":"2026-04-27T01:31:41.897573Z","steps":["trace[695293229] 'agreement among raft nodes before linearized reading' (duration: 137.015634ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:41.896835Z","caller":"traceutil/trace.go:171","msg":"trace[1181076713] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"136.279644ms","start":"2026-04-27T01:31:41.76054Z","end":"2026-04-27T01:31:41.89682Z","steps":["trace[1181076713] 'process raft request' (duration: 81.854077ms)","trace[1181076713] 'compare' (duration: 53.964601ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:41.897329Z","caller":"traceutil/trace.go:171","msg":"trace[1695583094] linearizableReadLoop","detail":"{readStateIndex:4837; appliedIndex:4833; }","duration":"126.895617ms","start":"2026-04-27T01:31:41.77042Z","end":"2026-04-27T01:31:41.897316Z","steps":["trace[1695583094] 'read index received' (duration: 71.899753ms)","trace[1695583094] 'applied index is now lower than readState.Index' (duration: 54.994884ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:31:41.898454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.402967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-27T01:31:41.898487Z","caller":"traceutil/trace.go:171","msg":"trace[807787743] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4654; }","duration":"125.465197ms","start":"2026-04-27T01:31:41.773011Z","end":"2026-04-27T01:31:41.898476Z","steps":["trace[807787743] 'agreement among raft nodes before linearized reading' (duration: 125.347076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:41.898785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.3629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-27T01:31:41.898827Z","caller":"traceutil/trace.go:171","msg":"trace[1411361381] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4654; }","duration":"106.435971ms","start":"2026-04-27T01:31:41.792381Z","end":"2026-04-27T01:31:41.898817Z","steps":["trace[1411361381] 'agreement among raft nodes before linearized reading' (duration: 106.237448ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:31:48.355656Z","caller":"traceutil/trace.go:171","msg":"trace[759266262] linearizableReadLoop","detail":"{readStateIndex:4952; appliedIndex:4950; }","duration":"195.68798ms","start":"2026-04-27T01:31:48.159946Z","end":"2026-04-27T01:31:48.355633Z","steps":["trace[759266262] 'read index received' (duration: 174.964893ms)","trace[759266262] 'applied index is now lower than readState.Index' (duration: 20.722117ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:48.355715Z","caller":"traceutil/trace.go:171","msg":"trace[990183202] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"284.216385ms","start":"2026-04-27T01:31:48.071453Z","end":"2026-04-27T01:31:48.355669Z","steps":["trace[990183202] 'process raft request' (duration: 263.512497ms)","trace[990183202] 'compare' (duration: 20.261092ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:31:48.355791Z","caller":"traceutil/trace.go:171","msg":"trace[635537350] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"283.17625ms","start":"2026-04-27T01:31:48.072604Z","end":"2026-04-27T01:31:48.35578Z","steps":["trace[635537350] 'process raft request' (duration: 282.946387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:48.355842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.392231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:31:48.355883Z","caller":"traceutil/trace.go:171","msg":"trace[965984975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4767; }","duration":"117.484253ms","start":"2026-04-27T01:31:48.238392Z","end":"2026-04-27T01:31:48.355876Z","steps":["trace[965984975] 'agreement among raft nodes before linearized reading' (duration: 117.406082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:31:48.355957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.002444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b1e0605e-c440-4cf8-9d0e-03fb953d1075\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-27T01:31:48.356011Z","caller":"traceutil/trace.go:171","msg":"trace[49388991] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b1e0605e-c440-4cf8-9d0e-03fb953d1075; range_end:; response_count:1; response_revision:4767; }","duration":"196.107215ms","start":"2026-04-27T01:31:48.15989Z","end":"2026-04-27T01:31:48.355998Z","steps":["trace[49388991] 'agreement among raft nodes before linearized reading' (duration: 195.923002ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:01.574135Z","caller":"traceutil/trace.go:171","msg":"trace[1749142299] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"410.915295ms","start":"2026-04-27T01:32:01.163192Z","end":"2026-04-27T01:32:01.574107Z","steps":["trace[1749142299] 'process raft request' (duration: 410.764073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:01.574479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:32:01.163168Z","time spent":"411.153728ms","remote":"127.0.0.1:36146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:32:02.446577Z","caller":"traceutil/trace.go:171","msg":"trace[164709794] linearizableReadLoop","detail":"{readStateIndex:5147; appliedIndex:5146; }","duration":"197.478328ms","start":"2026-04-27T01:32:02.249072Z","end":"2026-04-27T01:32:02.446551Z","steps":["trace[164709794] 'read index received' (duration: 144.995871ms)","trace[164709794] 'applied index is now lower than readState.Index' (duration: 52.471137ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:02.446698Z","caller":"traceutil/trace.go:171","msg":"trace[1786902878] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"197.647581ms","start":"2026-04-27T01:32:02.249035Z","end":"2026-04-27T01:32:02.446683Z","steps":["trace[1786902878] 'process raft request' (duration: 145.019672ms)","trace[1786902878] 'compare' (duration: 52.238054ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:32:02.447146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.056555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-27T01:32:02.447194Z","caller":"traceutil/trace.go:171","msg":"trace[973491678] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:4954; }","duration":"198.113186ms","start":"2026-04-27T01:32:02.249067Z","end":"2026-04-27T01:32:02.44718Z","steps":["trace[973491678] 'agreement among raft nodes before linearized reading' (duration: 197.732741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:02.456437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.715549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-04-27T01:32:02.456524Z","caller":"traceutil/trace.go:171","msg":"trace[573004076] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4955; }","duration":"199.83205ms","start":"2026-04-27T01:32:02.256674Z","end":"2026-04-27T01:32:02.456506Z","steps":["trace[573004076] 'agreement among raft nodes before linearized reading' (duration: 199.606577ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:02.456526Z","caller":"traceutil/trace.go:171","msg":"trace[1014784111] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"206.881133ms","start":"2026-04-27T01:32:02.249627Z","end":"2026-04-27T01:32:02.456508Z","steps":["trace[1014784111] 'process raft request' (duration: 206.535029ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:02.870923Z","caller":"traceutil/trace.go:171","msg":"trace[1703070618] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"100.111201ms","start":"2026-04-27T01:32:02.770789Z","end":"2026-04-27T01:32:02.8709Z","steps":["trace[1703070618] 'process raft request' (duration: 99.954929ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:02.93328Z","caller":"traceutil/trace.go:171","msg":"trace[1430136737] linearizableReadLoop","detail":"{readStateIndex:5153; appliedIndex:5151; }","duration":"102.311581ms","start":"2026-04-27T01:32:02.830933Z","end":"2026-04-27T01:32:02.933244Z","steps":["trace[1430136737] 'read index received' (duration: 39.858832ms)","trace[1430136737] 'applied index is now lower than readState.Index' (duration: 62.451769ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:02.933373Z","caller":"traceutil/trace.go:171","msg":"trace[778308610] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"161.778141ms","start":"2026-04-27T01:32:02.771556Z","end":"2026-04-27T01:32:02.933334Z","steps":["trace[778308610] 'process raft request' (duration: 139.238546ms)","trace[778308610] 'compare' (duration: 22.303121ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:32:02.933518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.539554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:32:02.933774Z","caller":"traceutil/trace.go:171","msg":"trace[1264016888] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4960; }","duration":"102.871219ms","start":"2026-04-27T01:32:02.830873Z","end":"2026-04-27T01:32:02.933744Z","steps":["trace[1264016888] 'agreement among raft nodes before linearized reading' (duration: 102.485565ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:03.134626Z","caller":"traceutil/trace.go:171","msg":"trace[157434194] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"189.514782ms","start":"2026-04-27T01:32:02.945076Z","end":"2026-04-27T01:32:03.13459Z","steps":["trace[157434194] 'process raft request' (duration: 146.872884ms)","trace[157434194] 'compare' (duration: 42.388255ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:03.398832Z","caller":"traceutil/trace.go:171","msg":"trace[306146260] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"248.632025ms","start":"2026-04-27T01:32:03.150175Z","end":"2026-04-27T01:32:03.398807Z","steps":["trace[306146260] 'process raft request' (duration: 248.556304ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:03.399235Z","caller":"traceutil/trace.go:171","msg":"trace[1893618549] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"256.343266ms","start":"2026-04-27T01:32:03.142871Z","end":"2026-04-27T01:32:03.399214Z","steps":["trace[1893618549] 'process raft request' (duration: 202.833316ms)","trace[1893618549] 'compare' (duration: 52.814841ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:03.399237Z","caller":"traceutil/trace.go:171","msg":"trace[526603618] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"254.298858ms","start":"2026-04-27T01:32:03.144613Z","end":"2026-04-27T01:32:03.398912Z","steps":["trace[526603618] 'process raft request' (duration: 254.062375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:03.660932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.845839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:32:03.661146Z","caller":"traceutil/trace.go:171","msg":"trace[1208702874] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"254.268048ms","start":"2026-04-27T01:32:03.406835Z","end":"2026-04-27T01:32:03.661103Z","steps":["trace[1208702874] 'process raft request' (duration: 95.150896ms)","trace[1208702874] 'compare' (duration: 158.646786ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:03.661186Z","caller":"traceutil/trace.go:171","msg":"trace[588199568] linearizableReadLoop","detail":"{readStateIndex:5162; appliedIndex:5160; }","duration":"110.416366ms","start":"2026-04-27T01:32:03.550752Z","end":"2026-04-27T01:32:03.661168Z","steps":["trace[588199568] 'read index received' (duration: 38.14µs)","trace[588199568] 'applied index is now lower than readState.Index' (duration: 110.377316ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:32:03.661348Z","caller":"traceutil/trace.go:171","msg":"trace[100665002] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"251.166268ms","start":"2026-04-27T01:32:03.410115Z","end":"2026-04-27T01:32:03.661281Z","steps":["trace[100665002] 'process raft request' (duration: 250.918584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:03.661406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.646049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:32:03.661443Z","caller":"traceutil/trace.go:171","msg":"trace[2096069395] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:4969; }","duration":"110.7244ms","start":"2026-04-27T01:32:03.550705Z","end":"2026-04-27T01:32:03.66143Z","steps":["trace[2096069395] 'agreement among raft nodes before linearized reading' (duration: 110.614589ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:33:08.581279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2857} {"level":"info","ts":"2026-04-27T01:33:08.665809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2857,"took":"83.016588ms","hash":768424664,"current-db-size-bytes":53026816,"current-db-size":"53 MB","current-db-size-in-use-bytes":28659712,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-27T01:33:08.665874Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":768424664,"revision":2857,"compact-revision":-1} {"level":"info","ts":"2026-04-27T01:38:08.588761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5493} {"level":"info","ts":"2026-04-27T01:38:08.676477Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5493,"took":"86.213057ms","hash":3444144228,"current-db-size-bytes":53026816,"current-db-size":"53 MB","current-db-size-in-use-bytes":18259968,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-27T01:38:08.676551Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3444144228,"revision":5493,"compact-revision":2857}