{"level":"warn","ts":"2026-05-30T01:56:46.830949Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:56:46.831172Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-30T01:56:46.83133Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:56:46.831358Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-30T01:56:46.831395Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-30T01:56:46.832722Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-05-30T01:56:46.832925Z","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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-30T01:56:46.837468Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.05712ms"} {"level":"info","ts":"2026-05-30T01:56:46.843899Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-05-30T01:56:46.84399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T01:56:46.844024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-05-30T01:56:46.844055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T01:56:46.844075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-05-30T01:56:46.844145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-05-30T01:56:46.85011Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T01:56:46.855438Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T01:56:46.8587Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-30T01:56:46.861071Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T01:56:46.861333Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T01:56:46.861413Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-30T01:56:46.861549Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-30T01:56:46.86157Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-30T01:56:46.862227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-05-30T01:56:46.862337Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-30T01:56:46.864011Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-30T01:56:46.86412Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-30T01:56:46.864155Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-30T01:56:46.864343Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T01:56:46.8644Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T01:56:47.845258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T01:56:47.845342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T01:56:47.845396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-05-30T01:56:47.845419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-05-30T01:56:47.845713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-30T01:56:47.845733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-05-30T01:56:47.845798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-30T01:56:47.847209Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:56:47.848218Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:56:47.848209Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T01:56:47.848295Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:56:47.848732Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:56:47.849033Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:56:47.849085Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:56:47.852046Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-05-30T01:56:47.852108Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T01:56:47.852206Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T01:56:47.852459Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-30T01:57:01.805936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.600798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-30T01:57:01.806109Z","caller":"traceutil/trace.go:171","msg":"trace[140415202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:362; }","duration":"189.846683ms","start":"2026-05-30T01:57:01.616236Z","end":"2026-05-30T01:57:01.806083Z","steps":["trace[140415202] 'range keys from in-memory index tree' (duration: 189.425405ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:57:02.133695Z","caller":"traceutil/trace.go:171","msg":"trace[477282569] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"321.795476ms","start":"2026-05-30T01:57:01.811869Z","end":"2026-05-30T01:57:02.133664Z","steps":["trace[477282569] 'process raft request' (duration: 312.323431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:57:02.134527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:57:01.811845Z","time spent":"321.936538ms","remote":"127.0.0.1:36394","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-05-30T01:57:35.370849Z","caller":"traceutil/trace.go:171","msg":"trace[2066008960] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"135.837365ms","start":"2026-05-30T01:57:35.234975Z","end":"2026-05-30T01:57:35.370813Z","steps":["trace[2066008960] 'process raft request' (duration: 135.651932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:57:35.890268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.702969ms","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-05-30T01:57:35.890375Z","caller":"traceutil/trace.go:171","msg":"trace[1096726204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"145.869202ms","start":"2026-05-30T01:57:35.744476Z","end":"2026-05-30T01:57:35.890346Z","steps":["trace[1096726204] 'range keys from in-memory index tree' (duration: 145.464914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:57:35.890707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.413862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mj6kq\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-30T01:57:35.893038Z","caller":"traceutil/trace.go:171","msg":"trace[1746425372] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mj6kq; range_end:; response_count:1; response_revision:599; }","duration":"282.779559ms","start":"2026-05-30T01:57:35.608141Z","end":"2026-05-30T01:57:35.890921Z","steps":["trace[1746425372] 'range keys from in-memory index tree' (duration: 281.966473ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:57:35.897556Z","caller":"traceutil/trace.go:171","msg":"trace[333519472] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"129.198295ms","start":"2026-05-30T01:57:35.767287Z","end":"2026-05-30T01:57:35.896485Z","steps":["trace[333519472] 'process raft request' (duration: 122.359081ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:58:24.123397Z","caller":"traceutil/trace.go:171","msg":"trace[182925252] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"104.846257ms","start":"2026-05-30T01:58:24.018526Z","end":"2026-05-30T01:58:24.123372Z","steps":["trace[182925252] 'process raft request' (duration: 104.688124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:59:10.500591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.431263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:59:10.500731Z","caller":"traceutil/trace.go:171","msg":"trace[744315742] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1848; }","duration":"226.684078ms","start":"2026-05-30T01:59:10.274017Z","end":"2026-05-30T01:59:10.500702Z","steps":["trace[744315742] 'count revisions from in-memory index tree' (duration: 226.130196ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:59:54.985001Z","caller":"traceutil/trace.go:171","msg":"trace[1886569922] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"195.795083ms","start":"2026-05-30T01:59:54.789154Z","end":"2026-05-30T01:59:54.984949Z","steps":["trace[1886569922] 'process raft request' (duration: 139.10504ms)","trace[1886569922] 'compare' (duration: 56.084871ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:00:01.219067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.125708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:00:01.21932Z","caller":"traceutil/trace.go:171","msg":"trace[488341654] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2182; }","duration":"267.444494ms","start":"2026-05-30T02:00:00.951854Z","end":"2026-05-30T02:00:01.219298Z","steps":["trace[488341654] 'range keys from in-memory index tree' (duration: 267.005435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:00:01.219164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.197688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-30T02:00:01.219555Z","caller":"traceutil/trace.go:171","msg":"trace[324553606] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:2182; }","duration":"292.652788ms","start":"2026-05-30T02:00:00.926876Z","end":"2026-05-30T02:00:01.219529Z","steps":["trace[324553606] 'range keys from in-memory index tree' (duration: 291.985805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:00:01.219722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.056857ms","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-05-30T02:00:01.219879Z","caller":"traceutil/trace.go:171","msg":"trace[684719108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2182; }","duration":"208.491835ms","start":"2026-05-30T02:00:01.011315Z","end":"2026-05-30T02:00:01.219807Z","steps":["trace[684719108] 'range keys from in-memory index tree' (duration: 207.402774ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:00:01.313445Z","caller":"traceutil/trace.go:171","msg":"trace[1024462663] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"168.794012ms","start":"2026-05-30T02:00:01.144604Z","end":"2026-05-30T02:00:01.313398Z","steps":["trace[1024462663] 'process raft request' (duration: 167.966716ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:01:31.83764Z","caller":"traceutil/trace.go:171","msg":"trace[1912223967] transaction","detail":"{read_only:false; response_revision:2864; number_of_response:1; }","duration":"148.653429ms","start":"2026-05-30T02:01:31.688956Z","end":"2026-05-30T02:01:31.83761Z","steps":["trace[1912223967] 'process raft request' (duration: 148.238891ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:01:31.838414Z","caller":"traceutil/trace.go:171","msg":"trace[62968249] transaction","detail":"{read_only:false; response_revision:2865; number_of_response:1; }","duration":"122.35392ms","start":"2026-05-30T02:01:31.715699Z","end":"2026-05-30T02:01:31.838053Z","steps":["trace[62968249] 'process raft request' (duration: 122.125295ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:30.588233Z","caller":"traceutil/trace.go:171","msg":"trace[250547238] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"279.035655ms","start":"2026-05-30T02:05:30.309166Z","end":"2026-05-30T02:05:30.588202Z","steps":["trace[250547238] 'process raft request' (duration: 278.77889ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:30.634841Z","caller":"traceutil/trace.go:171","msg":"trace[2121338430] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"289.351047ms","start":"2026-05-30T02:05:30.345448Z","end":"2026-05-30T02:05:30.634799Z","steps":["trace[2121338430] 'process raft request' (duration: 289.081042ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:30.795136Z","caller":"traceutil/trace.go:171","msg":"trace[532236586] linearizableReadLoop","detail":"{readStateIndex:5018; appliedIndex:5017; }","duration":"136.260587ms","start":"2026-05-30T02:05:30.658847Z","end":"2026-05-30T02:05:30.795107Z","steps":["trace[532236586] 'read index received' (duration: 136.099274ms)","trace[532236586] 'applied index is now lower than readState.Index' (duration: 159.773µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:05:30.795224Z","caller":"traceutil/trace.go:171","msg":"trace[1644860525] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"136.741946ms","start":"2026-05-30T02:05:30.658454Z","end":"2026-05-30T02:05:30.795196Z","steps":["trace[1644860525] 'process raft request' (duration: 136.44075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:30.795854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.97241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T02:05:30.795984Z","caller":"traceutil/trace.go:171","msg":"trace[1950600688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4835; }","duration":"137.142823ms","start":"2026-05-30T02:05:30.658816Z","end":"2026-05-30T02:05:30.795959Z","steps":["trace[1950600688] 'agreement among raft nodes before linearized reading' (duration: 136.406219ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:30.986873Z","caller":"traceutil/trace.go:171","msg":"trace[125028721] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"223.11531ms","start":"2026-05-30T02:05:30.763723Z","end":"2026-05-30T02:05:30.986838Z","steps":["trace[125028721] 'process raft request' (duration: 222.851035ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:30.987144Z","caller":"traceutil/trace.go:171","msg":"trace[353601535] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"221.605422ms","start":"2026-05-30T02:05:30.765516Z","end":"2026-05-30T02:05:30.987122Z","steps":["trace[353601535] 'process raft request' (duration: 221.4987ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:30.987213Z","caller":"traceutil/trace.go:171","msg":"trace[1303919753] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"223.283803ms","start":"2026-05-30T02:05:30.763858Z","end":"2026-05-30T02:05:30.987142Z","steps":["trace[1303919753] 'process raft request' (duration: 222.924916ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:31.010629Z","caller":"traceutil/trace.go:171","msg":"trace[430301306] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"211.131945ms","start":"2026-05-30T02:05:30.799476Z","end":"2026-05-30T02:05:31.010608Z","steps":["trace[430301306] 'process raft request' (duration: 210.933192ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:31.010592Z","caller":"traceutil/trace.go:171","msg":"trace[1354107052] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"202.24185ms","start":"2026-05-30T02:05:30.808317Z","end":"2026-05-30T02:05:31.010559Z","steps":["trace[1354107052] 'process raft request' (duration: 202.158709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:40.313526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.489885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T02:05:40.313685Z","caller":"traceutil/trace.go:171","msg":"trace[525066551] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"377.70994ms","start":"2026-05-30T02:05:39.935951Z","end":"2026-05-30T02:05:40.313661Z","steps":["trace[525066551] 'process raft request' (duration: 151.829718ms)","trace[525066551] 'compare' (duration: 225.341532ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:05:40.313756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.935924Z","time spent":"377.799842ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:05:40.34623Z","caller":"traceutil/trace.go:171","msg":"trace[281392447] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"409.922712ms","start":"2026-05-30T02:05:39.936278Z","end":"2026-05-30T02:05:40.3462Z","steps":["trace[281392447] 'process raft request' (duration: 409.646816ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:40.346313Z","caller":"traceutil/trace.go:171","msg":"trace[1108668781] linearizableReadLoop","detail":"{readStateIndex:5298; appliedIndex:5295; }","duration":"407.513208ms","start":"2026-05-30T02:05:39.938765Z","end":"2026-05-30T02:05:40.346278Z","steps":["trace[1108668781] 'read index received' (duration: 149.041176ms)","trace[1108668781] 'applied index is now lower than readState.Index' (duration: 258.470012ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:05:40.34635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.936259Z","time spent":"410.036494ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4934,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:05:40.346405Z","caller":"traceutil/trace.go:171","msg":"trace[206346107] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"409.840111ms","start":"2026-05-30T02:05:39.936527Z","end":"2026-05-30T02:05:40.346367Z","steps":["trace[206346107] 'process raft request' (duration: 409.567036ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:40.346467Z","caller":"traceutil/trace.go:171","msg":"trace[1470356398] transaction","detail":"{read_only:false; response_revision:5105; number_of_response:1; }","duration":"406.219293ms","start":"2026-05-30T02:05:39.940207Z","end":"2026-05-30T02:05:40.346426Z","steps":["trace[1470356398] 'process raft request' (duration: 405.970628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:40.346561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.990919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:05:40.346617Z","caller":"traceutil/trace.go:171","msg":"trace[844635695] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5105; }","duration":"376.08065ms","start":"2026-05-30T02:05:39.970521Z","end":"2026-05-30T02:05:40.346602Z","steps":["trace[844635695] 'agreement among raft nodes before linearized reading' (duration: 375.970358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:40.346622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.829014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d84a15a4-a3af-48e8-9b93-5adcdbe77bea\" ","response":"range_response_count:1 size:3600"} {"level":"warn","ts":"2026-05-30T02:05:40.346657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.936509Z","time spent":"410.064785ms","remote":"127.0.0.1:36172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T02:05:40.346704Z","caller":"traceutil/trace.go:171","msg":"trace[2027415153] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d84a15a4-a3af-48e8-9b93-5adcdbe77bea; range_end:; response_count:1; response_revision:5105; }","duration":"407.958715ms","start":"2026-05-30T02:05:39.938729Z","end":"2026-05-30T02:05:40.346688Z","steps":["trace[2027415153] 'agreement among raft nodes before linearized reading' (duration: 407.721091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:40.34671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.940194Z","time spent":"406.376865ms","remote":"127.0.0.1:36610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T02:05:40.346652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.970506Z","time spent":"376.137191ms","remote":"127.0.0.1:41442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:05:40.346757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.938712Z","time spent":"408.033857ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3623,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d84a15a4-a3af-48e8-9b93-5adcdbe77bea\" "} {"level":"warn","ts":"2026-05-30T02:05:40.347596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.528585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787065"} {"level":"info","ts":"2026-05-30T02:05:40.347702Z","caller":"traceutil/trace.go:171","msg":"trace[238279085] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5105; }","duration":"371.717479ms","start":"2026-05-30T02:05:39.975963Z","end":"2026-05-30T02:05:40.34768Z","steps":["trace[238279085] 'agreement among raft nodes before linearized reading' (duration: 370.739161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:40.347745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:39.975937Z","time spent":"371.79957ms","remote":"127.0.0.1:36186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":787088,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-05-30T02:05:40.624814Z","caller":"traceutil/trace.go:171","msg":"trace[881871363] linearizableReadLoop","detail":"{readStateIndex:5300; appliedIndex:5299; }","duration":"270.297972ms","start":"2026-05-30T02:05:40.354492Z","end":"2026-05-30T02:05:40.62479Z","steps":["trace[881871363] 'read index received' (duration: 270.093228ms)","trace[881871363] 'applied index is now lower than readState.Index' (duration: 203.284µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:05:40.624863Z","caller":"traceutil/trace.go:171","msg":"trace[1414299973] transaction","detail":"{read_only:false; response_revision:5106; number_of_response:1; }","duration":"272.446663ms","start":"2026-05-30T02:05:40.352374Z","end":"2026-05-30T02:05:40.62482Z","steps":["trace[1414299973] 'process raft request' (duration: 272.247069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:40.625145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.636068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-flvtc\" ","response":"range_response_count:1 size:4949"} {"level":"info","ts":"2026-05-30T02:05:40.625237Z","caller":"traceutil/trace.go:171","msg":"trace[1520372477] range","detail":"{range_begin:/registry/pods/monitoring/vector-flvtc; range_end:; response_count:1; response_revision:5106; }","duration":"270.786761ms","start":"2026-05-30T02:05:40.354427Z","end":"2026-05-30T02:05:40.625214Z","steps":["trace[1520372477] 'agreement among raft nodes before linearized reading' (duration: 270.476725ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:41.001111Z","caller":"traceutil/trace.go:171","msg":"trace[586611380] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"102.517266ms","start":"2026-05-30T02:05:40.898562Z","end":"2026-05-30T02:05:41.00108Z","steps":["trace[586611380] 'process raft request' (duration: 102.346143ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:41.020536Z","caller":"traceutil/trace.go:171","msg":"trace[431338349] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"117.17587ms","start":"2026-05-30T02:05:40.903342Z","end":"2026-05-30T02:05:41.020518Z","steps":["trace[431338349] 'process raft request' (duration: 116.842004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:42.717323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.407674ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T02:05:42.717623Z","caller":"traceutil/trace.go:171","msg":"trace[1730001008] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"262.225432ms","start":"2026-05-30T02:05:42.455354Z","end":"2026-05-30T02:05:42.717579Z","steps":["trace[1730001008] 'process raft request' (duration: 121.455821ms)","trace[1730001008] 'compare' (duration: 140.15975ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:05:42.71769Z","caller":"traceutil/trace.go:171","msg":"trace[881423568] linearizableReadLoop","detail":"{readStateIndex:5336; appliedIndex:5333; }","duration":"239.113528ms","start":"2026-05-30T02:05:42.478556Z","end":"2026-05-30T02:05:42.717669Z","steps":["trace[881423568] 'read index received' (duration: 98.409749ms)","trace[881423568] 'applied index is now lower than readState.Index' (duration: 140.702019ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:05:42.717834Z","caller":"traceutil/trace.go:171","msg":"trace[853468096] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"261.188852ms","start":"2026-05-30T02:05:42.456629Z","end":"2026-05-30T02:05:42.717818Z","steps":["trace[853468096] 'process raft request' (duration: 260.994889ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:42.717851Z","caller":"traceutil/trace.go:171","msg":"trace[856044732] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"261.875954ms","start":"2026-05-30T02:05:42.455946Z","end":"2026-05-30T02:05:42.717822Z","steps":["trace[856044732] 'process raft request' (duration: 261.528918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:42.718338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.745991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d84a15a4-a3af-48e8-9b93-5adcdbe77bea\" ","response":"range_response_count:1 size:3903"} {"level":"info","ts":"2026-05-30T02:05:42.718441Z","caller":"traceutil/trace.go:171","msg":"trace[2004959843] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d84a15a4-a3af-48e8-9b93-5adcdbe77bea; range_end:; response_count:1; response_revision:5140; }","duration":"239.906673ms","start":"2026-05-30T02:05:42.478511Z","end":"2026-05-30T02:05:42.718418Z","steps":["trace[2004959843] 'agreement among raft nodes before linearized reading' (duration: 239.530346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:42.719153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.656495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:05:42.719255Z","caller":"traceutil/trace.go:171","msg":"trace[1777777389] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:5140; }","duration":"174.572503ms","start":"2026-05-30T02:05:42.544657Z","end":"2026-05-30T02:05:42.71923Z","steps":["trace[1777777389] 'agreement among raft nodes before linearized reading' (duration: 173.288128ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:05:55.02057Z","caller":"traceutil/trace.go:171","msg":"trace[36313688] linearizableReadLoop","detail":"{readStateIndex:5578; appliedIndex:5577; }","duration":"462.973833ms","start":"2026-05-30T02:05:54.557557Z","end":"2026-05-30T02:05:55.020531Z","steps":["trace[36313688] 'read index received' (duration: 462.702388ms)","trace[36313688] 'applied index is now lower than readState.Index' (duration: 269.785µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:05:55.020727Z","caller":"traceutil/trace.go:171","msg":"trace[467337784] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"465.338338ms","start":"2026-05-30T02:05:54.555306Z","end":"2026-05-30T02:05:55.020645Z","steps":["trace[467337784] 'process raft request' (duration: 464.931551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:55.020826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.225458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:05:55.020924Z","caller":"traceutil/trace.go:171","msg":"trace[485841103] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5376; }","duration":"463.370931ms","start":"2026-05-30T02:05:54.55753Z","end":"2026-05-30T02:05:55.020901Z","steps":["trace[485841103] 'agreement among raft nodes before linearized reading' (duration: 463.158257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:55.020969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:54.557518Z","time spent":"463.442552ms","remote":"127.0.0.1:36598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-05-30T02:05:55.021033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:54.555258Z","time spent":"465.617022ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:05:55.056707Z","caller":"traceutil/trace.go:171","msg":"trace[1650797584] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"427.662464ms","start":"2026-05-30T02:05:54.629015Z","end":"2026-05-30T02:05:55.056677Z","steps":["trace[1650797584] 'process raft request' (duration: 427.47049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:05:55.056903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:05:54.628988Z","time spent":"427.816597ms","remote":"127.0.0.1:36274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:06:47.877401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2951} {"level":"info","ts":"2026-05-30T02:06:47.953039Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2951,"took":"73.228148ms","hash":3795327700,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":33419264,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-05-30T02:06:47.953154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3795327700,"revision":2951,"compact-revision":-1} {"level":"info","ts":"2026-05-30T02:11:47.883777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5993} {"level":"info","ts":"2026-05-30T02:11:47.995627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5993,"took":"109.215641ms","hash":427576072,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":21647360,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-05-30T02:11:47.995735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":427576072,"revision":5993,"compact-revision":2951} {"level":"info","ts":"2026-05-30T02:12:23.407344Z","caller":"traceutil/trace.go:171","msg":"trace[2078577916] linearizableReadLoop","detail":"{readStateIndex:8736; appliedIndex:8735; }","duration":"168.869248ms","start":"2026-05-30T02:12:23.238448Z","end":"2026-05-30T02:12:23.407317Z","steps":["trace[2078577916] 'read index received' (duration: 168.697205ms)","trace[2078577916] 'applied index is now lower than readState.Index' (duration: 170.693µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:12:23.407443Z","caller":"traceutil/trace.go:171","msg":"trace[2146648895] transaction","detail":"{read_only:false; response_revision:8437; number_of_response:1; }","duration":"170.467552ms","start":"2026-05-30T02:12:23.236938Z","end":"2026-05-30T02:12:23.407405Z","steps":["trace[2146648895] 'process raft request' (duration: 170.181486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:12:23.407742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.266287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-30T02:12:23.407787Z","caller":"traceutil/trace.go:171","msg":"trace[2057164498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8437; }","duration":"169.366549ms","start":"2026-05-30T02:12:23.238409Z","end":"2026-05-30T02:12:23.407776Z","steps":["trace[2057164498] 'agreement among raft nodes before linearized reading' (duration: 169.025432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:12:35.166472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.184954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T02:12:35.166804Z","caller":"traceutil/trace.go:171","msg":"trace[1597885486] linearizableReadLoop","detail":"{readStateIndex:8799; appliedIndex:8797; }","duration":"342.547926ms","start":"2026-05-30T02:12:34.824234Z","end":"2026-05-30T02:12:35.166782Z","steps":["trace[1597885486] 'read index received' (duration: 70.027373ms)","trace[1597885486] 'applied index is now lower than readState.Index' (duration: 272.519033ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:12:35.167002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.761671ms","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-05-30T02:12:35.166971Z","caller":"traceutil/trace.go:171","msg":"trace[1738128327] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"393.605542ms","start":"2026-05-30T02:12:34.77329Z","end":"2026-05-30T02:12:35.166896Z","steps":["trace[1738128327] 'process raft request' (duration: 393.364786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:12:35.167145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.061903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:12:35.167181Z","caller":"traceutil/trace.go:171","msg":"trace[1180882666] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:8498; }","duration":"128.099254ms","start":"2026-05-30T02:12:35.039073Z","end":"2026-05-30T02:12:35.167172Z","steps":["trace[1180882666] 'agreement among raft nodes before linearized reading' (duration: 128.003402ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:12:35.167047Z","caller":"traceutil/trace.go:171","msg":"trace[1944752122] 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:8498; }","duration":"342.860063ms","start":"2026-05-30T02:12:34.824173Z","end":"2026-05-30T02:12:35.167033Z","steps":["trace[1944752122] 'agreement among raft nodes before linearized reading' (duration: 342.774131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:12:35.167262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:12:34.773254Z","time spent":"393.862618ms","remote":"127.0.0.1:36394","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-05-30T02:12:35.167313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:12:34.824158Z","time spent":"343.127498ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-30T02:12:35.167032Z","caller":"traceutil/trace.go:171","msg":"trace[650393046] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"399.248377ms","start":"2026-05-30T02:12:34.767755Z","end":"2026-05-30T02:12:35.167003Z","steps":["trace[650393046] 'process raft request' (duration: 126.372598ms)","trace[650393046] 'compare' (duration: 271.721475ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:12:35.167624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:12:34.767721Z","time spent":"399.85091ms","remote":"127.0.0.1:36394","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-05-30T02:12:36.931758Z","caller":"traceutil/trace.go:171","msg":"trace[720288257] transaction","detail":"{read_only:false; response_revision:8506; number_of_response:1; }","duration":"170.91331ms","start":"2026-05-30T02:12:36.760814Z","end":"2026-05-30T02:12:36.931728Z","steps":["trace[720288257] 'process raft request' (duration: 170.810168ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:12:36.931804Z","caller":"traceutil/trace.go:171","msg":"trace[828799567] transaction","detail":"{read_only:false; response_revision:8505; number_of_response:1; }","duration":"173.219918ms","start":"2026-05-30T02:12:36.758532Z","end":"2026-05-30T02:12:36.931752Z","steps":["trace[828799567] 'process raft request' (duration: 114.018205ms)","trace[828799567] 'compare' (duration: 58.943747ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:13:03.524485Z","caller":"traceutil/trace.go:171","msg":"trace[1601481869] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"257.098925ms","start":"2026-05-30T02:13:03.267356Z","end":"2026-05-30T02:13:03.524455Z","steps":["trace[1601481869] 'process raft request' (duration: 256.921331ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:13:03.754113Z","caller":"traceutil/trace.go:171","msg":"trace[625336484] linearizableReadLoop","detail":"{readStateIndex:9015; appliedIndex:9013; }","duration":"249.857597ms","start":"2026-05-30T02:13:03.504229Z","end":"2026-05-30T02:13:03.754086Z","steps":["trace[625336484] 'read index received' (duration: 20.090211ms)","trace[625336484] 'applied index is now lower than readState.Index' (duration: 229.765826ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:13:03.754437Z","caller":"traceutil/trace.go:171","msg":"trace[792235329] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"481.493751ms","start":"2026-05-30T02:13:03.272926Z","end":"2026-05-30T02:13:03.754419Z","steps":["trace[792235329] 'process raft request' (duration: 481.000121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:03.754583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:03.272898Z","time spent":"481.584642ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T02:13:03.754867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.639943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:13:03.754917Z","caller":"traceutil/trace.go:171","msg":"trace[313577842] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8706; }","duration":"250.733915ms","start":"2026-05-30T02:13:03.504169Z","end":"2026-05-30T02:13:03.754902Z","steps":["trace[313577842] 'agreement among raft nodes before linearized reading' (duration: 250.657114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:03.755109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.850137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:13:03.755151Z","caller":"traceutil/trace.go:171","msg":"trace[1109527784] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8706; }","duration":"167.939429ms","start":"2026-05-30T02:13:03.587202Z","end":"2026-05-30T02:13:03.755141Z","steps":["trace[1109527784] 'agreement among raft nodes before linearized reading' (duration: 167.870708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:03.755748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.451098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T02:13:03.755789Z","caller":"traceutil/trace.go:171","msg":"trace[481328047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8706; }","duration":"122.53972ms","start":"2026-05-30T02:13:03.63324Z","end":"2026-05-30T02:13:03.75578Z","steps":["trace[481328047] 'agreement among raft nodes before linearized reading' (duration: 122.450258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:03.755965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.970039ms","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-05-30T02:13:03.756002Z","caller":"traceutil/trace.go:171","msg":"trace[1734483211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8706; }","duration":"123.04863ms","start":"2026-05-30T02:13:03.632945Z","end":"2026-05-30T02:13:03.755993Z","steps":["trace[1734483211] 'agreement among raft nodes before linearized reading' (duration: 122.964889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:16.801411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.735069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T02:13:16.801553Z","caller":"traceutil/trace.go:171","msg":"trace[1777318251] transaction","detail":"{read_only:false; response_revision:8816; number_of_response:1; }","duration":"178.026807ms","start":"2026-05-30T02:13:16.623505Z","end":"2026-05-30T02:13:16.801532Z","steps":["trace[1777318251] 'process raft request' (duration: 43.073453ms)","trace[1777318251] 'compare' (duration: 134.621937ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:13:17.784939Z","caller":"traceutil/trace.go:171","msg":"trace[1278342327] transaction","detail":"{read_only:false; response_revision:8821; number_of_response:1; }","duration":"194.335781ms","start":"2026-05-30T02:13:17.590574Z","end":"2026-05-30T02:13:17.78491Z","steps":["trace[1278342327] 'process raft request' (duration: 194.122536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:32.826015Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688583789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:13:33.265669Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.023200296s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T02:13:33.271787Z","caller":"traceutil/trace.go:171","msg":"trace[140043668] transaction","detail":"{read_only:false; response_revision:8943; number_of_response:1; }","duration":"1.029412893s","start":"2026-05-30T02:13:32.242347Z","end":"2026-05-30T02:13:33.271759Z","steps":["trace[140043668] 'process raft request' (duration: 1.023610714s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.271961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.242332Z","time spent":"1.029531265s","remote":"127.0.0.1:36366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3146,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:13:33.27456Z","caller":"traceutil/trace.go:171","msg":"trace[1510683649] transaction","detail":"{read_only:false; response_revision:8944; number_of_response:1; }","duration":"566.189355ms","start":"2026-05-30T02:13:32.708343Z","end":"2026-05-30T02:13:33.274532Z","steps":["trace[1510683649] 'process raft request' (duration: 565.970531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.274728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.708309Z","time spent":"566.318078ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:13:33.274842Z","caller":"traceutil/trace.go:171","msg":"trace[1741410310] transaction","detail":"{read_only:false; response_revision:8945; number_of_response:1; }","duration":"117.085038ms","start":"2026-05-30T02:13:33.157677Z","end":"2026-05-30T02:13:33.274762Z","steps":["trace[1741410310] 'process raft request' (duration: 116.812772ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:13:33.274967Z","caller":"traceutil/trace.go:171","msg":"trace[25231481] transaction","detail":"{read_only:false; response_revision:8946; number_of_response:1; }","duration":"114.704439ms","start":"2026-05-30T02:13:33.160236Z","end":"2026-05-30T02:13:33.27494Z","steps":["trace[25231481] 'process raft request' (duration: 114.489915ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:13:33.27494Z","caller":"traceutil/trace.go:171","msg":"trace[441036639] linearizableReadLoop","detail":"{readStateIndex:9263; appliedIndex:9261; }","duration":"949.260952ms","start":"2026-05-30T02:13:32.325639Z","end":"2026-05-30T02:13:33.2749Z","steps":["trace[441036639] 'read index received' (duration: 940.335739ms)","trace[441036639] 'applied index is now lower than readState.Index' (duration: 8.923333ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:13:33.275323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.170938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:13:33.275437Z","caller":"traceutil/trace.go:171","msg":"trace[1019136041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8946; }","duration":"322.28894ms","start":"2026-05-30T02:13:32.953128Z","end":"2026-05-30T02:13:33.275417Z","steps":["trace[1019136041] 'agreement among raft nodes before linearized reading' (duration: 322.123607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.275447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.203626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-w5rlz\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-05-30T02:13:33.275538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.312884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-30T02:13:33.275514Z","caller":"traceutil/trace.go:171","msg":"trace[1498247656] range","detail":"{range_begin:/registry/pods/openstack/keepalived-w5rlz; range_end:; response_count:1; response_revision:8946; }","duration":"754.33936ms","start":"2026-05-30T02:13:32.521162Z","end":"2026-05-30T02:13:33.275501Z","steps":["trace[1498247656] 'agreement among raft nodes before linearized reading' (duration: 754.087944ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:13:33.27558Z","caller":"traceutil/trace.go:171","msg":"trace[88754935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8946; }","duration":"160.411766ms","start":"2026-05-30T02:13:33.115158Z","end":"2026-05-30T02:13:33.27557Z","steps":["trace[88754935] 'agreement among raft nodes before linearized reading' (duration: 160.254062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.275554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.95305Z","time spent":"322.490366ms","remote":"127.0.0.1:36098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T02:13:33.275598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.521137Z","time spent":"754.451592ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-w5rlz\" "} {"level":"warn","ts":"2026-05-30T02:13:33.275082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.430204ms","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-05-30T02:13:33.27589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.912091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-579fff9d47-b8zck.18b436017ef00c40\" ","response":"range_response_count:1 size:1134"} {"level":"info","ts":"2026-05-30T02:13:33.275933Z","caller":"traceutil/trace.go:171","msg":"trace[1577840378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8946; }","duration":"950.365494ms","start":"2026-05-30T02:13:32.325552Z","end":"2026-05-30T02:13:33.275917Z","steps":["trace[1577840378] 'agreement among raft nodes before linearized reading' (duration: 949.458365ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:13:33.275977Z","caller":"traceutil/trace.go:171","msg":"trace[1374554477] range","detail":"{range_begin:/registry/events/openstack/barbican-api-579fff9d47-b8zck.18b436017ef00c40; range_end:; response_count:1; response_revision:8946; }","duration":"504.073974ms","start":"2026-05-30T02:13:32.771883Z","end":"2026-05-30T02:13:33.275957Z","steps":["trace[1374554477] 'agreement among raft nodes before linearized reading' (duration: 503.780658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.275983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.325512Z","time spent":"950.455446ms","remote":"127.0.0.1:37368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:13:33.275968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.832335ms","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":"info","ts":"2026-05-30T02:13:33.276085Z","caller":"traceutil/trace.go:171","msg":"trace[1138977629] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:8946; }","duration":"704.003409ms","start":"2026-05-30T02:13:32.57206Z","end":"2026-05-30T02:13:33.276064Z","steps":["trace[1138977629] 'agreement among raft nodes before linearized reading' (duration: 703.814915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.276142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.57204Z","time spent":"704.09155ms","remote":"127.0.0.1:37468","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":"warn","ts":"2026-05-30T02:13:33.27602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.771848Z","time spent":"504.164905ms","remote":"127.0.0.1:36172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1157,"request content":"key:\"/registry/events/openstack/barbican-api-579fff9d47-b8zck.18b436017ef00c40\" "} {"level":"warn","ts":"2026-05-30T02:13:33.275716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.047849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ceph-object-controller-detect-version-lvr58\" ","response":"range_response_count:1 size:4838"} {"level":"info","ts":"2026-05-30T02:13:33.276298Z","caller":"traceutil/trace.go:171","msg":"trace[2139265342] range","detail":"{range_begin:/registry/pods/openstack/ceph-object-controller-detect-version-lvr58; range_end:; response_count:1; response_revision:8946; }","duration":"495.639281ms","start":"2026-05-30T02:13:32.780648Z","end":"2026-05-30T02:13:33.276288Z","steps":["trace[2139265342] 'agreement among raft nodes before linearized reading' (duration: 494.987417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:33.276372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:32.780641Z","time spent":"495.681921ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":4861,"request content":"key:\"/registry/pods/openstack/ceph-object-controller-detect-version-lvr58\" "} {"level":"info","ts":"2026-05-30T02:13:34.722342Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002451.wal"} {"level":"warn","ts":"2026-05-30T02:13:38.145842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:13:38.646611Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:13:39.147274Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:13:39.647897Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:13:39.952563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00047628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-30T02:13:39.952674Z","caller":"traceutil/trace.go:171","msg":"trace[2068585901] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000650314s","start":"2026-05-30T02:13:37.951999Z","end":"2026-05-30T02:13:39.95265Z","steps":["trace[2068585901] 'agreement among raft nodes before linearized reading' (duration: 2.000517691s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:39.952728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.951974Z","time spent":"2.000743856s","remote":"127.0.0.1:36096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/30 02:13:39 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:13:40.148952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:13:40.503558Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.863988986s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T02:13:40.504242Z","caller":"traceutil/trace.go:171","msg":"trace[1854635905] transaction","detail":"{read_only:false; response_revision:9044; number_of_response:1; }","duration":"2.864762942s","start":"2026-05-30T02:13:37.639434Z","end":"2026-05-30T02:13:40.504197Z","steps":["trace[1854635905] 'process raft request' (duration: 2.864405385s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.504519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.6394Z","time spent":"2.864956115s","remote":"127.0.0.1:55608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2229,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T02:13:40.703996Z","caller":"traceutil/trace.go:171","msg":"trace[821115255] transaction","detail":"{read_only:false; response_revision:9045; number_of_response:1; }","duration":"2.844447635s","start":"2026-05-30T02:13:37.859518Z","end":"2026-05-30T02:13:40.703966Z","steps":["trace[821115255] 'process raft request' (duration: 2.84420796s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.704199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.859474Z","time spent":"2.844626839s","remote":"127.0.0.1:36394","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-05-30T02:13:40.704388Z","caller":"traceutil/trace.go:171","msg":"trace[614664244] transaction","detail":"{read_only:false; response_revision:9046; number_of_response:1; }","duration":"2.769649263s","start":"2026-05-30T02:13:37.934691Z","end":"2026-05-30T02:13:40.70434Z","steps":["trace[614664244] 'process raft request' (duration: 2.769228214s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.704733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.93465Z","time spent":"2.769882337s","remote":"127.0.0.1:36394","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-05-30T02:13:40.70473Z","caller":"traceutil/trace.go:171","msg":"trace[548666590] transaction","detail":"{read_only:false; response_revision:9047; number_of_response:1; }","duration":"1.408825453s","start":"2026-05-30T02:13:39.295862Z","end":"2026-05-30T02:13:40.704687Z","steps":["trace[548666590] 'process raft request' (duration: 1.408325852s)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:13:40.704878Z","caller":"traceutil/trace.go:171","msg":"trace[1865757027] transaction","detail":"{read_only:false; response_revision:9048; number_of_response:1; }","duration":"1.376920301s","start":"2026-05-30T02:13:39.327931Z","end":"2026-05-30T02:13:40.704852Z","steps":["trace[1865757027] 'process raft request' (duration: 1.376675625s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.705092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.327899Z","time spent":"1.377064083s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:13:40.705225Z","caller":"traceutil/trace.go:171","msg":"trace[1644154534] transaction","detail":"{read_only:false; response_revision:9049; number_of_response:1; }","duration":"748.201243ms","start":"2026-05-30T02:13:39.957015Z","end":"2026-05-30T02:13:40.705216Z","steps":["trace[1644154534] 'process raft request' (duration: 747.716173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.705267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.956979Z","time spent":"748.267835ms","remote":"127.0.0.1:36172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T02:13:40.705234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.29582Z","time spent":"1.409102859s","remote":"127.0.0.1:36394","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-05-30T02:13:40.704912Z","caller":"traceutil/trace.go:171","msg":"trace[1867039920] linearizableReadLoop","detail":"{readStateIndex:9371; appliedIndex:9365; }","duration":"3.059787187s","start":"2026-05-30T02:13:37.645051Z","end":"2026-05-30T02:13:40.704838Z","steps":["trace[1867039920] 'read index received' (duration: 2.858745129s)","trace[1867039920] 'applied index is now lower than readState.Index' (duration: 201.040628ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:13:40.705809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392352266s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-30T02:13:40.705875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.671996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-05-30T02:13:40.705909Z","caller":"traceutil/trace.go:171","msg":"trace[1107147592] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9049; }","duration":"941.749437ms","start":"2026-05-30T02:13:39.764151Z","end":"2026-05-30T02:13:40.705901Z","steps":["trace[1107147592] 'agreement among raft nodes before linearized reading' (duration: 941.602554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.705934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.764125Z","time spent":"941.802979ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-30T02:13:40.705876Z","caller":"traceutil/trace.go:171","msg":"trace[1152426893] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9049; }","duration":"1.392527689s","start":"2026-05-30T02:13:39.313332Z","end":"2026-05-30T02:13:40.70586Z","steps":["trace[1152426893] 'agreement among raft nodes before linearized reading' (duration: 1.392286054s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.300874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T02:13:40.706117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.313319Z","time spent":"1.392779624s","remote":"127.0.0.1:36394","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":"warn","ts":"2026-05-30T02:13:40.705982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.033889915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414469"} {"level":"warn","ts":"2026-05-30T02:13:40.706209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.678052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:13:40.706138Z","caller":"traceutil/trace.go:171","msg":"trace[823297223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9049; }","duration":"745.361176ms","start":"2026-05-30T02:13:39.960769Z","end":"2026-05-30T02:13:40.70613Z","steps":["trace[823297223] 'agreement among raft nodes before linearized reading' (duration: 745.297324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.503301949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9de869da-06f5-4745-830b-a905ed2e00c4\" ","response":"range_response_count:1 size:3640"} {"level":"warn","ts":"2026-05-30T02:13:40.706437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.960758Z","time spent":"745.665802ms","remote":"127.0.0.1:36098","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-05-30T02:13:40.706471Z","caller":"traceutil/trace.go:171","msg":"trace[1787521864] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9de869da-06f5-4745-830b-a905ed2e00c4; range_end:; response_count:1; response_revision:9049; }","duration":"2.503361389s","start":"2026-05-30T02:13:38.203101Z","end":"2026-05-30T02:13:40.706462Z","steps":["trace[1787521864] 'agreement among raft nodes before linearized reading' (duration: 2.503286948s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:38.203089Z","time spent":"2.50340504s","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3663,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9de869da-06f5-4745-830b-a905ed2e00c4\" "} {"level":"warn","ts":"2026-05-30T02:13:40.706494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.386013557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-w5rlz\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-05-30T02:13:40.706552Z","caller":"traceutil/trace.go:171","msg":"trace[821949494] range","detail":"{range_begin:/registry/pods/openstack/keepalived-w5rlz; range_end:; response_count:1; response_revision:9049; }","duration":"1.386073988s","start":"2026-05-30T02:13:39.320463Z","end":"2026-05-30T02:13:40.706537Z","steps":["trace[821949494] 'agreement among raft nodes before linearized reading' (duration: 1.385851793s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.673735998s","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-05-30T02:13:40.706636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.320431Z","time spent":"1.3861699s","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-w5rlz\" "} {"level":"warn","ts":"2026-05-30T02:13:40.706122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.441615405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:13:40.706717Z","caller":"traceutil/trace.go:171","msg":"trace[2039412124] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:9049; }","duration":"1.442250328s","start":"2026-05-30T02:13:39.264447Z","end":"2026-05-30T02:13:40.706697Z","steps":["trace[2039412124] 'agreement among raft nodes before linearized reading' (duration: 1.441597265s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:39.264426Z","time spent":"1.442337279s","remote":"127.0.0.1:51820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:13:40.706796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.711054494s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T02:13:40.706824Z","caller":"traceutil/trace.go:171","msg":"trace[275778340] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9049; }","duration":"2.711127435s","start":"2026-05-30T02:13:37.99569Z","end":"2026-05-30T02:13:40.706818Z","steps":["trace[275778340] 'agreement among raft nodes before linearized reading' (duration: 2.711049224s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.995662Z","time spent":"2.711182576s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-30T02:13:40.706275Z","caller":"traceutil/trace.go:171","msg":"trace[531205010] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:9049; }","duration":"3.034210622s","start":"2026-05-30T02:13:37.672036Z","end":"2026-05-30T02:13:40.706247Z","steps":["trace[531205010] 'agreement among raft nodes before linearized reading' (duration: 3.033565559s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.710842078s","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-05-30T02:13:40.706654Z","caller":"traceutil/trace.go:171","msg":"trace[1255087361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9049; }","duration":"2.67378844s","start":"2026-05-30T02:13:38.03286Z","end":"2026-05-30T02:13:40.706648Z","steps":["trace[1255087361] 'agreement among raft nodes before linearized reading' (duration: 2.673722139s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.707046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:38.032848Z","time spent":"2.674183778s","remote":"127.0.0.1:36394","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":"info","ts":"2026-05-30T02:13:40.707057Z","caller":"traceutil/trace.go:171","msg":"trace[2088983929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9049; }","duration":"2.711124894s","start":"2026-05-30T02:13:37.99588Z","end":"2026-05-30T02:13:40.707005Z","steps":["trace[2088983929] 'agreement among raft nodes before linearized reading' (duration: 2.710524772s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.706942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.672012Z","time spent":"3.034910376s","remote":"127.0.0.1:35500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":414492,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" "} {"level":"warn","ts":"2026-05-30T02:13:40.707207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.995868Z","time spent":"2.711311958s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-30T02:13:40.706412Z","caller":"traceutil/trace.go:171","msg":"trace[1638669385] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:9049; }","duration":"181.990548ms","start":"2026-05-30T02:13:40.524405Z","end":"2026-05-30T02:13:40.706395Z","steps":["trace[1638669385] 'agreement among raft nodes before linearized reading' (duration: 181.495888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.70637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.704871576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-30T02:13:40.707453Z","caller":"traceutil/trace.go:171","msg":"trace[166431846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9049; }","duration":"2.706005929s","start":"2026-05-30T02:13:38.001431Z","end":"2026-05-30T02:13:40.707437Z","steps":["trace[166431846] 'agreement among raft nodes before linearized reading' (duration: 2.704886796s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.705861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.218176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-30T02:13:40.70638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.477813106s","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-05-30T02:13:40.707578Z","caller":"traceutil/trace.go:171","msg":"trace[310517192] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:9049; }","duration":"2.479060632s","start":"2026-05-30T02:13:38.228504Z","end":"2026-05-30T02:13:40.707565Z","steps":["trace[310517192] 'agreement among raft nodes before linearized reading' (duration: 2.477725125s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.707622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:38.228492Z","time spent":"2.479112983s","remote":"127.0.0.1:37264","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-05-30T02:13:40.707652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:38.001419Z","time spent":"2.706207594s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-30T02:13:40.707783Z","caller":"traceutil/trace.go:171","msg":"trace[1358134823] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:9049; }","duration":"319.212617ms","start":"2026-05-30T02:13:40.388542Z","end":"2026-05-30T02:13:40.707755Z","steps":["trace[1358134823] 'agreement among raft nodes before linearized reading' (duration: 317.107144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.707866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:40.38852Z","time spent":"319.3205ms","remote":"127.0.0.1:36186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":98,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:13:40.708056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.062987012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224956"} {"level":"info","ts":"2026-05-30T02:13:40.708141Z","caller":"traceutil/trace.go:171","msg":"trace[816913919] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:9049; }","duration":"3.063111284s","start":"2026-05-30T02:13:37.645005Z","end":"2026-05-30T02:13:40.708117Z","steps":["trace[816913919] 'agreement among raft nodes before linearized reading' (duration: 3.060738006s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:13:40.708202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:13:37.644983Z","time spent":"3.063203256s","remote":"127.0.0.1:36200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2224979,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-05-30T02:13:41.595506Z","caller":"traceutil/trace.go:171","msg":"trace[1155961613] transaction","detail":"{read_only:false; response_revision:9061; number_of_response:1; }","duration":"269.180673ms","start":"2026-05-30T02:13:41.32627Z","end":"2026-05-30T02:13:41.595451Z","steps":["trace[1155961613] 'process raft request' (duration: 181.192241ms)","trace[1155961613] 'compare' (duration: 87.689756ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:13:41.59529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.317286ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:13:41.595779Z","caller":"traceutil/trace.go:171","msg":"trace[1071869999] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:9060; }","duration":"228.909769ms","start":"2026-05-30T02:13:41.366834Z","end":"2026-05-30T02:13:41.595744Z","steps":["trace[1071869999] 'range keys from in-memory index tree' (duration: 228.294715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:13.376773Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:13.877356Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:14.377552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:14.878486Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:14.952601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000022271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-30T02:14:14.952717Z","caller":"traceutil/trace.go:171","msg":"trace[126366103] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000181684s","start":"2026-05-30T02:14:12.952512Z","end":"2026-05-30T02:14:14.952693Z","steps":["trace[126366103] 'agreement among raft nodes before linearized reading' (duration: 2.000044932s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:14.952771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.952498Z","time spent":"2.000263046s","remote":"127.0.0.1:36098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/30 02:14:14 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:14:15.378819Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:15.879621Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:16.380783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:16.881149Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:16.95286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999710816s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-30T02:14:16.952966Z","caller":"traceutil/trace.go:171","msg":"trace[284455867] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999905429s","start":"2026-05-30T02:14:14.953035Z","end":"2026-05-30T02:14:16.952941Z","steps":["trace[284455867] 'agreement among raft nodes before linearized reading' (duration: 1.999761887s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:16.953045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:14.952986Z","time spent":"2.000046972s","remote":"127.0.0.1:36096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T02:14:17.382125Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:17.82967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.832645Z","time spent":"4.997013491s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/05/30 02:14:17 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:14:17.831393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.834651Z","time spent":"4.996730996s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-30T02:14:17.854653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.85645Z","time spent":"4.998190795s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/05/30 02:14:17 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:14:17.863873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.86484Z","time spent":"4.999024781s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/05/30 02:14:17 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:14:17.883097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567382688584967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T02:14:17.927393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999991012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-30T02:14:17.9275Z","caller":"traceutil/trace.go:171","msg":"trace[1093273266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000157915s","start":"2026-05-30T02:14:12.927317Z","end":"2026-05-30T02:14:17.927475Z","steps":["trace[1093273266] 'agreement among raft nodes before linearized reading' (duration: 5.000032393s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:17.927555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.927296Z","time spent":"5.000248247s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/05/30 02:14:17 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:14:17.931614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999603123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-30T02:14:17.931734Z","caller":"traceutil/trace.go:171","msg":"trace[2131805740] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999793726s","start":"2026-05-30T02:14:12.931916Z","end":"2026-05-30T02:14:17.93171Z","steps":["trace[2131805740] 'agreement among raft nodes before linearized reading' (duration: 4.999645583s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:17.931799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.931894Z","time spent":"4.999887329s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/05/30 02:14:17 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T02:14:17.932502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999362749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-30T02:14:17.932569Z","caller":"traceutil/trace.go:171","msg":"trace[958013283] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999462301s","start":"2026-05-30T02:14:12.933093Z","end":"2026-05-30T02:14:17.932555Z","steps":["trace[958013283] 'agreement among raft nodes before linearized reading' (duration: 4.99938124s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:17.932609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.933076Z","time spent":"4.999524792s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T02:14:18.078849Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.337429942s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T02:14:18.079331Z","caller":"traceutil/trace.go:171","msg":"trace[2092101535] transaction","detail":"{read_only:false; response_revision:9348; number_of_response:1; }","duration":"5.338016914s","start":"2026-05-30T02:14:12.741286Z","end":"2026-05-30T02:14:18.079303Z","steps":["trace[2092101535] 'process raft request' (duration: 5.33779779s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.079545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.741266Z","time spent":"5.338158137s","remote":"127.0.0.1:36172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T02:14:18.856375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.537472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T02:14:18.858128Z","caller":"traceutil/trace.go:171","msg":"trace[263349981] transaction","detail":"{read_only:false; response_revision:9353; number_of_response:1; }","duration":"4.912166453s","start":"2026-05-30T02:14:13.945895Z","end":"2026-05-30T02:14:18.858061Z","steps":["trace[263349981] 'process raft request' (duration: 4.91201083s)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:18.858229Z","caller":"traceutil/trace.go:171","msg":"trace[528571614] transaction","detail":"{read_only:false; response_revision:9354; number_of_response:1; }","duration":"4.766460288s","start":"2026-05-30T02:14:14.091714Z","end":"2026-05-30T02:14:18.858174Z","steps":["trace[528571614] 'process raft request' (duration: 4.766249974s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.858386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:14.091676Z","time spent":"4.766618771s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T02:14:18.858386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:13.945873Z","time spent":"4.912389847s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T02:14:18.876486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000272986s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-30T02:14:18.876585Z","caller":"traceutil/trace.go:171","msg":"trace[1363294698] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00043296s","start":"2026-05-30T02:14:16.876127Z","end":"2026-05-30T02:14:18.87656Z","steps":["trace[1363294698] 'agreement among raft nodes before linearized reading' (duration: 2.000300547s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.87725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:16.876106Z","time spent":"2.001124163s","remote":"127.0.0.1:36098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/30 02:14:18 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-30T02:14:18.94546Z","caller":"traceutil/trace.go:171","msg":"trace[1831630973] linearizableReadLoop","detail":"{readStateIndex:9686; appliedIndex:9678; }","duration":"6.068834992s","start":"2026-05-30T02:14:12.876596Z","end":"2026-05-30T02:14:18.945431Z","steps":["trace[1831630973] 'read index received' (duration: 5.202491849s)","trace[1831630973] 'applied index is now lower than readState.Index' (duration: 866.341473ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:14:18.945869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.5599637s","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-05-30T02:14:18.945936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.069323492s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-30T02:14:18.945948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.372147511s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-05-30T02:14:18.945975Z","caller":"traceutil/trace.go:171","msg":"trace[173986624] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:9354; }","duration":"5.560115142s","start":"2026-05-30T02:14:13.385838Z","end":"2026-05-30T02:14:18.945953Z","steps":["trace[173986624] 'agreement among raft nodes before linearized reading' (duration: 5.559922488s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.945954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.484039244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:14:18.945999Z","caller":"traceutil/trace.go:171","msg":"trace[362822840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9354; }","duration":"6.069437134s","start":"2026-05-30T02:14:12.876544Z","end":"2026-05-30T02:14:18.945981Z","steps":["trace[362822840] 'agreement among raft nodes before linearized reading' (duration: 6.069069377s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.022285288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-w5rlz\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-05-30T02:14:18.946316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.985347671s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T02:14:18.946362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.24398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T02:14:18.946343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.417431521s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:14:18.946387Z","caller":"traceutil/trace.go:171","msg":"trace[394292679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9354; }","duration":"1.985440963s","start":"2026-05-30T02:14:16.960928Z","end":"2026-05-30T02:14:18.946369Z","steps":["trace[394292679] 'agreement among raft nodes before linearized reading' (duration: 1.985347971s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064162374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:14:18.946398Z","caller":"traceutil/trace.go:171","msg":"trace[831746359] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:9354; }","duration":"989.333322ms","start":"2026-05-30T02:14:17.957055Z","end":"2026-05-30T02:14:18.946389Z","steps":["trace[831746359] 'agreement among raft nodes before linearized reading' (duration: 989.280561ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:18.94601Z","caller":"traceutil/trace.go:171","msg":"trace[2126679834] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9354; }","duration":"2.372215143s","start":"2026-05-30T02:14:16.57378Z","end":"2026-05-30T02:14:18.945996Z","steps":["trace[2126679834] 'agreement among raft nodes before linearized reading' (duration: 2.371957658s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113154298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:551"} {"level":"warn","ts":"2026-05-30T02:14:18.946426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.142427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-579fff9d47-b8zck.18b436017ef00c40\" ","response":"range_response_count:1 size:1134"} {"level":"warn","ts":"2026-05-30T02:14:18.946471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088955953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-30T02:14:18.946509Z","caller":"traceutil/trace.go:171","msg":"trace[1309014] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:9354; }","duration":"1.11325973s","start":"2026-05-30T02:14:17.833235Z","end":"2026-05-30T02:14:18.946495Z","steps":["trace[1309014] 'agreement among raft nodes before linearized reading' (duration: 1.112826891s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.013425297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-30T02:14:18.946037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:13.385784Z","time spent":"5.560242105s","remote":"127.0.0.1:36378","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-05-30T02:14:18.946576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:17.833214Z","time spent":"1.113352792s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":574,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-05-30T02:14:18.94662Z","caller":"traceutil/trace.go:171","msg":"trace[1825928812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9354; }","duration":"6.01355482s","start":"2026-05-30T02:14:12.933038Z","end":"2026-05-30T02:14:18.946593Z","steps":["trace[1825928812] 'agreement among raft nodes before linearized reading' (duration: 6.013249484s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079763465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-05-30T02:14:18.946692Z","caller":"traceutil/trace.go:171","msg":"trace[130302011] range","detail":"{range_begin:/registry/pods/openstack/keepalived-w5rlz; range_end:; response_count:1; response_revision:9354; }","duration":"6.022633346s","start":"2026-05-30T02:14:12.92372Z","end":"2026-05-30T02:14:18.946354Z","steps":["trace[130302011] 'agreement among raft nodes before linearized reading' (duration: 6.021996393s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.923704Z","time spent":"6.023105546s","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-w5rlz\" "} {"level":"warn","ts":"2026-05-30T02:14:18.946656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:16.573699Z","time spent":"2.372938128s","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-30T02:14:18.946213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.180399007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-30T02:14:18.947706Z","caller":"traceutil/trace.go:171","msg":"trace[13818071] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:9354; }","duration":"5.181906558s","start":"2026-05-30T02:14:13.765754Z","end":"2026-05-30T02:14:18.947661Z","steps":["trace[13818071] 'agreement among raft nodes before linearized reading' (duration: 5.180312685s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.947881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:13.765715Z","time spent":"5.182043991s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-30T02:14:18.946333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.876526Z","time spent":"6.069788112s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T02:14:18.946694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:12.933027Z","time spent":"6.013650422s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T02:14:18.946448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:16.960915Z","time spent":"1.985522884s","remote":"127.0.0.1:36096","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-05-30T02:14:18.946061Z","caller":"traceutil/trace.go:171","msg":"trace[252582353] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:9354; }","duration":"3.484148156s","start":"2026-05-30T02:14:15.461885Z","end":"2026-05-30T02:14:18.946033Z","steps":["trace[252582353] 'agreement among raft nodes before linearized reading' (duration: 3.483981273s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.948303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:15.461818Z","time spent":"3.486462573s","remote":"127.0.0.1:51838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:14:18.946226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114158229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-05-30T02:14:18.946232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.759787242s","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-05-30T02:14:18.9485Z","caller":"traceutil/trace.go:171","msg":"trace[1311431066] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:9354; }","duration":"1.116654049s","start":"2026-05-30T02:14:17.831817Z","end":"2026-05-30T02:14:18.948471Z","steps":["trace[1311431066] 'agreement among raft nodes before linearized reading' (duration: 1.114292261s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.948572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:17.831783Z","time spent":"1.116768771s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":549,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"info","ts":"2026-05-30T02:14:18.948566Z","caller":"traceutil/trace.go:171","msg":"trace[10734815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:9354; }","duration":"5.762245813s","start":"2026-05-30T02:14:13.18629Z","end":"2026-05-30T02:14:18.948536Z","steps":["trace[10734815] 'agreement among raft nodes before linearized reading' (duration: 5.759815623s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.948686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:13.186194Z","time spent":"5.762468907s","remote":"127.0.0.1:37298","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":"warn","ts":"2026-05-30T02:14:18.946282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.593730192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T02:14:18.948866Z","caller":"traceutil/trace.go:171","msg":"trace[2028460845] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9354; }","duration":"5.596371245s","start":"2026-05-30T02:14:13.352469Z","end":"2026-05-30T02:14:18.94884Z","steps":["trace[2028460845] 'agreement among raft nodes before linearized reading' (duration: 5.593750982s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.948948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:13.352447Z","time spent":"5.596476677s","remote":"127.0.0.1:37282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:14:18.946297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.834267048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:14:18.94909Z","caller":"traceutil/trace.go:171","msg":"trace[1911120637] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9354; }","duration":"5.837092936s","start":"2026-05-30T02:14:13.111979Z","end":"2026-05-30T02:14:18.949072Z","steps":["trace[1911120637] 'agreement among raft nodes before linearized reading' (duration: 5.834284649s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.949136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:13.11195Z","time spent":"5.837170307s","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-30T02:14:18.94631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.37059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:14:18.949357Z","caller":"traceutil/trace.go:171","msg":"trace[1753389397] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9354; }","duration":"174.463053ms","start":"2026-05-30T02:14:18.774871Z","end":"2026-05-30T02:14:18.949334Z","steps":["trace[1753389397] 'agreement among raft nodes before linearized reading' (duration: 171.403771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.946449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:17.957026Z","time spent":"989.415564ms","remote":"127.0.0.1:36178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-05-30T02:14:18.946456Z","caller":"traceutil/trace.go:171","msg":"trace[1310210064] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:9354; }","duration":"1.064224235s","start":"2026-05-30T02:14:17.882214Z","end":"2026-05-30T02:14:18.946439Z","steps":["trace[1310210064] 'agreement among raft nodes before linearized reading' (duration: 1.064124413s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.949717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:17.882133Z","time spent":"1.067555744s","remote":"127.0.0.1:41346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"info","ts":"2026-05-30T02:14:18.946457Z","caller":"traceutil/trace.go:171","msg":"trace[110439374] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:9354; }","duration":"4.417548173s","start":"2026-05-30T02:14:14.528877Z","end":"2026-05-30T02:14:18.946425Z","steps":["trace[110439374] 'agreement among raft nodes before linearized reading' (duration: 4.417196575s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.949926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:14.528797Z","time spent":"4.421078585s","remote":"127.0.0.1:55644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":59,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-05-30T02:14:18.946547Z","caller":"traceutil/trace.go:171","msg":"trace[1532527201] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9354; }","duration":"1.089045844s","start":"2026-05-30T02:14:17.857482Z","end":"2026-05-30T02:14:18.946528Z","steps":["trace[1532527201] 'agreement among raft nodes before linearized reading' (duration: 1.088553053s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.9503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:17.857472Z","time spent":"1.09280562s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-30T02:14:18.946546Z","caller":"traceutil/trace.go:171","msg":"trace[637494882] range","detail":"{range_begin:/registry/events/openstack/barbican-api-579fff9d47-b8zck.18b436017ef00c40; range_end:; response_count:1; response_revision:9354; }","duration":"862.343861ms","start":"2026-05-30T02:14:18.084169Z","end":"2026-05-30T02:14:18.946513Z","steps":["trace[637494882] 'agreement among raft nodes before linearized reading' (duration: 861.828509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.950442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:18.084145Z","time spent":"866.273711ms","remote":"127.0.0.1:36172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1157,"request content":"key:\"/registry/events/openstack/barbican-api-579fff9d47-b8zck.18b436017ef00c40\" "} {"level":"info","ts":"2026-05-30T02:14:18.946696Z","caller":"traceutil/trace.go:171","msg":"trace[264398233] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:9354; }","duration":"1.080190803s","start":"2026-05-30T02:14:17.866489Z","end":"2026-05-30T02:14:18.946679Z","steps":["trace[264398233] 'agreement among raft nodes before linearized reading' (duration: 1.079468097s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.950601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:17.866472Z","time spent":"1.084104773s","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-05-30T02:14:18.946216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.674487894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T02:14:18.950767Z","caller":"traceutil/trace.go:171","msg":"trace[1268372131] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:9354; }","duration":"2.67916197s","start":"2026-05-30T02:14:16.271582Z","end":"2026-05-30T02:14:18.950744Z","steps":["trace[1268372131] 'agreement among raft nodes before linearized reading' (duration: 2.674422722s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:18.950839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:14:16.271535Z","time spent":"2.679278482s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-30T02:14:21.186819Z","caller":"traceutil/trace.go:171","msg":"trace[768415847] transaction","detail":"{read_only:false; response_revision:9374; number_of_response:1; }","duration":"166.760345ms","start":"2026-05-30T02:14:21.02003Z","end":"2026-05-30T02:14:21.18679Z","steps":["trace[768415847] 'process raft request' (duration: 166.664973ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:21.186869Z","caller":"traceutil/trace.go:171","msg":"trace[1274411228] transaction","detail":"{read_only:false; response_revision:9373; number_of_response:1; }","duration":"167.029391ms","start":"2026-05-30T02:14:21.019805Z","end":"2026-05-30T02:14:21.186834Z","steps":["trace[1274411228] 'process raft request' (duration: 106.252637ms)","trace[1274411228] 'compare' (duration: 60.451287ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:14:21.187175Z","caller":"traceutil/trace.go:171","msg":"trace[263398693] transaction","detail":"{read_only:false; response_revision:9375; number_of_response:1; }","duration":"166.592262ms","start":"2026-05-30T02:14:21.020553Z","end":"2026-05-30T02:14:21.187145Z","steps":["trace[263398693] 'process raft request' (duration: 166.198454ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:21.187248Z","caller":"traceutil/trace.go:171","msg":"trace[661349442] linearizableReadLoop","detail":"{readStateIndex:9709; appliedIndex:9705; }","duration":"129.584473ms","start":"2026-05-30T02:14:21.057644Z","end":"2026-05-30T02:14:21.187228Z","steps":["trace[661349442] 'read index received' (duration: 68.431802ms)","trace[661349442] 'applied index is now lower than readState.Index' (duration: 61.151021ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:14:21.187295Z","caller":"traceutil/trace.go:171","msg":"trace[1023279367] transaction","detail":"{read_only:false; response_revision:9377; number_of_response:1; }","duration":"128.936091ms","start":"2026-05-30T02:14:21.05834Z","end":"2026-05-30T02:14:21.187276Z","steps":["trace[1023279367] 'process raft request' (duration: 128.838678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:21.187493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.739955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-30T02:14:21.187543Z","caller":"traceutil/trace.go:171","msg":"trace[2037128522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9377; }","duration":"167.831138ms","start":"2026-05-30T02:14:21.019701Z","end":"2026-05-30T02:14:21.187532Z","steps":["trace[2037128522] 'agreement among raft nodes before linearized reading' (duration: 167.628584ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:21.18765Z","caller":"traceutil/trace.go:171","msg":"trace[792794081] transaction","detail":"{read_only:false; response_revision:9378; number_of_response:1; }","duration":"126.116773ms","start":"2026-05-30T02:14:21.061517Z","end":"2026-05-30T02:14:21.187634Z","steps":["trace[792794081] 'process raft request' (duration: 125.720254ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:21.187241Z","caller":"traceutil/trace.go:171","msg":"trace[1255639761] transaction","detail":"{read_only:false; response_revision:9376; number_of_response:1; }","duration":"166.365357ms","start":"2026-05-30T02:14:21.020842Z","end":"2026-05-30T02:14:21.187208Z","steps":["trace[1255639761] 'process raft request' (duration: 166.155453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:21.187844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.02503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-w5rlz\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-05-30T02:14:21.188029Z","caller":"traceutil/trace.go:171","msg":"trace[436476765] range","detail":"{range_begin:/registry/pods/openstack/keepalived-w5rlz; range_end:; response_count:1; response_revision:9378; }","duration":"165.247174ms","start":"2026-05-30T02:14:21.022761Z","end":"2026-05-30T02:14:21.188008Z","steps":["trace[436476765] 'agreement among raft nodes before linearized reading' (duration: 164.744334ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:21.330392Z","caller":"traceutil/trace.go:171","msg":"trace[1011038741] linearizableReadLoop","detail":"{readStateIndex:9712; appliedIndex:9711; }","duration":"137.420784ms","start":"2026-05-30T02:14:21.192942Z","end":"2026-05-30T02:14:21.330362Z","steps":["trace[1011038741] 'read index received' (duration: 121.579929ms)","trace[1011038741] 'applied index is now lower than readState.Index' (duration: 15.839555ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:14:21.330549Z","caller":"traceutil/trace.go:171","msg":"trace[1489179218] transaction","detail":"{read_only:false; response_revision:9379; number_of_response:1; }","duration":"137.696941ms","start":"2026-05-30T02:14:21.192838Z","end":"2026-05-30T02:14:21.330535Z","steps":["trace[1489179218] 'process raft request' (duration: 121.773185ms)","trace[1489179218] 'compare' (duration: 15.59531ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:14:21.330869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.890004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T02:14:21.330962Z","caller":"traceutil/trace.go:171","msg":"trace[361713536] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:9379; }","duration":"138.043666ms","start":"2026-05-30T02:14:21.192896Z","end":"2026-05-30T02:14:21.330939Z","steps":["trace[361713536] 'agreement among raft nodes before linearized reading' (duration: 137.699829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:14:21.33109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.443115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:28 size:254758"} {"level":"info","ts":"2026-05-30T02:14:21.33115Z","caller":"traceutil/trace.go:171","msg":"trace[725922381] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:28; response_revision:9379; }","duration":"137.754211ms","start":"2026-05-30T02:14:21.193383Z","end":"2026-05-30T02:14:21.331137Z","steps":["trace[725922381] 'agreement among raft nodes before linearized reading' (duration: 137.21545ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:14:42.311564Z","caller":"traceutil/trace.go:171","msg":"trace[928774962] transaction","detail":"{read_only:false; response_revision:9578; number_of_response:1; }","duration":"100.056441ms","start":"2026-05-30T02:14:42.21147Z","end":"2026-05-30T02:14:42.311527Z","steps":["trace[928774962] 'process raft request' (duration: 55.037533ms)","trace[928774962] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/cilium-operator-resource-lock; req_size:472; } (duration: 44.791974ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:14:53.329811Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-30T02:14:53.334995Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-30T02:14:53.335095Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-30T02:16:47.890903Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8074} {"level":"info","ts":"2026-05-30T02:16:47.962605Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8074,"took":"68.279115ms","hash":3201210915,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":27992064,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-30T02:16:47.962675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3201210915,"revision":8074,"compact-revision":5993} {"level":"info","ts":"2026-05-30T02:21:47.897245Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10443} {"level":"info","ts":"2026-05-30T02:21:47.983397Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10443,"took":"82.631669ms","hash":2987090006,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":25583616,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-30T02:21:47.983487Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2987090006,"revision":10443,"compact-revision":8074} {"level":"info","ts":"2026-05-30T02:26:19.744022Z","caller":"traceutil/trace.go:171","msg":"trace[382956118] transaction","detail":"{read_only:false; response_revision:14443; number_of_response:1; }","duration":"106.688453ms","start":"2026-05-30T02:26:19.637298Z","end":"2026-05-30T02:26:19.743987Z","steps":["trace[382956118] 'process raft request' (duration: 96.716143ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:26:47.904214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12604} {"level":"info","ts":"2026-05-30T02:26:47.991853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12604,"took":"84.287262ms","hash":2277959417,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":27070464,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-30T02:26:47.991927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2277959417,"revision":12604,"compact-revision":10443} {"level":"info","ts":"2026-05-30T02:26:56.160342Z","caller":"traceutil/trace.go:171","msg":"trace[1720428749] transaction","detail":"{read_only:false; response_revision:14651; number_of_response:1; }","duration":"340.464747ms","start":"2026-05-30T02:26:55.819843Z","end":"2026-05-30T02:26:56.160308Z","steps":["trace[1720428749] 'process raft request' (duration: 340.232382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:26:56.160566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:26:55.8198Z","time spent":"340.641881ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12479,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:27:18.643092Z","caller":"traceutil/trace.go:171","msg":"trace[1931223123] transaction","detail":"{read_only:false; response_revision:14959; number_of_response:1; }","duration":"107.158712ms","start":"2026-05-30T02:27:18.535889Z","end":"2026-05-30T02:27:18.643048Z","steps":["trace[1931223123] 'process raft request' (duration: 106.845116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:27:18.643302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.242454ms","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-05-30T02:27:18.643396Z","caller":"traceutil/trace.go:171","msg":"trace[1105000822] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14959; }","duration":"105.365967ms","start":"2026-05-30T02:27:18.538002Z","end":"2026-05-30T02:27:18.643368Z","steps":["trace[1105000822] 'agreement among raft nodes before linearized reading' (duration: 105.111252ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:27:18.643071Z","caller":"traceutil/trace.go:171","msg":"trace[760045285] linearizableReadLoop","detail":"{readStateIndex:15483; appliedIndex:15482; }","duration":"104.901748ms","start":"2026-05-30T02:27:18.538038Z","end":"2026-05-30T02:27:18.642939Z","steps":["trace[760045285] 'read index received' (duration: 104.736054ms)","trace[760045285] 'applied index is now lower than readState.Index' (duration: 164.424µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:27:18.918686Z","caller":"traceutil/trace.go:171","msg":"trace[2014268624] transaction","detail":"{read_only:false; response_revision:14961; number_of_response:1; }","duration":"352.136922ms","start":"2026-05-30T02:27:18.566524Z","end":"2026-05-30T02:27:18.918661Z","steps":["trace[2014268624] 'process raft request' (duration: 351.948498ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:27:18.918792Z","caller":"traceutil/trace.go:171","msg":"trace[534809217] transaction","detail":"{read_only:false; response_revision:14960; number_of_response:1; }","duration":"352.303185ms","start":"2026-05-30T02:27:18.566434Z","end":"2026-05-30T02:27:18.918737Z","steps":["trace[534809217] 'process raft request' (duration: 351.814775ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:27:18.918849Z","caller":"traceutil/trace.go:171","msg":"trace[1647164033] transaction","detail":"{read_only:false; response_revision:14962; number_of_response:1; }","duration":"351.961618ms","start":"2026-05-30T02:27:18.566819Z","end":"2026-05-30T02:27:18.91878Z","steps":["trace[1647164033] 'process raft request' (duration: 351.709423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:27:18.919061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:27:18.566388Z","time spent":"352.52368ms","remote":"127.0.0.1:36394","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-05-30T02:27:18.918848Z","caller":"traceutil/trace.go:171","msg":"trace[1735843672] transaction","detail":"{read_only:false; response_revision:14963; number_of_response:1; }","duration":"350.656293ms","start":"2026-05-30T02:27:18.568161Z","end":"2026-05-30T02:27:18.918817Z","steps":["trace[1735843672] 'process raft request' (duration: 350.409288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:27:18.918957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.03394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d7b4aef-cee5-40eb-bcd7-539a733bd4b7\" ","response":"range_response_count:1 size:3636"} {"level":"warn","ts":"2026-05-30T02:27:18.919331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:27:18.566809Z","time spent":"352.280034ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T02:27:18.919387Z","caller":"traceutil/trace.go:171","msg":"trace[494963826] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1d7b4aef-cee5-40eb-bcd7-539a733bd4b7; range_end:; response_count:1; response_revision:14963; }","duration":"354.49719ms","start":"2026-05-30T02:27:18.564866Z","end":"2026-05-30T02:27:18.919363Z","steps":["trace[494963826] 'agreement among raft nodes before linearized reading' (duration: 353.886887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:27:18.919696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:27:18.564853Z","time spent":"354.781266ms","remote":"127.0.0.1:36290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3659,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d7b4aef-cee5-40eb-bcd7-539a733bd4b7\" "} {"level":"info","ts":"2026-05-30T02:27:18.918674Z","caller":"traceutil/trace.go:171","msg":"trace[1308214002] linearizableReadLoop","detail":"{readStateIndex:15487; appliedIndex:15483; }","duration":"275.033614ms","start":"2026-05-30T02:27:18.643591Z","end":"2026-05-30T02:27:18.918625Z","steps":["trace[1308214002] 'read index received' (duration: 274.618086ms)","trace[1308214002] 'applied index is now lower than readState.Index' (duration: 413.848µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:27:18.918974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:27:18.566487Z","time spent":"352.360466ms","remote":"127.0.0.1:36394","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-05-30T02:27:18.920408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:27:18.568148Z","time spent":"351.087491ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T02:27:18.936098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.936531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-30T02:27:18.936198Z","caller":"traceutil/trace.go:171","msg":"trace[259509617] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14964; }","duration":"267.109535ms","start":"2026-05-30T02:27:18.669063Z","end":"2026-05-30T02:27:18.936173Z","steps":["trace[259509617] 'agreement among raft nodes before linearized reading' (duration: 266.820518ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:27:18.935969Z","caller":"traceutil/trace.go:171","msg":"trace[521707862] transaction","detail":"{read_only:false; response_revision:14964; number_of_response:1; }","duration":"287.545414ms","start":"2026-05-30T02:27:18.648388Z","end":"2026-05-30T02:27:18.935934Z","steps":["trace[521707862] 'process raft request' (duration: 287.282709ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:28:35.00886Z","caller":"traceutil/trace.go:171","msg":"trace[1901048847] transaction","detail":"{read_only:false; response_revision:15717; number_of_response:1; }","duration":"116.164083ms","start":"2026-05-30T02:28:34.892651Z","end":"2026-05-30T02:28:35.008815Z","steps":["trace[1901048847] 'process raft request' (duration: 115.963789ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:28:35.209836Z","caller":"traceutil/trace.go:171","msg":"trace[530033726] transaction","detail":"{read_only:false; response_revision:15718; number_of_response:1; }","duration":"149.751628ms","start":"2026-05-30T02:28:35.060033Z","end":"2026-05-30T02:28:35.209784Z","steps":["trace[530033726] 'process raft request' (duration: 100.803205ms)","trace[530033726] 'compare' (duration: 48.514085ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:28:36.494792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.31596ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-30T02:28:36.494938Z","caller":"traceutil/trace.go:171","msg":"trace[492533521] linearizableReadLoop","detail":"{readStateIndex:16270; appliedIndex:16269; }","duration":"381.646226ms","start":"2026-05-30T02:28:36.113265Z","end":"2026-05-30T02:28:36.494912Z","steps":["trace[492533521] 'read index received' (duration: 102.121072ms)","trace[492533521] 'applied index is now lower than readState.Index' (duration: 279.522954ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T02:28:36.495242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.65058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-30T02:28:36.49531Z","caller":"traceutil/trace.go:171","msg":"trace[1847228215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15724; }","duration":"312.726981ms","start":"2026-05-30T02:28:36.182562Z","end":"2026-05-30T02:28:36.495289Z","steps":["trace[1847228215] 'agreement among raft nodes before linearized reading' (duration: 312.494487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:28:36.495351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:28:36.182525Z","time spent":"312.816052ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T02:28:36.495332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.267197ms","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-05-30T02:28:36.495379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.642568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-x2mh7\" ","response":"range_response_count:1 size:9787"} {"level":"warn","ts":"2026-05-30T02:28:36.495432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.177896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-30T02:28:36.495444Z","caller":"traceutil/trace.go:171","msg":"trace[1675764686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15724; }","duration":"257.432701ms","start":"2026-05-30T02:28:36.237984Z","end":"2026-05-30T02:28:36.495417Z","steps":["trace[1675764686] 'agreement among raft nodes before linearized reading' (duration: 257.078084ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:28:36.495494Z","caller":"traceutil/trace.go:171","msg":"trace[1041037578] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15724; }","duration":"382.289628ms","start":"2026-05-30T02:28:36.11319Z","end":"2026-05-30T02:28:36.49548Z","steps":["trace[1041037578] 'agreement among raft nodes before linearized reading' (duration: 381.847609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T02:28:36.495483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.410522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-bmnvj\" ","response":"range_response_count:1 size:20750"} {"level":"warn","ts":"2026-05-30T02:28:36.495601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T02:28:36.113165Z","time spent":"382.426451ms","remote":"127.0.0.1:36366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5544,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"info","ts":"2026-05-30T02:28:36.495495Z","caller":"traceutil/trace.go:171","msg":"trace[894131186] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-x2mh7; range_end:; response_count:1; response_revision:15724; }","duration":"297.797761ms","start":"2026-05-30T02:28:36.197671Z","end":"2026-05-30T02:28:36.495469Z","steps":["trace[894131186] 'agreement among raft nodes before linearized reading' (duration: 297.472254ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:28:36.49565Z","caller":"traceutil/trace.go:171","msg":"trace[1851869163] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-bmnvj; range_end:; response_count:1; response_revision:15724; }","duration":"167.595306ms","start":"2026-05-30T02:28:36.327998Z","end":"2026-05-30T02:28:36.495593Z","steps":["trace[1851869163] 'agreement among raft nodes before linearized reading' (duration: 167.131967ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T02:31:47.911835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14593} {"level":"info","ts":"2026-05-30T02:31:48.002846Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14593,"took":"86.712652ms","hash":300320014,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":33665024,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-30T02:31:48.002918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":300320014,"revision":14593,"compact-revision":12604} {"level":"info","ts":"2026-05-30T02:36:47.921604Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17236} {"level":"info","ts":"2026-05-30T02:36:48.025913Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17236,"took":"99.935945ms","hash":3598298583,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":30232576,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-30T02:36:48.025991Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3598298583,"revision":17236,"compact-revision":14593} {"level":"info","ts":"2026-05-30T02:37:42.297529Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-30T02:37:42.303719Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-30T02:37:42.303866Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-30T02:41:47.931708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19046} {"level":"info","ts":"2026-05-30T02:41:48.028241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19046,"took":"92.458974ms","hash":951015425,"current-db-size-bytes":57348096,"current-db-size":"57 MB","current-db-size-in-use-bytes":23728128,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-30T02:41:48.028318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":951015425,"revision":19046,"compact-revision":17236}