{"level":"warn","ts":"2026-04-01T05:10:48.177085Z","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-01T05:10:48.177166Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-01T05:10:48.177227Z","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-01T05:10:48.177241Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-01T05:10:48.177258Z","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-01T05:10:48.179067Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-04-01T05:10:48.181782Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-01T05:10:48.186532Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.197889ms"} {"level":"info","ts":"2026-04-01T05:10:48.194343Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-04-01T05:10:48.19445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-04-01T05:10:48.194481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-04-01T05:10:48.194493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-01T05:10:48.194505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-04-01T05:10:48.194555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-04-01T05:10:48.201147Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-01T05:10:48.203539Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-01T05:10:48.204883Z","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-01T05:10:48.20692Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-01T05:10:48.207077Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-01T05:10:48.207334Z","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-01T05:10:48.207436Z","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-01T05:10:48.207477Z","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-01T05:10:48.209275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-04-01T05:10:48.209412Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-01T05:10:48.213246Z","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-01T05:10:48.213315Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-01T05:10:48.213367Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-01T05:10:48.213636Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-01T05:10:48.213697Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-01T05:10:48.795438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-04-01T05:10:48.79549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-01T05:10:48.795508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-04-01T05:10:48.795522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-04-01T05:10:48.795538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-01T05:10:48.795549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-04-01T05:10:48.795558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-01T05:10:48.79631Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-01T05:10:48.797058Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-01T05:10:48.797079Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-04-01T05:10:48.797121Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-01T05:10:48.797323Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-01T05:10:48.797394Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-01T05:10:48.798058Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-04-01T05:10:48.798149Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-01T05:10:48.798173Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-01T05:10:48.799127Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-04-01T05:10:48.800487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-01T05:11:09.294188Z","caller":"traceutil/trace.go:171","msg":"trace[1211942898] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"119.913761ms","start":"2026-04-01T05:11:09.17425Z","end":"2026-04-01T05:11:09.294164Z","steps":["trace[1211942898] 'process raft request' (duration: 119.752508ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:11.116491Z","caller":"traceutil/trace.go:171","msg":"trace[1109745878] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"319.693347ms","start":"2026-04-01T05:11:10.796763Z","end":"2026-04-01T05:11:11.116456Z","steps":["trace[1109745878] 'process raft request' (duration: 298.763677ms)","trace[1109745878] 'compare' (duration: 20.789067ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:11:11.117616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:10.796736Z","time spent":"319.963884ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:11:11.442345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.848107ms","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-01T05:11:11.442452Z","caller":"traceutil/trace.go:171","msg":"trace[887752671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:415; }","duration":"143.005401ms","start":"2026-04-01T05:11:11.299428Z","end":"2026-04-01T05:11:11.442433Z","steps":["trace[887752671] 'range keys from in-memory index tree' (duration: 142.749695ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:16.276113Z","caller":"traceutil/trace.go:171","msg":"trace[672917340] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"229.196274ms","start":"2026-04-01T05:11:16.046899Z","end":"2026-04-01T05:11:16.276095Z","steps":["trace[672917340] 'process raft request' (duration: 229.069301ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:16.926866Z","caller":"traceutil/trace.go:171","msg":"trace[139382067] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"331.270498ms","start":"2026-04-01T05:11:16.595558Z","end":"2026-04-01T05:11:16.926828Z","steps":["trace[139382067] 'process raft request' (duration: 331.060223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:16.927169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:16.59553Z","time spent":"331.472623ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:11:16.934094Z","caller":"traceutil/trace.go:171","msg":"trace[684497982] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:449; }","duration":"196.144351ms","start":"2026-04-01T05:11:16.737881Z","end":"2026-04-01T05:11:16.934026Z","steps":["trace[684497982] 'read index received' (duration: 188.714698ms)","trace[684497982] 'applied index is now lower than readState.Index' (duration: 7.427983ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:11:16.934277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.361277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-04-01T05:11:16.934423Z","caller":"traceutil/trace.go:171","msg":"trace[438487397] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:429; }","duration":"196.561792ms","start":"2026-04-01T05:11:16.737843Z","end":"2026-04-01T05:11:16.934404Z","steps":["trace[438487397] 'agreement among raft nodes before linearized reading' (duration: 196.279666ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.65957Z","caller":"traceutil/trace.go:171","msg":"trace[1782355003] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"174.346502ms","start":"2026-04-01T05:11:19.485121Z","end":"2026-04-01T05:11:19.659467Z","steps":["trace[1782355003] 'read index received' (duration: 174.128707ms)","trace[1782355003] 'applied index is now lower than readState.Index' (duration: 217.045µs)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:19.659588Z","caller":"traceutil/trace.go:171","msg":"trace[650536161] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"180.425894ms","start":"2026-04-01T05:11:19.479121Z","end":"2026-04-01T05:11:19.659547Z","steps":["trace[650536161] 'process raft request' (duration: 180.213999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:19.659809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.661559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-01T05:11:19.659871Z","caller":"traceutil/trace.go:171","msg":"trace[1124642844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:478; }","duration":"174.772973ms","start":"2026-04-01T05:11:19.485083Z","end":"2026-04-01T05:11:19.659856Z","steps":["trace[1124642844] 'agreement among raft nodes before linearized reading' (duration: 174.604868ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665341Z","caller":"traceutil/trace.go:171","msg":"trace[913673531] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"169.716264ms","start":"2026-04-01T05:11:19.495612Z","end":"2026-04-01T05:11:19.665328Z","steps":["trace[913673531] 'process raft request' (duration: 169.52843ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665446Z","caller":"traceutil/trace.go:171","msg":"trace[486007076] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"169.738354ms","start":"2026-04-01T05:11:19.495691Z","end":"2026-04-01T05:11:19.665429Z","steps":["trace[486007076] 'process raft request' (duration: 169.54825ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665519Z","caller":"traceutil/trace.go:171","msg":"trace[121335453] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"169.778666ms","start":"2026-04-01T05:11:19.495726Z","end":"2026-04-01T05:11:19.665505Z","steps":["trace[121335453] 'process raft request' (duration: 169.57345ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665552Z","caller":"traceutil/trace.go:171","msg":"trace[504804571] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"168.443216ms","start":"2026-04-01T05:11:19.497096Z","end":"2026-04-01T05:11:19.665539Z","steps":["trace[504804571] 'process raft request' (duration: 168.308712ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665589Z","caller":"traceutil/trace.go:171","msg":"trace[1145412907] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"168.300023ms","start":"2026-04-01T05:11:19.497271Z","end":"2026-04-01T05:11:19.665571Z","steps":["trace[1145412907] 'process raft request' (duration: 168.19376ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665815Z","caller":"traceutil/trace.go:171","msg":"trace[287700705] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"167.36682ms","start":"2026-04-01T05:11:19.498439Z","end":"2026-04-01T05:11:19.665806Z","steps":["trace[287700705] 'process raft request' (duration: 167.272158ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.665838Z","caller":"traceutil/trace.go:171","msg":"trace[1713367272] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"167.526894ms","start":"2026-04-01T05:11:19.498264Z","end":"2026-04-01T05:11:19.665791Z","steps":["trace[1713367272] 'process raft request' (duration: 167.254367ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.666023Z","caller":"traceutil/trace.go:171","msg":"trace[421090542] transaction","detail":"{read_only:false; number_of_response:1; response_revision:485; }","duration":"167.270517ms","start":"2026-04-01T05:11:19.49868Z","end":"2026-04-01T05:11:19.665951Z","steps":["trace[421090542] 'process raft request' (duration: 167.083653ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.666295Z","caller":"traceutil/trace.go:171","msg":"trace[246875037] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"161.501933ms","start":"2026-04-01T05:11:19.504776Z","end":"2026-04-01T05:11:19.666278Z","steps":["trace[246875037] 'process raft request' (duration: 161.354639ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.666128Z","caller":"traceutil/trace.go:171","msg":"trace[330431343] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"164.517423ms","start":"2026-04-01T05:11:19.501592Z","end":"2026-04-01T05:11:19.666109Z","steps":["trace[330431343] 'process raft request' (duration: 164.323858ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.666087Z","caller":"traceutil/trace.go:171","msg":"trace[836018193] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"165.812622ms","start":"2026-04-01T05:11:19.500186Z","end":"2026-04-01T05:11:19.665998Z","steps":["trace[836018193] 'process raft request' (duration: 165.626518ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:19.666237Z","caller":"traceutil/trace.go:171","msg":"trace[1041447690] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"162.531057ms","start":"2026-04-01T05:11:19.503697Z","end":"2026-04-01T05:11:19.666228Z","steps":["trace[1041447690] 'process raft request' (duration: 162.295131ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:22.764447Z","caller":"traceutil/trace.go:171","msg":"trace[1041172600] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"103.59991ms","start":"2026-04-01T05:11:22.660807Z","end":"2026-04-01T05:11:22.764406Z","steps":["trace[1041172600] 'process raft request' (duration: 102.76198ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:23.472125Z","caller":"traceutil/trace.go:171","msg":"trace[56947472] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"224.291328ms","start":"2026-04-01T05:11:23.247803Z","end":"2026-04-01T05:11:23.472095Z","steps":["trace[56947472] 'process raft request' (duration: 221.828531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:23.904893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.530574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:23.904947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.01879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-01T05:11:23.904949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.112224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-01T05:11:23.904988Z","caller":"traceutil/trace.go:171","msg":"trace[1475009026] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:559; }","duration":"328.682367ms","start":"2026-04-01T05:11:23.576284Z","end":"2026-04-01T05:11:23.904966Z","steps":["trace[1475009026] 'range keys from in-memory index tree' (duration: 328.341779ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:23.905011Z","caller":"traceutil/trace.go:171","msg":"trace[686297918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:559; }","duration":"107.141643ms","start":"2026-04-01T05:11:23.797853Z","end":"2026-04-01T05:11:23.904995Z","steps":["trace[686297918] 'range keys from in-memory index tree' (duration: 106.854926ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:23.905019Z","caller":"traceutil/trace.go:171","msg":"trace[103430450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"224.221797ms","start":"2026-04-01T05:11:23.680781Z","end":"2026-04-01T05:11:23.905003Z","steps":["trace[103430450] 'range keys from in-memory index tree' (duration: 223.978372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:23.905036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:23.57626Z","time spent":"328.766059ms","remote":"127.0.0.1:33744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-01T05:11:26.59263Z","caller":"traceutil/trace.go:171","msg":"trace[1452255326] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"271.692177ms","start":"2026-04-01T05:11:26.320911Z","end":"2026-04-01T05:11:26.592603Z","steps":["trace[1452255326] 'read index received' (duration: 271.489332ms)","trace[1452255326] 'applied index is now lower than readState.Index' (duration: 201.765µs)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:26.592797Z","caller":"traceutil/trace.go:171","msg":"trace[347451954] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"331.79065ms","start":"2026-04-01T05:11:26.260927Z","end":"2026-04-01T05:11:26.592717Z","steps":["trace[347451954] 'process raft request' (duration: 331.527754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:26.593068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:26.260902Z","time spent":"332.056176ms","remote":"127.0.0.1:33940","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-01T05:11:26.593327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.275771ms","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-01T05:11:26.593508Z","caller":"traceutil/trace.go:171","msg":"trace[34760009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"272.568599ms","start":"2026-04-01T05:11:26.320841Z","end":"2026-04-01T05:11:26.59341Z","steps":["trace[34760009] 'agreement among raft nodes before linearized reading' (duration: 271.917763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:26.859257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.020984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-01T05:11:26.859393Z","caller":"traceutil/trace.go:171","msg":"trace[1146588780] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"254.472312ms","start":"2026-04-01T05:11:26.6049Z","end":"2026-04-01T05:11:26.859372Z","steps":["trace[1146588780] 'read index received' (duration: 42.158351ms)","trace[1146588780] 'applied index is now lower than readState.Index' (duration: 212.31221ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:11:26.859456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.553994ms","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-01T05:11:26.859427Z","caller":"traceutil/trace.go:171","msg":"trace[1336583606] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"259.466171ms","start":"2026-04-01T05:11:26.599923Z","end":"2026-04-01T05:11:26.859389Z","steps":["trace[1336583606] 'process raft request' (duration: 47.046437ms)","trace[1336583606] 'compare' (duration: 211.893201ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:26.859496Z","caller":"traceutil/trace.go:171","msg":"trace[654405891] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:580; }","duration":"254.619426ms","start":"2026-04-01T05:11:26.604862Z","end":"2026-04-01T05:11:26.859481Z","steps":["trace[654405891] 'agreement among raft nodes before linearized reading' (duration: 254.562685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:27.492046Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153698278802228955,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-01T05:11:27.604741Z","caller":"traceutil/trace.go:171","msg":"trace[1252108671] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"995.404383ms","start":"2026-04-01T05:11:26.609305Z","end":"2026-04-01T05:11:27.604709Z","steps":["trace[1252108671] 'process raft request' (duration: 995.197197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:27.604898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:26.609285Z","time spent":"995.527486ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:11:27.883263Z","caller":"traceutil/trace.go:171","msg":"trace[2049062467] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:605; }","duration":"891.959749ms","start":"2026-04-01T05:11:26.991268Z","end":"2026-04-01T05:11:27.883228Z","steps":["trace[2049062467] 'read index received' (duration: 613.325779ms)","trace[2049062467] 'applied index is now lower than readState.Index' (duration: 278.6327ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:27.883344Z","caller":"traceutil/trace.go:171","msg":"trace[1201325121] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"619.508275ms","start":"2026-04-01T05:11:27.263789Z","end":"2026-04-01T05:11:27.883297Z","steps":["trace[1201325121] 'process raft request' (duration: 618.296097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:27.883618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.327818ms","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-01T05:11:27.883698Z","caller":"traceutil/trace.go:171","msg":"trace[28369478] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"892.460912ms","start":"2026-04-01T05:11:26.991218Z","end":"2026-04-01T05:11:27.883679Z","steps":["trace[28369478] 'agreement among raft nodes before linearized reading' (duration: 892.207746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:27.883752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:26.991197Z","time spent":"892.545293ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-01T05:11:27.883656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:27.263757Z","time spent":"619.760961ms","remote":"127.0.0.1:33498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:11:28.804783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153698278802228960,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-01T05:11:29.251271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.947544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-01T05:11:29.251549Z","caller":"traceutil/trace.go:171","msg":"trace[224176039] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.316999983s","start":"2026-04-01T05:11:27.934495Z","end":"2026-04-01T05:11:29.251495Z","steps":["trace[224176039] 'process raft request' (duration: 961.704031ms)","trace[224176039] 'compare' (duration: 354.76588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:11:29.251769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:27.934474Z","time spent":"1.317178366s","remote":"127.0.0.1:33668","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-01T05:11:29.25204Z","caller":"traceutil/trace.go:171","msg":"trace[2047864521] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.315372765s","start":"2026-04-01T05:11:27.936643Z","end":"2026-04-01T05:11:29.252016Z","steps":["trace[2047864521] 'process raft request' (duration: 1.3147674s)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252067Z","caller":"traceutil/trace.go:171","msg":"trace[2019725013] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:609; }","duration":"948.244934ms","start":"2026-04-01T05:11:28.303797Z","end":"2026-04-01T05:11:29.252042Z","steps":["trace[2019725013] 'read index received' (duration: 592.415528ms)","trace[2019725013] 'applied index is now lower than readState.Index' (duration: 355.828225ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:29.252098Z","caller":"traceutil/trace.go:171","msg":"trace[602085704] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.304590271s","start":"2026-04-01T05:11:27.947492Z","end":"2026-04-01T05:11:29.252082Z","steps":["trace[602085704] 'process raft request' (duration: 1.304420018s)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.252134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:27.936617Z","time spent":"1.315478828s","remote":"127.0.0.1:33668","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-01T05:11:29.252173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:27.947479Z","time spent":"1.304662343s","remote":"127.0.0.1:33632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-01T05:11:29.252216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.408798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.25227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.317296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.252289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.033479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.252295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.109862ms","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-01T05:11:29.252291Z","caller":"traceutil/trace.go:171","msg":"trace[1768203401] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:586; }","duration":"948.51502ms","start":"2026-04-01T05:11:28.303765Z","end":"2026-04-01T05:11:29.25228Z","steps":["trace[1768203401] 'agreement among raft nodes before linearized reading' (duration: 948.356846ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252311Z","caller":"traceutil/trace.go:171","msg":"trace[1569576536] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:586; }","duration":"948.441488ms","start":"2026-04-01T05:11:28.303858Z","end":"2026-04-01T05:11:29.2523Z","steps":["trace[1569576536] 'agreement among raft nodes before linearized reading' (duration: 948.352616ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252324Z","caller":"traceutil/trace.go:171","msg":"trace[1125496137] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:586; }","duration":"267.10269ms","start":"2026-04-01T05:11:28.98521Z","end":"2026-04-01T05:11:29.252312Z","steps":["trace[1125496137] 'agreement among raft nodes before linearized reading' (duration: 267.040808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.252346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.303743Z","time spent":"948.592822ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-01T05:11:29.25235Z","caller":"traceutil/trace.go:171","msg":"trace[621941193] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:586; }","duration":"131.169404ms","start":"2026-04-01T05:11:29.121158Z","end":"2026-04-01T05:11:29.252327Z","steps":["trace[621941193] 'agreement among raft nodes before linearized reading' (duration: 131.095922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.252359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.303826Z","time spent":"948.521711ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-01T05:11:29.252521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.370585ms","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":"warn","ts":"2026-04-01T05:11:29.252567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.02833ms","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":"warn","ts":"2026-04-01T05:11:29.252612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.450738ms","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":"warn","ts":"2026-04-01T05:11:29.252641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.585609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.252651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.723515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.252688Z","caller":"traceutil/trace.go:171","msg":"trace[248603463] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:586; }","duration":"241.685881ms","start":"2026-04-01T05:11:29.01099Z","end":"2026-04-01T05:11:29.252676Z","steps":["trace[248603463] 'agreement among raft nodes before linearized reading' (duration: 241.62182ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252726Z","caller":"traceutil/trace.go:171","msg":"trace[1373268799] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"176.837207ms","start":"2026-04-01T05:11:29.075867Z","end":"2026-04-01T05:11:29.252705Z","steps":["trace[1373268799] 'agreement among raft nodes before linearized reading' (duration: 176.654793ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252708Z","caller":"traceutil/trace.go:171","msg":"trace[2036218129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:586; }","duration":"506.507558ms","start":"2026-04-01T05:11:28.746097Z","end":"2026-04-01T05:11:29.252605Z","steps":["trace[2036218129] 'agreement among raft nodes before linearized reading' (duration: 506.321193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.252814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.087859ms","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":"warn","ts":"2026-04-01T05:11:29.25283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.054586ms","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":"warn","ts":"2026-04-01T05:11:29.252802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.654943ms","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":"info","ts":"2026-04-01T05:11:29.25287Z","caller":"traceutil/trace.go:171","msg":"trace[1797572027] 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:586; }","duration":"104.096176ms","start":"2026-04-01T05:11:29.148764Z","end":"2026-04-01T05:11:29.25286Z","steps":["trace[1797572027] 'agreement among raft nodes before linearized reading' (duration: 104.039485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.252583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.954042ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.252841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.746084Z","time spent":"506.740194ms","remote":"127.0.0.1:51866","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":"info","ts":"2026-04-01T05:11:29.25294Z","caller":"traceutil/trace.go:171","msg":"trace[1915613850] 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:586; }","duration":"220.32313ms","start":"2026-04-01T05:11:29.0326Z","end":"2026-04-01T05:11:29.252923Z","steps":["trace[1915613850] 'agreement among raft nodes before linearized reading' (duration: 219.941331ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252948Z","caller":"traceutil/trace.go:171","msg":"trace[1322002417] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"176.899549ms","start":"2026-04-01T05:11:29.076014Z","end":"2026-04-01T05:11:29.252913Z","steps":["trace[1322002417] 'agreement among raft nodes before linearized reading' (duration: 176.463559ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.252644Z","caller":"traceutil/trace.go:171","msg":"trace[811656107] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:586; }","duration":"130.491768ms","start":"2026-04-01T05:11:29.122143Z","end":"2026-04-01T05:11:29.252635Z","steps":["trace[811656107] 'agreement among raft nodes before linearized reading' (duration: 130.447277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.14386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.252567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.05378ms","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":"warn","ts":"2026-04-01T05:11:29.252593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.975808ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.25312Z","caller":"traceutil/trace.go:171","msg":"trace[902011385] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:586; }","duration":"683.218072ms","start":"2026-04-01T05:11:28.56989Z","end":"2026-04-01T05:11:29.253108Z","steps":["trace[902011385] 'agreement among raft nodes before linearized reading' (duration: 683.1047ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253138Z","caller":"traceutil/trace.go:171","msg":"trace[747997494] 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:586; }","duration":"105.670785ms","start":"2026-04-01T05:11:29.147454Z","end":"2026-04-01T05:11:29.253124Z","steps":["trace[747997494] 'agreement among raft nodes before linearized reading' (duration: 105.082901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.569854Z","time spent":"683.301964ms","remote":"127.0.0.1:51844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-01T05:11:29.253162Z","caller":"traceutil/trace.go:171","msg":"trace[147344459] 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:586; }","duration":"219.548571ms","start":"2026-04-01T05:11:29.0336Z","end":"2026-04-01T05:11:29.253148Z","steps":["trace[147344459] 'agreement among raft nodes before linearized reading' (duration: 218.973178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.693576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.253174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.933902ms","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":"warn","ts":"2026-04-01T05:11:29.253225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.089174ms","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-01T05:11:29.253301Z","caller":"traceutil/trace.go:171","msg":"trace[1814802094] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:586; }","duration":"242.84453ms","start":"2026-04-01T05:11:29.010415Z","end":"2026-04-01T05:11:29.25326Z","steps":["trace[1814802094] 'agreement among raft nodes before linearized reading' (duration: 242.677166ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253316Z","caller":"traceutil/trace.go:171","msg":"trace[1536838241] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:586; }","duration":"132.141156ms","start":"2026-04-01T05:11:29.121141Z","end":"2026-04-01T05:11:29.253282Z","steps":["trace[1536838241] 'agreement among raft nodes before linearized reading' (duration: 131.820999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.25336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.137225ms","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-01T05:11:29.253387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.553242ms","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":"warn","ts":"2026-04-01T05:11:29.253406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.275857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.253415Z","caller":"traceutil/trace.go:171","msg":"trace[173694749] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"177.192216ms","start":"2026-04-01T05:11:29.07621Z","end":"2026-04-01T05:11:29.253402Z","steps":["trace[173694749] 'agreement among raft nodes before linearized reading' (duration: 177.118004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.666973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.25347Z","caller":"traceutil/trace.go:171","msg":"trace[1017152009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:586; }","duration":"268.353399ms","start":"2026-04-01T05:11:28.985092Z","end":"2026-04-01T05:11:29.253446Z","steps":["trace[1017152009] 'agreement among raft nodes before linearized reading' (duration: 268.265297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.35025ms","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":"warn","ts":"2026-04-01T05:11:29.253493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.168731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.253536Z","caller":"traceutil/trace.go:171","msg":"trace[471136772] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:586; }","duration":"656.412492ms","start":"2026-04-01T05:11:28.597089Z","end":"2026-04-01T05:11:29.253502Z","steps":["trace[471136772] 'agreement among raft nodes before linearized reading' (duration: 656.355901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.240036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.253549Z","caller":"traceutil/trace.go:171","msg":"trace[126399166] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:586; }","duration":"341.229692ms","start":"2026-04-01T05:11:28.912307Z","end":"2026-04-01T05:11:29.253537Z","steps":["trace[126399166] 'agreement among raft nodes before linearized reading' (duration: 341.14473ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.25323Z","caller":"traceutil/trace.go:171","msg":"trace[1294061643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:586; }","duration":"267.16601ms","start":"2026-04-01T05:11:28.985687Z","end":"2026-04-01T05:11:29.252853Z","steps":["trace[1294061643] 'agreement among raft nodes before linearized reading' (duration: 267.083608ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253584Z","caller":"traceutil/trace.go:171","msg":"trace[1735259887] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:586; }","duration":"775.312008ms","start":"2026-04-01T05:11:28.478263Z","end":"2026-04-01T05:11:29.253575Z","steps":["trace[1735259887] 'agreement among raft nodes before linearized reading' (duration: 775.265547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.912267Z","time spent":"341.315094ms","remote":"127.0.0.1:51884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-01T05:11:29.253596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.597078Z","time spent":"656.503094ms","remote":"127.0.0.1:51852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-01T05:11:29.253632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.478231Z","time spent":"775.37858ms","remote":"127.0.0.1:51828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-01T05:11:29.25364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.382096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.25364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.40729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.253662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.392701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.253701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.198905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.253711Z","caller":"traceutil/trace.go:171","msg":"trace[2063295614] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:586; }","duration":"949.492223ms","start":"2026-04-01T05:11:28.304207Z","end":"2026-04-01T05:11:29.2537Z","steps":["trace[2063295614] 'agreement among raft nodes before linearized reading' (duration: 949.421051ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253325Z","caller":"traceutil/trace.go:171","msg":"trace[1925361878] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:586; }","duration":"656.241488ms","start":"2026-04-01T05:11:28.597062Z","end":"2026-04-01T05:11:29.253304Z","steps":["trace[1925361878] 'agreement among raft nodes before linearized reading' (duration: 656.066684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.304173Z","time spent":"949.569245ms","remote":"127.0.0.1:51812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-01T05:11:29.253676Z","caller":"traceutil/trace.go:171","msg":"trace[348383276] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:586; }","duration":"683.450368ms","start":"2026-04-01T05:11:28.570215Z","end":"2026-04-01T05:11:29.253665Z","steps":["trace[348383276] 'agreement among raft nodes before linearized reading' (duration: 683.307365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.737627ms","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-01T05:11:29.253328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.801202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.253801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.57018Z","time spent":"683.611671ms","remote":"127.0.0.1:51844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-01T05:11:29.253708Z","caller":"traceutil/trace.go:171","msg":"trace[541988075] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:586; }","duration":"775.518862ms","start":"2026-04-01T05:11:28.478158Z","end":"2026-04-01T05:11:29.253677Z","steps":["trace[541988075] 'agreement among raft nodes before linearized reading' (duration: 775.446251ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253813Z","caller":"traceutil/trace.go:171","msg":"trace[969405216] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:586; }","duration":"299.787808ms","start":"2026-04-01T05:11:28.954014Z","end":"2026-04-01T05:11:29.253802Z","steps":["trace[969405216] 'agreement among raft nodes before linearized reading' (duration: 299.730467ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253822Z","caller":"traceutil/trace.go:171","msg":"trace[136310377] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:586; }","duration":"358.317334ms","start":"2026-04-01T05:11:28.895494Z","end":"2026-04-01T05:11:29.253812Z","steps":["trace[136310377] 'agreement among raft nodes before linearized reading' (duration: 357.784742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.478134Z","time spent":"775.698537ms","remote":"127.0.0.1:51828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-01T05:11:29.253859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.895486Z","time spent":"358.361045ms","remote":"127.0.0.1:51866","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:500 "} {"level":"warn","ts":"2026-04-01T05:11:29.253852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.846659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.252529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.647034ms","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-01T05:11:29.253901Z","caller":"traceutil/trace.go:171","msg":"trace[1858304487] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:586; }","duration":"299.921161ms","start":"2026-04-01T05:11:28.953964Z","end":"2026-04-01T05:11:29.253886Z","steps":["trace[1858304487] 'agreement among raft nodes before linearized reading' (duration: 299.846469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.25386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.802456ms","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":"warn","ts":"2026-04-01T05:11:29.253506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.216217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.254Z","caller":"traceutil/trace.go:171","msg":"trace[171632112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"679.71425ms","start":"2026-04-01T05:11:28.574275Z","end":"2026-04-01T05:11:29.253989Z","steps":["trace[171632112] 'agreement among raft nodes before linearized reading' (duration: 679.206678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.25401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.020309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-01T05:11:29.254039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.57427Z","time spent":"679.76037ms","remote":"127.0.0.1:33398","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-01T05:11:29.25405Z","caller":"traceutil/trace.go:171","msg":"trace[1113694002] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"390.092601ms","start":"2026-04-01T05:11:28.863941Z","end":"2026-04-01T05:11:29.254034Z","steps":["trace[1113694002] 'agreement among raft nodes before linearized reading' (duration: 389.926917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.367615ms","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-01T05:11:29.254079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.863911Z","time spent":"390.161492ms","remote":"127.0.0.1:33668","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-01T05:11:29.254019Z","caller":"traceutil/trace.go:171","msg":"trace[1066614263] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:586; }","duration":"359.0013ms","start":"2026-04-01T05:11:28.894973Z","end":"2026-04-01T05:11:29.253974Z","steps":["trace[1066614263] 'agreement among raft nodes before linearized reading' (duration: 358.783615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.709196ms","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-01T05:11:29.252643Z","caller":"traceutil/trace.go:171","msg":"trace[1993987823] 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:586; }","duration":"105.136212ms","start":"2026-04-01T05:11:29.147491Z","end":"2026-04-01T05:11:29.252627Z","steps":["trace[1993987823] 'agreement among raft nodes before linearized reading' (duration: 105.000239ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.254121Z","caller":"traceutil/trace.go:171","msg":"trace[1339829147] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:586; }","duration":"359.02243ms","start":"2026-04-01T05:11:28.895078Z","end":"2026-04-01T05:11:29.2541Z","steps":["trace[1339829147] 'agreement among raft nodes before linearized reading' (duration: 358.353325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.137034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:11:29.254264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.895043Z","time spent":"359.197084ms","remote":"127.0.0.1:51880","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-01T05:11:29.253754Z","caller":"traceutil/trace.go:171","msg":"trace[1949277031] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:586; }","duration":"342.246906ms","start":"2026-04-01T05:11:28.911493Z","end":"2026-04-01T05:11:29.25374Z","steps":["trace[1949277031] 'agreement among raft nodes before linearized reading' (duration: 342.180554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.25433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.89491Z","time spent":"359.248635ms","remote":"127.0.0.1:51880","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-01T05:11:29.254352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.911466Z","time spent":"342.85786ms","remote":"127.0.0.1:51884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-01T05:11:29.25365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.106272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.256647Z","caller":"traceutil/trace.go:171","msg":"trace[425767958] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:586; }","duration":"345.117814ms","start":"2026-04-01T05:11:28.91151Z","end":"2026-04-01T05:11:29.256628Z","steps":["trace[425767958] 'agreement among raft nodes before linearized reading' (duration: 342.107513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.253772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.597044Z","time spent":"656.708609ms","remote":"127.0.0.1:51852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-01T05:11:29.253272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.121956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.253956Z","caller":"traceutil/trace.go:171","msg":"trace[116929827] 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:586; }","duration":"221.131168ms","start":"2026-04-01T05:11:29.0328Z","end":"2026-04-01T05:11:29.253931Z","steps":["trace[116929827] 'agreement among raft nodes before linearized reading' (duration: 219.639084ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.254177Z","caller":"traceutil/trace.go:171","msg":"trace[1746240924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:586; }","duration":"508.070454ms","start":"2026-04-01T05:11:28.746097Z","end":"2026-04-01T05:11:29.254168Z","steps":["trace[1746240924] 'agreement among raft nodes before linearized reading' (duration: 507.718136ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.254279Z","caller":"traceutil/trace.go:171","msg":"trace[162187007] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:586; }","duration":"776.076536ms","start":"2026-04-01T05:11:28.478189Z","end":"2026-04-01T05:11:29.254265Z","steps":["trace[162187007] 'agreement among raft nodes before linearized reading' (duration: 775.183195ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253421Z","caller":"traceutil/trace.go:171","msg":"trace[1440548465] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:586; }","duration":"655.657574ms","start":"2026-04-01T05:11:28.597755Z","end":"2026-04-01T05:11:29.253412Z","steps":["trace[1440548465] 'agreement among raft nodes before linearized reading' (duration: 655.604293ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.253505Z","caller":"traceutil/trace.go:171","msg":"trace[654334220] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:586; }","duration":"683.740264ms","start":"2026-04-01T05:11:28.569752Z","end":"2026-04-01T05:11:29.253493Z","steps":["trace[654334220] 'agreement among raft nodes before linearized reading' (duration: 683.681793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.257289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.911496Z","time spent":"345.776849ms","remote":"127.0.0.1:51884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-01T05:11:29.257366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.569738Z","time spent":"687.577365ms","remote":"127.0.0.1:51844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-01T05:11:29.257557Z","caller":"traceutil/trace.go:171","msg":"trace[1730803852] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:586; }","duration":"247.394127ms","start":"2026-04-01T05:11:29.010123Z","end":"2026-04-01T05:11:29.257517Z","steps":["trace[1730803852] 'agreement among raft nodes before linearized reading' (duration: 243.126765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.257627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.597731Z","time spent":"659.882715ms","remote":"127.0.0.1:51852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-01T05:11:29.257628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.478161Z","time spent":"779.440385ms","remote":"127.0.0.1:51828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-01T05:11:29.257806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:11:28.746076Z","time spent":"511.713141ms","remote":"127.0.0.1:51866","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-01T05:11:29.398163Z","caller":"traceutil/trace.go:171","msg":"trace[1791773227] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"133.701864ms","start":"2026-04-01T05:11:29.26444Z","end":"2026-04-01T05:11:29.398142Z","steps":["trace[1791773227] 'read index received' (duration: 132.092025ms)","trace[1791773227] 'applied index is now lower than readState.Index' (duration: 1.608288ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:29.398253Z","caller":"traceutil/trace.go:171","msg":"trace[1560292834] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"135.517517ms","start":"2026-04-01T05:11:29.262669Z","end":"2026-04-01T05:11:29.398186Z","steps":["trace[1560292834] 'process raft request' (duration: 133.886718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.39829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.830856ms","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-01T05:11:29.398347Z","caller":"traceutil/trace.go:171","msg":"trace[887653966] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:587; }","duration":"133.897968ms","start":"2026-04-01T05:11:29.264437Z","end":"2026-04-01T05:11:29.398335Z","steps":["trace[887653966] 'agreement among raft nodes before linearized reading' (duration: 133.784205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.39853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.082241ms","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-01T05:11:29.398647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.67857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:11:29.39871Z","caller":"traceutil/trace.go:171","msg":"trace[1781733498] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:587; }","duration":"101.770412ms","start":"2026-04-01T05:11:29.29692Z","end":"2026-04-01T05:11:29.39869Z","steps":["trace[1781733498] 'agreement among raft nodes before linearized reading' (duration: 101.647989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:29.39887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.198692ms","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-01T05:11:29.398955Z","caller":"traceutil/trace.go:171","msg":"trace[1078583264] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:587; }","duration":"102.339966ms","start":"2026-04-01T05:11:29.296597Z","end":"2026-04-01T05:11:29.398937Z","steps":["trace[1078583264] 'agreement among raft nodes before linearized reading' (duration: 102.041049ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:29.398638Z","caller":"traceutil/trace.go:171","msg":"trace[423996858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:587; }","duration":"102.194183ms","start":"2026-04-01T05:11:29.296376Z","end":"2026-04-01T05:11:29.398571Z","steps":["trace[423996858] 'agreement among raft nodes before linearized reading' (duration: 101.945588ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:34.952734Z","caller":"traceutil/trace.go:171","msg":"trace[1566951680] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"109.837102ms","start":"2026-04-01T05:11:34.842873Z","end":"2026-04-01T05:11:34.95271Z","steps":["trace[1566951680] 'process raft request' (duration: 109.616016ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:40.664736Z","caller":"traceutil/trace.go:171","msg":"trace[1397918169] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"205.049332ms","start":"2026-04-01T05:11:40.459666Z","end":"2026-04-01T05:11:40.664715Z","steps":["trace[1397918169] 'process raft request' (duration: 204.889768ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:45.499576Z","caller":"traceutil/trace.go:171","msg":"trace[719465433] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"115.787302ms","start":"2026-04-01T05:11:45.383765Z","end":"2026-04-01T05:11:45.499553Z","steps":["trace[719465433] 'read index received' (duration: 115.578787ms)","trace[719465433] 'applied index is now lower than readState.Index' (duration: 207.315µs)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:45.499774Z","caller":"traceutil/trace.go:171","msg":"trace[720004005] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"184.457287ms","start":"2026-04-01T05:11:45.315293Z","end":"2026-04-01T05:11:45.49975Z","steps":["trace[720004005] 'process raft request' (duration: 184.064967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:45.500044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.251764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-01T05:11:45.500322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.516389ms","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-01T05:11:45.500404Z","caller":"traceutil/trace.go:171","msg":"trace[1291562977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:747; }","duration":"116.631352ms","start":"2026-04-01T05:11:45.383755Z","end":"2026-04-01T05:11:45.500387Z","steps":["trace[1291562977] 'agreement among raft nodes before linearized reading' (duration: 116.400227ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:45.500094Z","caller":"traceutil/trace.go:171","msg":"trace[39173654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:747; }","duration":"116.363136ms","start":"2026-04-01T05:11:45.383718Z","end":"2026-04-01T05:11:45.500081Z","steps":["trace[39173654] 'agreement among raft nodes before linearized reading' (duration: 116.039659ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:11:45.733838Z","caller":"traceutil/trace.go:171","msg":"trace[1878636494] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"227.992969ms","start":"2026-04-01T05:11:45.505804Z","end":"2026-04-01T05:11:45.733797Z","steps":["trace[1878636494] 'process raft request' (duration: 182.960331ms)","trace[1878636494] 'compare' (duration: 44.826624ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:45.739914Z","caller":"traceutil/trace.go:171","msg":"trace[1590439133] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:777; }","duration":"209.827813ms","start":"2026-04-01T05:11:45.530042Z","end":"2026-04-01T05:11:45.739869Z","steps":["trace[1590439133] 'read index received' (duration: 158.744653ms)","trace[1590439133] 'applied index is now lower than readState.Index' (duration: 51.08174ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:11:45.739988Z","caller":"traceutil/trace.go:171","msg":"trace[1002269498] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"233.946319ms","start":"2026-04-01T05:11:45.506014Z","end":"2026-04-01T05:11:45.73996Z","steps":["trace[1002269498] 'process raft request' (duration: 233.712424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:45.740284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.202812ms","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-01T05:11:45.740383Z","caller":"traceutil/trace.go:171","msg":"trace[266567759] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:749; }","duration":"210.348995ms","start":"2026-04-01T05:11:45.530014Z","end":"2026-04-01T05:11:45.740363Z","steps":["trace[266567759] 'agreement among raft nodes before linearized reading' (duration: 210.064798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:11:45.740384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.852801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hdr7s\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-01T05:11:45.740499Z","caller":"traceutil/trace.go:171","msg":"trace[772304899] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hdr7s; range_end:; response_count:1; response_revision:749; }","duration":"124.038816ms","start":"2026-04-01T05:11:45.616431Z","end":"2026-04-01T05:11:45.74047Z","steps":["trace[772304899] 'agreement among raft nodes before linearized reading' (duration: 123.711119ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:02.741919Z","caller":"traceutil/trace.go:171","msg":"trace[1840848057] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"109.335481ms","start":"2026-04-01T05:12:02.632535Z","end":"2026-04-01T05:12:02.741871Z","steps":["trace[1840848057] 'process raft request' (duration: 52.427853ms)","trace[1840848057] 'compare' (duration: 56.598431ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:12:02.741983Z","caller":"traceutil/trace.go:171","msg":"trace[425650829] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"107.705172ms","start":"2026-04-01T05:12:02.634233Z","end":"2026-04-01T05:12:02.741939Z","steps":["trace[425650829] 'process raft request' (duration: 107.549788ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.036349Z","caller":"traceutil/trace.go:171","msg":"trace[1980727228] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"111.854408ms","start":"2026-04-01T05:12:02.924467Z","end":"2026-04-01T05:12:03.036322Z","steps":["trace[1980727228] 'process raft request' (duration: 111.300456ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.226289Z","caller":"traceutil/trace.go:171","msg":"trace[1233345760] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"283.859153ms","start":"2026-04-01T05:12:02.942395Z","end":"2026-04-01T05:12:03.226254Z","steps":["trace[1233345760] 'process raft request' (duration: 283.484234ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.226285Z","caller":"traceutil/trace.go:171","msg":"trace[1817267028] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1025; }","duration":"188.390429ms","start":"2026-04-01T05:12:03.037862Z","end":"2026-04-01T05:12:03.226253Z","steps":["trace[1817267028] 'read index received' (duration: 187.960589ms)","trace[1817267028] 'applied index is now lower than readState.Index' (duration: 428.56µs)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:12:03.226376Z","caller":"traceutil/trace.go:171","msg":"trace[1799694019] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"279.4756ms","start":"2026-04-01T05:12:02.946862Z","end":"2026-04-01T05:12:03.226338Z","steps":["trace[1799694019] 'process raft request' (duration: 279.274315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:12:03.226627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.730086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:91156"} {"level":"info","ts":"2026-04-01T05:12:03.226689Z","caller":"traceutil/trace.go:171","msg":"trace[283868032] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:991; }","duration":"188.857909ms","start":"2026-04-01T05:12:03.037813Z","end":"2026-04-01T05:12:03.226671Z","steps":["trace[283868032] 'agreement among raft nodes before linearized reading' (duration: 188.614304ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.266468Z","caller":"traceutil/trace.go:171","msg":"trace[18864030] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"228.135724ms","start":"2026-04-01T05:12:03.038312Z","end":"2026-04-01T05:12:03.266448Z","steps":["trace[18864030] 'process raft request' (duration: 228.004321ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.47974Z","caller":"traceutil/trace.go:171","msg":"trace[169177700] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"135.005914ms","start":"2026-04-01T05:12:03.344703Z","end":"2026-04-01T05:12:03.479709Z","steps":["trace[169177700] 'process raft request' (duration: 118.753732ms)","trace[169177700] 'compare' (duration: 15.931415ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:12:03.479771Z","caller":"traceutil/trace.go:171","msg":"trace[1245324114] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"134.334899ms","start":"2026-04-01T05:12:03.345388Z","end":"2026-04-01T05:12:03.479723Z","steps":["trace[1245324114] 'process raft request' (duration: 134.101833ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.4798Z","caller":"traceutil/trace.go:171","msg":"trace[1479691019] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"132.567508ms","start":"2026-04-01T05:12:03.347202Z","end":"2026-04-01T05:12:03.479769Z","steps":["trace[1479691019] 'process raft request' (duration: 132.339402ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.47987Z","caller":"traceutil/trace.go:171","msg":"trace[1305624734] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"132.583338ms","start":"2026-04-01T05:12:03.34727Z","end":"2026-04-01T05:12:03.479853Z","steps":["trace[1305624734] 'process raft request' (duration: 132.303881ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:03.480015Z","caller":"traceutil/trace.go:171","msg":"trace[883133163] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"131.305688ms","start":"2026-04-01T05:12:03.348511Z","end":"2026-04-01T05:12:03.479816Z","steps":["trace[883133163] 'process raft request' (duration: 131.135624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:12:15.09543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.78874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:12:15.095532Z","caller":"traceutil/trace.go:171","msg":"trace[1444085221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1145; }","duration":"519.904233ms","start":"2026-04-01T05:12:14.575607Z","end":"2026-04-01T05:12:15.095511Z","steps":["trace[1444085221] 'range keys from in-memory index tree' (duration: 519.680108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:12:15.095577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:12:14.57554Z","time spent":"520.027695ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:12:15.095671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.323278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-01T05:12:15.095726Z","caller":"traceutil/trace.go:171","msg":"trace[759671400] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1145; }","duration":"322.413991ms","start":"2026-04-01T05:12:14.773294Z","end":"2026-04-01T05:12:15.095708Z","steps":["trace[759671400] 'count revisions from in-memory index tree' (duration: 322.193525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:12:15.095762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:12:14.773274Z","time spent":"322.477872ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":10,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-04-01T05:12:15.096057Z","caller":"traceutil/trace.go:171","msg":"trace[282123002] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"176.9284ms","start":"2026-04-01T05:12:14.9191Z","end":"2026-04-01T05:12:15.096029Z","steps":["trace[282123002] 'process raft request' (duration: 112.551316ms)","trace[282123002] 'compare' (duration: 64.259161ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:12:31.843776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.877547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-01T05:12:31.843872Z","caller":"traceutil/trace.go:171","msg":"trace[1103988976] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:1284; }","duration":"149.03768ms","start":"2026-04-01T05:12:31.694813Z","end":"2026-04-01T05:12:31.843851Z","steps":["trace[1103988976] 'range keys from in-memory index tree' (duration: 148.698553ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:37.304615Z","caller":"traceutil/trace.go:171","msg":"trace[981779760] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"110.046322ms","start":"2026-04-01T05:12:37.194545Z","end":"2026-04-01T05:12:37.304591Z","steps":["trace[981779760] 'process raft request' (duration: 109.852017ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:37.360405Z","caller":"traceutil/trace.go:171","msg":"trace[1097269427] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"111.61935ms","start":"2026-04-01T05:12:37.248757Z","end":"2026-04-01T05:12:37.360376Z","steps":["trace[1097269427] 'process raft request' (duration: 111.443666ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:43.342836Z","caller":"traceutil/trace.go:171","msg":"trace[364989684] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"158.391387ms","start":"2026-04-01T05:12:43.184416Z","end":"2026-04-01T05:12:43.342807Z","steps":["trace[364989684] 'process raft request' (duration: 76.604056ms)","trace[364989684] 'compare' (duration: 81.653658ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:12:43.343297Z","caller":"traceutil/trace.go:171","msg":"trace[1400268787] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"158.717005ms","start":"2026-04-01T05:12:43.184563Z","end":"2026-04-01T05:12:43.34328Z","steps":["trace[1400268787] 'process raft request' (duration: 158.657664ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:43.50435Z","caller":"traceutil/trace.go:171","msg":"trace[2044043422] linearizableReadLoop","detail":"{readStateIndex:1533; appliedIndex:1532; }","duration":"116.578368ms","start":"2026-04-01T05:12:43.387748Z","end":"2026-04-01T05:12:43.504326Z","steps":["trace[2044043422] 'read index received' (duration: 70.250002ms)","trace[2044043422] 'applied index is now lower than readState.Index' (duration: 46.327176ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:12:43.504399Z","caller":"traceutil/trace.go:171","msg":"trace[1949947222] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"153.008656ms","start":"2026-04-01T05:12:43.351365Z","end":"2026-04-01T05:12:43.504374Z","steps":["trace[1949947222] 'process raft request' (duration: 106.718711ms)","trace[1949947222] 'compare' (duration: 46.05516ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:12:43.504574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.814574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/shovels.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:12:43.504621Z","caller":"traceutil/trace.go:171","msg":"trace[491969763] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/shovels.rabbitmq.com; range_end:; response_count:0; response_revision:1486; }","duration":"116.911456ms","start":"2026-04-01T05:12:43.387695Z","end":"2026-04-01T05:12:43.504606Z","steps":["trace[491969763] 'agreement among raft nodes before linearized reading' (duration: 116.761502ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:12:56.002583Z","caller":"traceutil/trace.go:171","msg":"trace[1120100383] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"127.237856ms","start":"2026-04-01T05:12:55.875322Z","end":"2026-04-01T05:12:56.00256Z","steps":["trace[1120100383] 'process raft request' (duration: 127.056052ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:00.548055Z","caller":"traceutil/trace.go:171","msg":"trace[1597596972] linearizableReadLoop","detail":"{readStateIndex:1850; appliedIndex:1847; }","duration":"149.394129ms","start":"2026-04-01T05:13:00.39864Z","end":"2026-04-01T05:13:00.548034Z","steps":["trace[1597596972] 'read index received' (duration: 11.423345ms)","trace[1597596972] 'applied index is now lower than readState.Index' (duration: 137.969974ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:00.548135Z","caller":"traceutil/trace.go:171","msg":"trace[768931861] transaction","detail":"{read_only:false; response_revision:1776; number_of_response:1; }","duration":"150.566427ms","start":"2026-04-01T05:13:00.397537Z","end":"2026-04-01T05:13:00.548104Z","steps":["trace[768931861] 'process raft request' (duration: 127.962383ms)","trace[768931861] 'compare' (duration: 22.239105ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:00.548224Z","caller":"traceutil/trace.go:171","msg":"trace[1340804590] transaction","detail":"{read_only:false; response_revision:1777; number_of_response:1; }","duration":"150.351993ms","start":"2026-04-01T05:13:00.397861Z","end":"2026-04-01T05:13:00.548213Z","steps":["trace[1340804590] 'process raft request' (duration: 150.018065ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:00.548419Z","caller":"traceutil/trace.go:171","msg":"trace[1249563034] transaction","detail":"{read_only:false; response_revision:1778; number_of_response:1; }","duration":"148.935988ms","start":"2026-04-01T05:13:00.39944Z","end":"2026-04-01T05:13:00.548376Z","steps":["trace[1249563034] 'process raft request' (duration: 148.496968ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:00.548491Z","caller":"traceutil/trace.go:171","msg":"trace[1622115896] transaction","detail":"{read_only:false; response_revision:1779; number_of_response:1; }","duration":"146.865968ms","start":"2026-04-01T05:13:00.401503Z","end":"2026-04-01T05:13:00.548369Z","steps":["trace[1622115896] 'process raft request' (duration: 146.475519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:00.548592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.933712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:9247"} {"level":"info","ts":"2026-04-01T05:13:00.548649Z","caller":"traceutil/trace.go:171","msg":"trace[308112353] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1779; }","duration":"150.015726ms","start":"2026-04-01T05:13:00.398617Z","end":"2026-04-01T05:13:00.548632Z","steps":["trace[308112353] 'agreement among raft nodes before linearized reading' (duration: 149.82327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:00.548692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.694356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:15319"} {"level":"info","ts":"2026-04-01T05:13:00.548733Z","caller":"traceutil/trace.go:171","msg":"trace[124540525] range","detail":"{range_begin:/registry/statefulsets/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:1779; }","duration":"144.786749ms","start":"2026-04-01T05:13:00.403934Z","end":"2026-04-01T05:13:00.54872Z","steps":["trace[124540525] 'agreement among raft nodes before linearized reading' (duration: 144.641534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:00.550642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.927208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" ","response":"range_response_count:1 size:18091"} {"level":"info","ts":"2026-04-01T05:13:00.550735Z","caller":"traceutil/trace.go:171","msg":"trace[2061729991] range","detail":"{range_begin:/registry/statefulsets/openstack/percona-xtradb-pxc; range_end:; response_count:1; response_revision:1779; }","duration":"144.058471ms","start":"2026-04-01T05:13:00.406654Z","end":"2026-04-01T05:13:00.550712Z","steps":["trace[2061729991] 'agreement among raft nodes before linearized reading' (duration: 142.238538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.079164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.168537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-01T05:13:04.079326Z","caller":"traceutil/trace.go:171","msg":"trace[995257279] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"503.145954ms","start":"2026-04-01T05:13:03.576158Z","end":"2026-04-01T05:13:04.079304Z","steps":["trace[995257279] 'read index received' (duration: 262.67843ms)","trace[995257279] 'applied index is now lower than readState.Index' (duration: 240.465694ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:13:04.079508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.301087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:13:04.079538Z","caller":"traceutil/trace.go:171","msg":"trace[1060245637] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"619.456135ms","start":"2026-04-01T05:13:03.459868Z","end":"2026-04-01T05:13:04.079324Z","steps":["trace[1060245637] 'process raft request' (duration: 378.975691ms)","trace[1060245637] 'compare' (duration: 239.755937ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:04.079588Z","caller":"traceutil/trace.go:171","msg":"trace[1323191852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1831; }","duration":"503.453851ms","start":"2026-04-01T05:13:03.576119Z","end":"2026-04-01T05:13:04.079573Z","steps":["trace[1323191852] 'agreement among raft nodes before linearized reading' (duration: 503.276017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.079709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:03.576094Z","time spent":"503.603524ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:13:04.079827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:03.45983Z","time spent":"619.791054ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:04.131288Z","caller":"traceutil/trace.go:171","msg":"trace[1306878698] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"534.17579ms","start":"2026-04-01T05:13:03.597086Z","end":"2026-04-01T05:13:04.131262Z","steps":["trace[1306878698] 'process raft request' (duration: 534.005886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.131453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:03.597068Z","time spent":"534.298044ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:04.131603Z","caller":"traceutil/trace.go:171","msg":"trace[1086346981] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"350.126486ms","start":"2026-04-01T05:13:03.781465Z","end":"2026-04-01T05:13:04.131592Z","steps":["trace[1086346981] 'process raft request' (duration: 349.761437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.131647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:03.781419Z","time spent":"350.205498ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:13:04.408086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.595224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-01T05:13:04.408344Z","caller":"traceutil/trace.go:171","msg":"trace[1146362194] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"270.834965ms","start":"2026-04-01T05:13:04.137489Z","end":"2026-04-01T05:13:04.408324Z","steps":["trace[1146362194] 'process raft request' (duration: 270.710662ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:04.408407Z","caller":"traceutil/trace.go:171","msg":"trace[1562933702] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"406.821453ms","start":"2026-04-01T05:13:04.001555Z","end":"2026-04-01T05:13:04.408376Z","steps":["trace[1562933702] 'process raft request' (duration: 190.848569ms)","trace[1562933702] 'compare' (duration: 215.178995ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:04.408439Z","caller":"traceutil/trace.go:171","msg":"trace[1395059105] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1905; }","duration":"329.047588ms","start":"2026-04-01T05:13:04.079355Z","end":"2026-04-01T05:13:04.408403Z","steps":["trace[1395059105] 'read index received' (duration: 51.849009ms)","trace[1395059105] 'applied index is now lower than readState.Index' (duration: 277.195289ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:13:04.408564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.001524Z","time spent":"406.956886ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:13:04.408586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.334747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-00e97781-0b7f-49ef-825a-60f04d4f3064\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-01T05:13:04.408619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.279589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-00e97781-0b7f-49ef-825a-60f04d4f3064\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-01T05:13:04.40865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.685726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:13:04.408662Z","caller":"traceutil/trace.go:171","msg":"trace[829344111] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-00e97781-0b7f-49ef-825a-60f04d4f3064; range_end:; response_count:1; response_revision:1835; }","duration":"393.428959ms","start":"2026-04-01T05:13:04.015198Z","end":"2026-04-01T05:13:04.408627Z","steps":["trace[829344111] 'agreement among raft nodes before linearized reading' (duration: 393.211694ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:04.408683Z","caller":"traceutil/trace.go:171","msg":"trace[124820597] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-00e97781-0b7f-49ef-825a-60f04d4f3064; range_end:; response_count:1; response_revision:1835; }","duration":"760.394941ms","start":"2026-04-01T05:13:03.648272Z","end":"2026-04-01T05:13:04.408667Z","steps":["trace[124820597] 'agreement among raft nodes before linearized reading' (duration: 760.141855ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:04.408698Z","caller":"traceutil/trace.go:171","msg":"trace[1863761350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1835; }","duration":"327.772938ms","start":"2026-04-01T05:13:04.080911Z","end":"2026-04-01T05:13:04.408684Z","steps":["trace[1863761350] 'agreement among raft nodes before linearized reading' (duration: 327.686886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.408713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.015171Z","time spent":"393.533261ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-00e97781-0b7f-49ef-825a-60f04d4f3064\" "} {"level":"warn","ts":"2026-04-01T05:13:04.408727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:03.64825Z","time spent":"760.466864ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-00e97781-0b7f-49ef-825a-60f04d4f3064\" "} {"level":"warn","ts":"2026-04-01T05:13:04.408748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.080893Z","time spent":"327.844819ms","remote":"127.0.0.1:33382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:13:04.408713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.716455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-01T05:13:04.408793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.605607ms","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-01T05:13:04.408841Z","caller":"traceutil/trace.go:171","msg":"trace[1297223117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1835; }","duration":"349.87883ms","start":"2026-04-01T05:13:04.058923Z","end":"2026-04-01T05:13:04.408801Z","steps":["trace[1297223117] 'agreement among raft nodes before linearized reading' (duration: 349.517201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.408901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.058903Z","time spent":"349.986983ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-01T05:13:04.408903Z","caller":"traceutil/trace.go:171","msg":"trace[756000488] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1835; }","duration":"782.75086ms","start":"2026-04-01T05:13:03.626123Z","end":"2026-04-01T05:13:04.408874Z","steps":["trace[756000488] 'agreement among raft nodes before linearized reading' (duration: 782.450893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.408764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.513189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-01T05:13:04.408969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:03.626111Z","time spent":"782.847673ms","remote":"127.0.0.1:43616","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-01T05:13:04.409035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.975765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-01T05:13:04.409103Z","caller":"traceutil/trace.go:171","msg":"trace[2104417856] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1835; }","duration":"133.086787ms","start":"2026-04-01T05:13:04.276Z","end":"2026-04-01T05:13:04.409087Z","steps":["trace[2104417856] 'agreement among raft nodes before linearized reading' (duration: 132.891963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:04.409119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.023191ms","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-01T05:13:04.409033Z","caller":"traceutil/trace.go:171","msg":"trace[793021360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1835; }","duration":"126.785945ms","start":"2026-04-01T05:13:04.282162Z","end":"2026-04-01T05:13:04.409003Z","steps":["trace[793021360] 'agreement among raft nodes before linearized reading' (duration: 126.470727ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:04.409163Z","caller":"traceutil/trace.go:171","msg":"trace[1696603476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1835; }","duration":"127.106003ms","start":"2026-04-01T05:13:04.282045Z","end":"2026-04-01T05:13:04.409151Z","steps":["trace[1696603476] 'agreement among raft nodes before linearized reading' (duration: 126.783764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.027875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.894803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-01T05:13:05.028222Z","caller":"traceutil/trace.go:171","msg":"trace[978022618] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"614.60733ms","start":"2026-04-01T05:13:04.413576Z","end":"2026-04-01T05:13:05.028183Z","steps":["trace[978022618] 'process raft request' (duration: 112.275095ms)","trace[978022618] 'compare' (duration: 501.78034ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:13:05.028389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.413542Z","time spent":"614.763303ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:05.028888Z","caller":"traceutil/trace.go:171","msg":"trace[571802778] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"615.155563ms","start":"2026-04-01T05:13:04.41371Z","end":"2026-04-01T05:13:05.028865Z","steps":["trace[571802778] 'process raft request' (duration: 614.421215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.029001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.413683Z","time spent":"615.264456ms","remote":"127.0.0.1:33668","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-01T05:13:05.029121Z","caller":"traceutil/trace.go:171","msg":"trace[1170402267] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"615.337917ms","start":"2026-04-01T05:13:04.413744Z","end":"2026-04-01T05:13:05.029082Z","steps":["trace[1170402267] 'process raft request' (duration: 614.537868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.029304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.413729Z","time spent":"615.477931ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:05.029339Z","caller":"traceutil/trace.go:171","msg":"trace[1516709640] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"612.848836ms","start":"2026-04-01T05:13:04.416471Z","end":"2026-04-01T05:13:05.02932Z","steps":["trace[1516709640] 'process raft request' (duration: 612.396686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.029428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.416457Z","time spent":"612.924849ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:05.029422Z","caller":"traceutil/trace.go:171","msg":"trace[2103498450] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1910; }","duration":"453.015075ms","start":"2026-04-01T05:13:04.57638Z","end":"2026-04-01T05:13:05.029395Z","steps":["trace[2103498450] 'read index received' (duration: 52.521µs)","trace[2103498450] 'applied index is now lower than readState.Index' (duration: 452.958144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:13:05.029542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.170919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:13:05.029606Z","caller":"traceutil/trace.go:171","msg":"trace[546313549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1840; }","duration":"453.289952ms","start":"2026-04-01T05:13:04.576297Z","end":"2026-04-01T05:13:05.029587Z","steps":["trace[546313549] 'agreement among raft nodes before linearized reading' (duration: 453.19702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.029647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.576262Z","time spent":"453.376894ms","remote":"127.0.0.1:33398","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-01T05:13:05.029854Z","caller":"traceutil/trace.go:171","msg":"trace[347942055] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"263.599042ms","start":"2026-04-01T05:13:04.766232Z","end":"2026-04-01T05:13:05.029831Z","steps":["trace[347942055] 'process raft request' (duration: 263.073919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.030245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.921136ms","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-01T05:13:05.030374Z","caller":"traceutil/trace.go:171","msg":"trace[1701679635] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1841; }","duration":"383.07345ms","start":"2026-04-01T05:13:04.647275Z","end":"2026-04-01T05:13:05.030349Z","steps":["trace[1701679635] 'agreement among raft nodes before linearized reading' (duration: 382.599689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:05.030494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:04.647261Z","time spent":"383.216003ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-01T05:13:06.139719Z","caller":"traceutil/trace.go:171","msg":"trace[336630392] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"100.142322ms","start":"2026-04-01T05:13:06.039538Z","end":"2026-04-01T05:13:06.13968Z","steps":["trace[336630392] 'process raft request' (duration: 99.748193ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:18.83207Z","caller":"traceutil/trace.go:171","msg":"trace[506773782] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"614.584248ms","start":"2026-04-01T05:13:18.217452Z","end":"2026-04-01T05:13:18.832036Z","steps":["trace[506773782] 'process raft request' (duration: 614.368163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:18.8323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.217422Z","time spent":"614.757252ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:18.878104Z","caller":"traceutil/trace.go:171","msg":"trace[1851155275] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"411.206318ms","start":"2026-04-01T05:13:18.466869Z","end":"2026-04-01T05:13:18.878075Z","steps":["trace[1851155275] 'process raft request' (duration: 411.134776ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:18.878136Z","caller":"traceutil/trace.go:171","msg":"trace[935986780] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"597.771704ms","start":"2026-04-01T05:13:18.280325Z","end":"2026-04-01T05:13:18.878097Z","steps":["trace[935986780] 'process raft request' (duration: 597.522057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:18.878326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.466837Z","time spent":"411.387023ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:13:18.878359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.280298Z","time spent":"597.950358ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:18.878359Z","caller":"traceutil/trace.go:171","msg":"trace[331157464] linearizableReadLoop","detail":"{readStateIndex:2023; appliedIndex:2019; }","duration":"382.65385ms","start":"2026-04-01T05:13:18.495683Z","end":"2026-04-01T05:13:18.878337Z","steps":["trace[331157464] 'read index received' (duration: 336.137969ms)","trace[331157464] 'applied index is now lower than readState.Index' (duration: 46.513461ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:18.87841Z","caller":"traceutil/trace.go:171","msg":"trace[751526755] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"411.264029ms","start":"2026-04-01T05:13:18.467116Z","end":"2026-04-01T05:13:18.87838Z","steps":["trace[751526755] 'process raft request' (duration: 410.925871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:18.878554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.870576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-01T05:13:18.878622Z","caller":"traceutil/trace.go:171","msg":"trace[1022264324] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1945; }","duration":"382.977548ms","start":"2026-04-01T05:13:18.495629Z","end":"2026-04-01T05:13:18.878607Z","steps":["trace[1022264324] 'agreement among raft nodes before linearized reading' (duration: 382.767963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:18.87867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.495603Z","time spent":"383.05319ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-01T05:13:18.87867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.668939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:13:18.878668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.467085Z","time spent":"411.485055ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:18.878722Z","caller":"traceutil/trace.go:171","msg":"trace[912160846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1945; }","duration":"301.763891ms","start":"2026-04-01T05:13:18.57694Z","end":"2026-04-01T05:13:18.878704Z","steps":["trace[912160846] 'agreement among raft nodes before linearized reading' (duration: 301.685149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:18.878763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.576886Z","time spent":"301.866903ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:13:18.878764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.655353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-mtfq4\" ","response":"range_response_count:1 size:5855"} {"level":"warn","ts":"2026-04-01T05:13:18.878778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.673795ms","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-01T05:13:18.878817Z","caller":"traceutil/trace.go:171","msg":"trace[926363466] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-mtfq4; range_end:; response_count:1; response_revision:1945; }","duration":"214.760285ms","start":"2026-04-01T05:13:18.66404Z","end":"2026-04-01T05:13:18.8788Z","steps":["trace[926363466] 'agreement among raft nodes before linearized reading' (duration: 214.562951ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:18.878856Z","caller":"traceutil/trace.go:171","msg":"trace[1712962663] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1945; }","duration":"366.825679ms","start":"2026-04-01T05:13:18.512008Z","end":"2026-04-01T05:13:18.878833Z","steps":["trace[1712962663] 'agreement among raft nodes before linearized reading' (duration: 366.578553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:18.878916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:18.511974Z","time spent":"366.930821ms","remote":"127.0.0.1:43616","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":"info","ts":"2026-04-01T05:13:56.79947Z","caller":"traceutil/trace.go:171","msg":"trace[228690062] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"192.408462ms","start":"2026-04-01T05:13:56.606986Z","end":"2026-04-01T05:13:56.799395Z","steps":["trace[228690062] 'process raft request' (duration: 192.119465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.35885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.68556ms","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-01T05:13:57.358962Z","caller":"traceutil/trace.go:171","msg":"trace[38620886] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2163; }","duration":"402.871675ms","start":"2026-04-01T05:13:56.956065Z","end":"2026-04-01T05:13:57.358937Z","steps":["trace[38620886] 'count revisions from in-memory index tree' (duration: 402.453555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.359018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:56.956042Z","time spent":"402.963037ms","remote":"127.0.0.1:51922","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":"info","ts":"2026-04-01T05:13:57.358997Z","caller":"traceutil/trace.go:171","msg":"trace[250337532] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"399.280319ms","start":"2026-04-01T05:13:56.959687Z","end":"2026-04-01T05:13:57.358967Z","steps":["trace[250337532] 'process raft request' (duration: 327.462478ms)","trace[250337532] 'compare' (duration: 71.703588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:13:57.359347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:56.959645Z","time spent":"399.561605ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:13:57.838178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.413542ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-01T05:13:57.838698Z","caller":"traceutil/trace.go:171","msg":"trace[236561062] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"632.133413ms","start":"2026-04-01T05:13:57.20652Z","end":"2026-04-01T05:13:57.838653Z","steps":["trace[236561062] 'process raft request' (duration: 631.798495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.838835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.206485Z","time spent":"632.264286ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:57.920191Z","caller":"traceutil/trace.go:171","msg":"trace[335901168] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"712.214791ms","start":"2026-04-01T05:13:57.207917Z","end":"2026-04-01T05:13:57.920132Z","steps":["trace[335901168] 'process raft request' (duration: 630.721421ms)","trace[335901168] 'compare' (duration: 81.06854ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:57.920258Z","caller":"traceutil/trace.go:171","msg":"trace[682101705] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"709.934176ms","start":"2026-04-01T05:13:57.210281Z","end":"2026-04-01T05:13:57.920216Z","steps":["trace[682101705] 'process raft request' (duration: 709.711481ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:57.920348Z","caller":"traceutil/trace.go:171","msg":"trace[1739521539] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2249; }","duration":"758.903364ms","start":"2026-04-01T05:13:57.161409Z","end":"2026-04-01T05:13:57.920313Z","steps":["trace[1739521539] 'read index received' (duration: 125.748375ms)","trace[1739521539] 'applied index is now lower than readState.Index' (duration: 633.149088ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:13:57.920404Z","caller":"traceutil/trace.go:171","msg":"trace[1157125041] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"485.296537ms","start":"2026-04-01T05:13:57.435076Z","end":"2026-04-01T05:13:57.920372Z","steps":["trace[1157125041] 'process raft request' (duration: 485.103712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.92046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.207909Z","time spent":"712.408836ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:13:57.920516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.435044Z","time spent":"485.41889ms","remote":"127.0.0.1:33566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:13:57.920784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.510956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-01T05:13:57.920837Z","caller":"traceutil/trace.go:171","msg":"trace[917564990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2169; }","duration":"604.588908ms","start":"2026-04-01T05:13:57.316235Z","end":"2026-04-01T05:13:57.920824Z","steps":["trace[917564990] 'agreement among raft nodes before linearized reading' (duration: 604.381812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.920819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.014926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-01T05:13:57.920886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.745674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-01T05:13:57.920925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.532179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:13:57.920947Z","caller":"traceutil/trace.go:171","msg":"trace[701071477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2169; }","duration":"615.856286ms","start":"2026-04-01T05:13:57.305074Z","end":"2026-04-01T05:13:57.92093Z","steps":["trace[701071477] 'agreement among raft nodes before linearized reading' (duration: 615.610799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.920879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.316223Z","time spent":"604.64733ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-01T05:13:57.920971Z","caller":"traceutil/trace.go:171","msg":"trace[1900644165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2169; }","duration":"759.617851ms","start":"2026-04-01T05:13:57.16134Z","end":"2026-04-01T05:13:57.920958Z","steps":["trace[1900644165] 'agreement among raft nodes before linearized reading' (duration: 759.147739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.920997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.305063Z","time spent":"615.925898ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-01T05:13:57.921012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.161307Z","time spent":"759.698723ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:13:57.921017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.728294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:13:57.921022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.573273ms","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-01T05:13:57.921078Z","caller":"traceutil/trace.go:171","msg":"trace[1805948175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2169; }","duration":"345.832826ms","start":"2026-04-01T05:13:57.575225Z","end":"2026-04-01T05:13:57.921058Z","steps":["trace[1805948175] 'agreement among raft nodes before linearized reading' (duration: 345.736384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.921127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.575215Z","time spent":"345.900867ms","remote":"127.0.0.1:33382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:13:57.921111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.210254Z","time spent":"710.124401ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:57.921139Z","caller":"traceutil/trace.go:171","msg":"trace[152621151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2169; }","duration":"608.714967ms","start":"2026-04-01T05:13:57.312381Z","end":"2026-04-01T05:13:57.921096Z","steps":["trace[152621151] 'agreement among raft nodes before linearized reading' (duration: 608.451691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.921223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.963696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-01T05:13:57.921274Z","caller":"traceutil/trace.go:171","msg":"trace[519703958] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2169; }","duration":"353.014517ms","start":"2026-04-01T05:13:57.568246Z","end":"2026-04-01T05:13:57.921261Z","steps":["trace[519703958] 'agreement among raft nodes before linearized reading' (duration: 352.928815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.921314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.568207Z","time spent":"353.097159ms","remote":"127.0.0.1:33914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-04-01T05:13:57.921359Z","caller":"traceutil/trace.go:171","msg":"trace[830987334] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"326.324772ms","start":"2026-04-01T05:13:57.595018Z","end":"2026-04-01T05:13:57.921342Z","steps":["trace[830987334] 'process raft request' (duration: 325.289526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.921309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.417094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-01T05:13:57.921406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.572425ms","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":"warn","ts":"2026-04-01T05:13:57.921434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.594997Z","time spent":"326.392103ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:13:57.921413Z","caller":"traceutil/trace.go:171","msg":"trace[370633701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2169; }","duration":"617.558697ms","start":"2026-04-01T05:13:57.303838Z","end":"2026-04-01T05:13:57.921397Z","steps":["trace[370633701] 'agreement among raft nodes before linearized reading' (duration: 617.352632ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:13:57.921471Z","caller":"traceutil/trace.go:171","msg":"trace[495919132] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2169; }","duration":"627.689068ms","start":"2026-04-01T05:13:57.293761Z","end":"2026-04-01T05:13:57.92145Z","steps":["trace[495919132] 'agreement among raft nodes before linearized reading' (duration: 627.513104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.921519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.293732Z","time spent":"627.7745ms","remote":"127.0.0.1:43616","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-01T05:13:57.921551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.303775Z","time spent":"617.724901ms","remote":"127.0.0.1:33668","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-01T05:13:57.920938Z","caller":"traceutil/trace.go:171","msg":"trace[445091876] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2169; }","duration":"688.20864ms","start":"2026-04-01T05:13:57.232705Z","end":"2026-04-01T05:13:57.920913Z","steps":["trace[445091876] 'agreement among raft nodes before linearized reading' (duration: 687.870241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:13:57.921715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.232673Z","time spent":"689.028619ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-01T05:13:57.921201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:13:57.312369Z","time spent":"608.823939ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-01T05:14:45.315302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.810755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-01T05:14:45.315427Z","caller":"traceutil/trace.go:171","msg":"trace[545237782] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2591; }","duration":"120.01902ms","start":"2026-04-01T05:14:45.195383Z","end":"2026-04-01T05:14:45.315402Z","steps":["trace[545237782] 'count revisions from in-memory index tree' (duration: 119.674662ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:14:48.563212Z","caller":"traceutil/trace.go:171","msg":"trace[751557886] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"380.311471ms","start":"2026-04-01T05:14:48.18288Z","end":"2026-04-01T05:14:48.563191Z","steps":["trace[751557886] 'process raft request' (duration: 380.182908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:14:48.563336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:14:48.18286Z","time spent":"380.417773ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:14:48.627836Z","caller":"traceutil/trace.go:171","msg":"trace[652940744] linearizableReadLoop","detail":"{readStateIndex:2717; appliedIndex:2715; }","duration":"384.214333ms","start":"2026-04-01T05:14:48.243598Z","end":"2026-04-01T05:14:48.627812Z","steps":["trace[652940744] 'read index received' (duration: 319.509362ms)","trace[652940744] 'applied index is now lower than readState.Index' (duration: 64.704001ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:14:48.627926Z","caller":"traceutil/trace.go:171","msg":"trace[662414020] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"411.460622ms","start":"2026-04-01T05:14:48.216427Z","end":"2026-04-01T05:14:48.627887Z","steps":["trace[662414020] 'process raft request' (duration: 411.190276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:14:48.628074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.451839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-01T05:14:48.628119Z","caller":"traceutil/trace.go:171","msg":"trace[1559447951] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2612; }","duration":"384.53625ms","start":"2026-04-01T05:14:48.24357Z","end":"2026-04-01T05:14:48.628106Z","steps":["trace[1559447951] 'agreement among raft nodes before linearized reading' (duration: 384.381077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:14:48.628158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:14:48.243555Z","time spent":"384.593562ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-01T05:14:48.628167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:14:48.216399Z","time spent":"411.640697ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:14:48.628228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.298666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-01T05:14:48.628326Z","caller":"traceutil/trace.go:171","msg":"trace[1911403077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2612; }","duration":"384.415678ms","start":"2026-04-01T05:14:48.243889Z","end":"2026-04-01T05:14:48.628305Z","steps":["trace[1911403077] 'agreement among raft nodes before linearized reading' (duration: 384.195553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:14:48.628379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:14:48.243884Z","time spent":"384.48335ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-01T05:14:48.628391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.666796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-01T05:14:48.628482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.927072ms","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-01T05:14:48.628523Z","caller":"traceutil/trace.go:171","msg":"trace[849188193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2612; }","duration":"382.81212ms","start":"2026-04-01T05:14:48.2457Z","end":"2026-04-01T05:14:48.628513Z","steps":["trace[849188193] 'agreement among raft nodes before linearized reading' (duration: 382.605404ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:14:48.628543Z","caller":"traceutil/trace.go:171","msg":"trace[1285026356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2612; }","duration":"383.013925ms","start":"2026-04-01T05:14:48.24551Z","end":"2026-04-01T05:14:48.628524Z","steps":["trace[1285026356] 'agreement among raft nodes before linearized reading' (duration: 382.82311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:14:48.628554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:14:48.245695Z","time spent":"382.850601ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-01T05:14:48.628599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:14:48.245489Z","time spent":"383.097287ms","remote":"127.0.0.1:33668","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":"info","ts":"2026-04-01T05:15:22.402382Z","caller":"traceutil/trace.go:171","msg":"trace[1928734570] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"219.256034ms","start":"2026-04-01T05:15:22.183104Z","end":"2026-04-01T05:15:22.40236Z","steps":["trace[1928734570] 'process raft request' (duration: 219.05221ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:22.411813Z","caller":"traceutil/trace.go:171","msg":"trace[1917028617] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"184.025594ms","start":"2026-04-01T05:15:22.227762Z","end":"2026-04-01T05:15:22.411788Z","steps":["trace[1917028617] 'process raft request' (duration: 183.84135ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:22.412005Z","caller":"traceutil/trace.go:171","msg":"trace[1218353995] transaction","detail":"{read_only:false; response_revision:2818; number_of_response:1; }","duration":"182.017716ms","start":"2026-04-01T05:15:22.229957Z","end":"2026-04-01T05:15:22.411975Z","steps":["trace[1218353995] 'process raft request' (duration: 181.78582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:22.860976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.500438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-01T05:15:22.861051Z","caller":"traceutil/trace.go:171","msg":"trace[1865935799] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2818; }","duration":"182.626201ms","start":"2026-04-01T05:15:22.678407Z","end":"2026-04-01T05:15:22.861033Z","steps":["trace[1865935799] 'range keys from in-memory index tree' (duration: 181.792781ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:23.157763Z","caller":"traceutil/trace.go:171","msg":"trace[578567574] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"293.148823ms","start":"2026-04-01T05:15:22.864584Z","end":"2026-04-01T05:15:23.157733Z","steps":["trace[578567574] 'process raft request' (duration: 292.990589ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:23.378496Z","caller":"traceutil/trace.go:171","msg":"trace[1982751675] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"513.843801ms","start":"2026-04-01T05:15:22.864627Z","end":"2026-04-01T05:15:23.378471Z","steps":["trace[1982751675] 'process raft request' (duration: 513.562104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:23.378785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:15:22.86461Z","time spent":"513.967314ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:15:23.378916Z","caller":"traceutil/trace.go:171","msg":"trace[71282113] linearizableReadLoop","detail":"{readStateIndex:2936; appliedIndex:2932; }","duration":"512.841908ms","start":"2026-04-01T05:15:22.86605Z","end":"2026-04-01T05:15:23.378892Z","steps":["trace[71282113] 'read index received' (duration: 292.497029ms)","trace[71282113] 'applied index is now lower than readState.Index' (duration: 220.343869ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:15:23.378964Z","caller":"traceutil/trace.go:171","msg":"trace[783153801] transaction","detail":"{read_only:false; response_revision:2822; number_of_response:1; }","duration":"513.828081ms","start":"2026-04-01T05:15:22.865094Z","end":"2026-04-01T05:15:23.378922Z","steps":["trace[783153801] 'process raft request' (duration: 513.653527ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:23.378997Z","caller":"traceutil/trace.go:171","msg":"trace[994482689] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"513.7871ms","start":"2026-04-01T05:15:22.865157Z","end":"2026-04-01T05:15:23.378944Z","steps":["trace[994482689] 'process raft request' (duration: 513.693628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:23.379143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:15:22.865072Z","time spent":"513.964314ms","remote":"127.0.0.1:33668","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-01T05:15:23.379162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.085693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1313"} {"level":"warn","ts":"2026-04-01T05:15:23.379206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:15:22.865148Z","time spent":"513.938923ms","remote":"127.0.0.1:33668","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-01T05:15:23.379022Z","caller":"traceutil/trace.go:171","msg":"trace[1814365334] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"513.949513ms","start":"2026-04-01T05:15:22.865053Z","end":"2026-04-01T05:15:23.379002Z","steps":["trace[1814365334] 'process raft request' (duration: 513.329739ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:23.379242Z","caller":"traceutil/trace.go:171","msg":"trace[1458923300] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2823; }","duration":"513.186115ms","start":"2026-04-01T05:15:22.866025Z","end":"2026-04-01T05:15:23.379211Z","steps":["trace[1458923300] 'agreement among raft nodes before linearized reading' (duration: 512.992941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:23.379323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:15:22.866018Z","time spent":"513.285989ms","remote":"127.0.0.1:33586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1336,"request content":"key:\"/registry/services/specs/auth-system/keycloak\" "} {"level":"warn","ts":"2026-04-01T05:15:23.37938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.041998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-01T05:15:23.379442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:15:22.865029Z","time spent":"514.312592ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:15:23.379508Z","caller":"traceutil/trace.go:171","msg":"trace[236864019] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2823; }","duration":"423.230233ms","start":"2026-04-01T05:15:22.95625Z","end":"2026-04-01T05:15:23.37948Z","steps":["trace[236864019] 'agreement among raft nodes before linearized reading' (duration: 422.938886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:23.379562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:15:22.956223Z","time spent":"423.328956ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-04-01T05:15:29.538007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.856352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-01T05:15:29.538087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.968445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-01T05:15:29.538132Z","caller":"traceutil/trace.go:171","msg":"trace[518114380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2854; }","duration":"135.032946ms","start":"2026-04-01T05:15:29.403069Z","end":"2026-04-01T05:15:29.538102Z","steps":["trace[518114380] 'range keys from in-memory index tree' (duration: 134.652908ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:15:29.538159Z","caller":"traceutil/trace.go:171","msg":"trace[2122779726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2854; }","duration":"135.083908ms","start":"2026-04-01T05:15:29.403057Z","end":"2026-04-01T05:15:29.53814Z","steps":["trace[2122779726] 'range keys from in-memory index tree' (duration: 134.774111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:29.538473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.806502ms","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-01T05:15:29.538514Z","caller":"traceutil/trace.go:171","msg":"trace[1635058739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2854; }","duration":"134.908834ms","start":"2026-04-01T05:15:29.403596Z","end":"2026-04-01T05:15:29.538505Z","steps":["trace[1635058739] 'range keys from in-memory index tree' (duration: 134.643288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:15:29.538522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.040947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-01T05:15:29.538574Z","caller":"traceutil/trace.go:171","msg":"trace[1961219081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2854; }","duration":"135.112309ms","start":"2026-04-01T05:15:29.403448Z","end":"2026-04-01T05:15:29.53856Z","steps":["trace[1961219081] 'range keys from in-memory index tree' (duration: 134.898594ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:17:51.128236Z","caller":"traceutil/trace.go:171","msg":"trace[570394996] transaction","detail":"{read_only:false; response_revision:3801; number_of_response:1; }","duration":"207.46257ms","start":"2026-04-01T05:17:50.920747Z","end":"2026-04-01T05:17:51.12821Z","steps":["trace[570394996] 'process raft request' (duration: 193.953307ms)","trace[570394996] 'compare' (duration: 13.355289ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:17:51.128608Z","caller":"traceutil/trace.go:171","msg":"trace[781667241] transaction","detail":"{read_only:false; response_revision:3802; number_of_response:1; }","duration":"207.021119ms","start":"2026-04-01T05:17:50.921544Z","end":"2026-04-01T05:17:51.128566Z","steps":["trace[781667241] 'process raft request' (duration: 206.62634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:10.435167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.542928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-01T05:19:10.435261Z","caller":"traceutil/trace.go:171","msg":"trace[917392262] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4924; }","duration":"148.687121ms","start":"2026-04-01T05:19:10.286554Z","end":"2026-04-01T05:19:10.435241Z","steps":["trace[917392262] 'range keys from in-memory index tree' (duration: 148.356513ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:10.608042Z","caller":"traceutil/trace.go:171","msg":"trace[1362311331] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"169.176662ms","start":"2026-04-01T05:19:10.438845Z","end":"2026-04-01T05:19:10.608021Z","steps":["trace[1362311331] 'process raft request' (duration: 169.054239ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:10.680168Z","caller":"traceutil/trace.go:171","msg":"trace[1679096142] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"224.934283ms","start":"2026-04-01T05:19:10.455207Z","end":"2026-04-01T05:19:10.680141Z","steps":["trace[1679096142] 'process raft request' (duration: 224.8156ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:10.680189Z","caller":"traceutil/trace.go:171","msg":"trace[206372993] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"239.254904ms","start":"2026-04-01T05:19:10.440905Z","end":"2026-04-01T05:19:10.680159Z","steps":["trace[206372993] 'process raft request' (duration: 238.875565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:22.050837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.617751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-plcwm\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-04-01T05:19:22.050971Z","caller":"traceutil/trace.go:171","msg":"trace[1627033110] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-plcwm; range_end:; response_count:1; response_revision:5163; }","duration":"138.829426ms","start":"2026-04-01T05:19:21.912115Z","end":"2026-04-01T05:19:22.050944Z","steps":["trace[1627033110] 'range keys from in-memory index tree' (duration: 138.329294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:29.937504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.990181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f150e1c-03fb-460f-97de-6b5b521e7244\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-01T05:19:29.937598Z","caller":"traceutil/trace.go:171","msg":"trace[844565490] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f150e1c-03fb-460f-97de-6b5b521e7244; range_end:; response_count:1; response_revision:5324; }","duration":"165.139654ms","start":"2026-04-01T05:19:29.772438Z","end":"2026-04-01T05:19:29.937578Z","steps":["trace[844565490] 'range keys from in-memory index tree' (duration: 164.790916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:29.937582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.197779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mn896\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-01T05:19:29.937669Z","caller":"traceutil/trace.go:171","msg":"trace[11578763] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mn896; range_end:; response_count:1; response_revision:5324; }","duration":"212.338122ms","start":"2026-04-01T05:19:29.725312Z","end":"2026-04-01T05:19:29.93765Z","steps":["trace[11578763] 'range keys from in-memory index tree' (duration: 212.007715ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:30.114119Z","caller":"traceutil/trace.go:171","msg":"trace[521579030] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"121.314208ms","start":"2026-04-01T05:19:29.992779Z","end":"2026-04-01T05:19:30.114093Z","steps":["trace[521579030] 'process raft request' (duration: 121.042742ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:37.009379Z","caller":"traceutil/trace.go:171","msg":"trace[1833716908] transaction","detail":"{read_only:false; response_revision:5448; number_of_response:1; }","duration":"103.613915ms","start":"2026-04-01T05:19:36.905732Z","end":"2026-04-01T05:19:37.009346Z","steps":["trace[1833716908] 'process raft request' (duration: 103.159804ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:37.01064Z","caller":"traceutil/trace.go:171","msg":"trace[907503774] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"103.858771ms","start":"2026-04-01T05:19:36.906754Z","end":"2026-04-01T05:19:37.010613Z","steps":["trace[907503774] 'process raft request' (duration: 103.81028ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:37.010805Z","caller":"traceutil/trace.go:171","msg":"trace[1649986303] transaction","detail":"{read_only:false; response_revision:5450; number_of_response:1; }","duration":"104.190809ms","start":"2026-04-01T05:19:36.906585Z","end":"2026-04-01T05:19:37.010776Z","steps":["trace[1649986303] 'process raft request' (duration: 103.936582ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:37.010804Z","caller":"traceutil/trace.go:171","msg":"trace[317412015] transaction","detail":"{read_only:false; response_revision:5449; number_of_response:1; }","duration":"104.866696ms","start":"2026-04-01T05:19:36.905883Z","end":"2026-04-01T05:19:37.010749Z","steps":["trace[317412015] 'process raft request' (duration: 104.484566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:41.832114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.582375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-01T05:19:41.832212Z","caller":"traceutil/trace.go:171","msg":"trace[422907086] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:5504; }","duration":"116.772529ms","start":"2026-04-01T05:19:41.715414Z","end":"2026-04-01T05:19:41.832187Z","steps":["trace[422907086] 'range keys from in-memory index tree' (duration: 116.316529ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:19:42.616116Z","caller":"traceutil/trace.go:171","msg":"trace[888869572] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"193.78717ms","start":"2026-04-01T05:19:42.422294Z","end":"2026-04-01T05:19:42.616081Z","steps":["trace[888869572] 'process raft request' (duration: 166.830506ms)","trace[888869572] 'compare' (duration: 26.714577ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:19:43.02968Z","caller":"traceutil/trace.go:171","msg":"trace[751628734] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"109.942706ms","start":"2026-04-01T05:19:42.919708Z","end":"2026-04-01T05:19:43.02965Z","steps":["trace[751628734] 'process raft request' (duration: 109.768492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:43.198009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.473984ms","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-01T05:19:43.198177Z","caller":"traceutil/trace.go:171","msg":"trace[227169692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5513; }","duration":"163.680229ms","start":"2026-04-01T05:19:43.034477Z","end":"2026-04-01T05:19:43.198158Z","steps":["trace[227169692] 'range keys from in-memory index tree' (duration: 163.30813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:43.19854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.56799ms","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-01T05:19:43.198573Z","caller":"traceutil/trace.go:171","msg":"trace[1774993879] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"156.877417ms","start":"2026-04-01T05:19:43.041663Z","end":"2026-04-01T05:19:43.19854Z","steps":["trace[1774993879] 'process raft request' (duration: 100.411459ms)","trace[1774993879] 'compare' (duration: 55.775082ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:19:43.198626Z","caller":"traceutil/trace.go:171","msg":"trace[1757445824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5513; }","duration":"164.740364ms","start":"2026-04-01T05:19:43.033866Z","end":"2026-04-01T05:19:43.198606Z","steps":["trace[1757445824] 'range keys from in-memory index tree' (duration: 164.257653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:19:43.198939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.911822ms","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-01T05:19:43.199053Z","caller":"traceutil/trace.go:171","msg":"trace[678586667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5513; }","duration":"166.577699ms","start":"2026-04-01T05:19:43.032462Z","end":"2026-04-01T05:19:43.199039Z","steps":["trace[678586667] 'range keys from in-memory index tree' (duration: 165.594654ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:20:48.830892Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961} {"level":"info","ts":"2026-04-01T05:20:48.897033Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"64.955499ms","hash":348756375,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":34136064,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-01T05:20:48.897113Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":348756375,"revision":2961,"compact-revision":-1} {"level":"warn","ts":"2026-04-01T05:25:32.438071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.296516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mn896\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-01T05:25:32.438423Z","caller":"traceutil/trace.go:171","msg":"trace[1692577485] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mn896; range_end:; response_count:1; response_revision:8157; }","duration":"447.718226ms","start":"2026-04-01T05:25:31.990682Z","end":"2026-04-01T05:25:32.438401Z","steps":["trace[1692577485] 'range keys from in-memory index tree' (duration: 446.65629ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:25:32.438234Z","caller":"traceutil/trace.go:171","msg":"trace[155111418] transaction","detail":"{read_only:false; response_revision:8158; number_of_response:1; }","duration":"116.905654ms","start":"2026-04-01T05:25:32.32128Z","end":"2026-04-01T05:25:32.438186Z","steps":["trace[155111418] 'process raft request' (duration: 115.264695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:25:32.438471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:25:31.990659Z","time spent":"447.800009ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-mn896\" "} {"level":"info","ts":"2026-04-01T05:25:44.791231Z","caller":"traceutil/trace.go:171","msg":"trace[1206229106] transaction","detail":"{read_only:false; response_revision:8223; number_of_response:1; }","duration":"170.050381ms","start":"2026-04-01T05:25:44.621161Z","end":"2026-04-01T05:25:44.791211Z","steps":["trace[1206229106] 'process raft request' (duration: 116.836873ms)","trace[1206229106] 'compare' (duration: 53.076754ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:25:46.710433Z","caller":"traceutil/trace.go:171","msg":"trace[1401968779] linearizableReadLoop","detail":"{readStateIndex:8528; appliedIndex:8527; }","duration":"121.564044ms","start":"2026-04-01T05:25:46.588837Z","end":"2026-04-01T05:25:46.710402Z","steps":["trace[1401968779] 'read index received' (duration: 121.327758ms)","trace[1401968779] 'applied index is now lower than readState.Index' (duration: 234.926µs)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:25:46.710519Z","caller":"traceutil/trace.go:171","msg":"trace[181077335] transaction","detail":"{read_only:false; response_revision:8231; number_of_response:1; }","duration":"128.896608ms","start":"2026-04-01T05:25:46.581585Z","end":"2026-04-01T05:25:46.710481Z","steps":["trace[181077335] 'process raft request' (duration: 128.638782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:25:46.710764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.921062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mn896\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-01T05:25:46.710837Z","caller":"traceutil/trace.go:171","msg":"trace[598440542] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mn896; range_end:; response_count:1; response_revision:8231; }","duration":"122.058125ms","start":"2026-04-01T05:25:46.58875Z","end":"2026-04-01T05:25:46.710808Z","steps":["trace[598440542] 'agreement among raft nodes before linearized reading' (duration: 121.8481ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:25:48.837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6071} {"level":"info","ts":"2026-04-01T05:25:48.930216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6071,"took":"91.025723ms","hash":1743357734,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":23203840,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-01T05:25:48.930295Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1743357734,"revision":6071,"compact-revision":2961} {"level":"info","ts":"2026-04-01T05:26:13.236126Z","caller":"traceutil/trace.go:171","msg":"trace[1780924958] linearizableReadLoop","detail":"{readStateIndex:8734; appliedIndex:8733; }","duration":"366.423645ms","start":"2026-04-01T05:26:12.869684Z","end":"2026-04-01T05:26:13.236108Z","steps":["trace[1780924958] 'read index received' (duration: 366.076276ms)","trace[1780924958] 'applied index is now lower than readState.Index' (duration: 346.619µs)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:26:13.236486Z","caller":"traceutil/trace.go:171","msg":"trace[537262014] transaction","detail":"{read_only:false; response_revision:8428; number_of_response:1; }","duration":"427.950858ms","start":"2026-04-01T05:26:12.808522Z","end":"2026-04-01T05:26:13.236473Z","steps":["trace[537262014] 'process raft request' (duration: 427.278822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.236579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:12.808501Z","time spent":"428.013309ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:26:13.236813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.136211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mn896\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-01T05:26:13.236847Z","caller":"traceutil/trace.go:171","msg":"trace[1566860788] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mn896; range_end:; response_count:1; response_revision:8428; }","duration":"367.167632ms","start":"2026-04-01T05:26:12.869668Z","end":"2026-04-01T05:26:13.236835Z","steps":["trace[1566860788] 'agreement among raft nodes before linearized reading' (duration: 367.057839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.236874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:12.869612Z","time spent":"367.255553ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-mn896\" "} {"level":"info","ts":"2026-04-01T05:26:13.473632Z","caller":"traceutil/trace.go:171","msg":"trace[1444236295] transaction","detail":"{read_only:false; response_revision:8429; number_of_response:1; }","duration":"538.275096ms","start":"2026-04-01T05:26:12.935341Z","end":"2026-04-01T05:26:13.473616Z","steps":["trace[1444236295] 'process raft request' (duration: 538.128483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.473748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:12.935309Z","time spent":"538.379049ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:26:13.47388Z","caller":"traceutil/trace.go:171","msg":"trace[600631039] transaction","detail":"{read_only:false; response_revision:8430; number_of_response:1; }","duration":"534.542979ms","start":"2026-04-01T05:26:12.939331Z","end":"2026-04-01T05:26:13.473874Z","steps":["trace[600631039] 'process raft request' (duration: 534.254323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.473937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:12.939317Z","time spent":"534.58412ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:26:13.47412Z","caller":"traceutil/trace.go:171","msg":"trace[1884266496] linearizableReadLoop","detail":"{readStateIndex:8737; appliedIndex:8734; }","duration":"237.904905ms","start":"2026-04-01T05:26:13.236203Z","end":"2026-04-01T05:26:13.474108Z","steps":["trace[1884266496] 'read index received' (duration: 237.224269ms)","trace[1884266496] 'applied index is now lower than readState.Index' (duration: 679.876µs)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:26:13.474404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.183292ms","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-01T05:26:13.474439Z","caller":"traceutil/trace.go:171","msg":"trace[2081295429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8431; }","duration":"469.220744ms","start":"2026-04-01T05:26:13.00521Z","end":"2026-04-01T05:26:13.47443Z","steps":["trace[2081295429] 'agreement among raft nodes before linearized reading' (duration: 469.099041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.474467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:13.005159Z","time spent":"469.301456ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-01T05:26:13.474519Z","caller":"traceutil/trace.go:171","msg":"trace[1013948779] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"534.58533ms","start":"2026-04-01T05:26:12.939907Z","end":"2026-04-01T05:26:13.474493Z","steps":["trace[1013948779] 'process raft request' (duration: 533.935945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.474617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.761919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-01T05:26:13.474642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:12.939874Z","time spent":"534.698093ms","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-01T05:26:13.474659Z","caller":"traceutil/trace.go:171","msg":"trace[1376902523] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:8431; }","duration":"530.83702ms","start":"2026-04-01T05:26:12.94381Z","end":"2026-04-01T05:26:13.474647Z","steps":["trace[1376902523] 'agreement among raft nodes before linearized reading' (duration: 530.775319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.47469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:12.943796Z","time spent":"530.885442ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-01T05:26:13.474872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.6362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-01T05:26:13.474893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.028755ms","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-01T05:26:13.474915Z","caller":"traceutil/trace.go:171","msg":"trace[1015452617] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:8431; }","duration":"254.679021ms","start":"2026-04-01T05:26:13.220225Z","end":"2026-04-01T05:26:13.474904Z","steps":["trace[1015452617] 'agreement among raft nodes before linearized reading' (duration: 254.551678ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:26:13.474922Z","caller":"traceutil/trace.go:171","msg":"trace[423695207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8431; }","duration":"232.074967ms","start":"2026-04-01T05:26:13.242839Z","end":"2026-04-01T05:26:13.474914Z","steps":["trace[423695207] 'agreement among raft nodes before linearized reading' (duration: 231.989135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.474921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.511192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-01T05:26:13.474434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.864445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-01T05:26:13.474995Z","caller":"traceutil/trace.go:171","msg":"trace[1606511818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8431; }","duration":"239.586154ms","start":"2026-04-01T05:26:13.235388Z","end":"2026-04-01T05:26:13.474975Z","steps":["trace[1606511818] 'agreement among raft nodes before linearized reading' (duration: 239.365129ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:26:13.475012Z","caller":"traceutil/trace.go:171","msg":"trace[482353486] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8431; }","duration":"260.50545ms","start":"2026-04-01T05:26:13.214497Z","end":"2026-04-01T05:26:13.475003Z","steps":["trace[482353486] 'agreement among raft nodes before linearized reading' (duration: 259.744362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.475211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.863969ms","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-01T05:26:13.475272Z","caller":"traceutil/trace.go:171","msg":"trace[1785923958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8431; }","duration":"222.938782ms","start":"2026-04-01T05:26:13.252318Z","end":"2026-04-01T05:26:13.475257Z","steps":["trace[1785923958] 'agreement among raft nodes before linearized reading' (duration: 222.797837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.475382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.851544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228893"} {"level":"info","ts":"2026-04-01T05:26:13.475412Z","caller":"traceutil/trace.go:171","msg":"trace[327286303] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8431; }","duration":"229.911237ms","start":"2026-04-01T05:26:13.245495Z","end":"2026-04-01T05:26:13.475406Z","steps":["trace[327286303] 'agreement among raft nodes before linearized reading' (duration: 229.6586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:13.475535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.666781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-01T05:26:13.475586Z","caller":"traceutil/trace.go:171","msg":"trace[782985224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8431; }","duration":"232.757183ms","start":"2026-04-01T05:26:13.242819Z","end":"2026-04-01T05:26:13.475576Z","steps":["trace[782985224] 'agreement among raft nodes before linearized reading' (duration: 232.63574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:17.47434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.699958ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-01T05:26:17.47495Z","caller":"traceutil/trace.go:171","msg":"trace[1663320637] transaction","detail":"{read_only:false; response_revision:8447; number_of_response:1; }","duration":"222.49625ms","start":"2026-04-01T05:26:17.252404Z","end":"2026-04-01T05:26:17.4749Z","steps":["trace[1663320637] 'process raft request' (duration: 222.121241ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:26:18.463898Z","caller":"traceutil/trace.go:171","msg":"trace[1964963582] transaction","detail":"{read_only:false; response_revision:8456; number_of_response:1; }","duration":"202.758964ms","start":"2026-04-01T05:26:18.261118Z","end":"2026-04-01T05:26:18.463877Z","steps":["trace[1964963582] 'process raft request' (duration: 202.187041ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:26:26.644943Z","caller":"traceutil/trace.go:171","msg":"trace[598628878] transaction","detail":"{read_only:false; response_revision:8543; number_of_response:1; }","duration":"239.228817ms","start":"2026-04-01T05:26:26.405675Z","end":"2026-04-01T05:26:26.644904Z","steps":["trace[598628878] 'process raft request' (duration: 238.873359ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:26:27.016763Z","caller":"traceutil/trace.go:171","msg":"trace[2113762794] linearizableReadLoop","detail":"{readStateIndex:8855; appliedIndex:8853; }","duration":"441.105359ms","start":"2026-04-01T05:26:26.575613Z","end":"2026-04-01T05:26:27.016718Z","steps":["trace[2113762794] 'read index received' (duration: 68.956521ms)","trace[2113762794] 'applied index is now lower than readState.Index' (duration: 372.147128ms)"],"step_count":2} {"level":"info","ts":"2026-04-01T05:26:27.01704Z","caller":"traceutil/trace.go:171","msg":"trace[2110061062] transaction","detail":"{read_only:false; response_revision:8544; number_of_response:1; }","duration":"604.646435ms","start":"2026-04-01T05:26:26.412367Z","end":"2026-04-01T05:26:27.017014Z","steps":["trace[2110061062] 'process raft request' (duration: 593.44414ms)","trace[2110061062] 'compare' (duration: 10.378296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-01T05:26:27.017198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:26.412352Z","time spent":"604.752829ms","remote":"127.0.0.1:33576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4638,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-01T05:26:27.017169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.52208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:26:27.017337Z","caller":"traceutil/trace.go:171","msg":"trace[681362550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8544; }","duration":"441.772985ms","start":"2026-04-01T05:26:26.575545Z","end":"2026-04-01T05:26:27.017318Z","steps":["trace[681362550] 'agreement among raft nodes before linearized reading' (duration: 441.52084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:26:27.017396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-01T05:26:26.575518Z","time spent":"441.862988ms","remote":"127.0.0.1:33398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-01T05:26:27.079222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.822986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-01T05:26:27.07953Z","caller":"traceutil/trace.go:171","msg":"trace[618808115] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:8544; }","duration":"181.183984ms","start":"2026-04-01T05:26:26.898315Z","end":"2026-04-01T05:26:27.079499Z","steps":["trace[618808115] 'agreement among raft nodes before linearized reading' (duration: 180.804016ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:27:14.331453Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000247c.wal"} {"level":"warn","ts":"2026-04-01T05:27:26.019892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.117725ms","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-01T05:27:26.019977Z","caller":"traceutil/trace.go:171","msg":"trace[822243197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9164; }","duration":"102.229288ms","start":"2026-04-01T05:27:25.917732Z","end":"2026-04-01T05:27:26.019962Z","steps":["trace[822243197] 'range keys from in-memory index tree' (duration: 102.005122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:27:26.020218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.275822ms","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-01T05:27:26.020308Z","caller":"traceutil/trace.go:171","msg":"trace[372268219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9164; }","duration":"103.446776ms","start":"2026-04-01T05:27:25.916842Z","end":"2026-04-01T05:27:26.020289Z","steps":["trace[372268219] 'range keys from in-memory index tree' (duration: 103.058407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-01T05:27:26.020313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.165955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-01T05:27:26.020426Z","caller":"traceutil/trace.go:171","msg":"trace[489822865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9164; }","duration":"107.317878ms","start":"2026-04-01T05:27:25.913083Z","end":"2026-04-01T05:27:26.020401Z","steps":["trace[489822865] 'range keys from in-memory index tree' (duration: 106.976611ms)"],"step_count":1} {"level":"info","ts":"2026-04-01T05:28:32.055668Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-01T05:28:32.066928Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-01T05:28:32.067027Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-01T05:30:48.843131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8248} {"level":"info","ts":"2026-04-01T05:30:48.927469Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8248,"took":"81.86021ms","hash":1624987747,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":24895488,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-01T05:30:48.927547Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1624987747,"revision":8248,"compact-revision":6071} {"level":"info","ts":"2026-04-01T05:35:48.850251Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10641} {"level":"info","ts":"2026-04-01T05:35:48.936367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10641,"took":"84.075398ms","hash":3202394383,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":20467712,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-01T05:35:48.936457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3202394383,"revision":10641,"compact-revision":8248}