{"level":"warn","ts":"2026-05-21T02:10:26.381295Z","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-21T02:10:26.381455Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-21T02:10:26.381559Z","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-21T02:10:26.381596Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-21T02:10:26.381713Z","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-21T02:10:26.382558Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-05-21T02:10:26.38269Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-21T02:10:26.387546Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.588187ms"} {"level":"info","ts":"2026-05-21T02:10:26.399236Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-05-21T02:10:26.399432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T02:10:26.399466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-05-21T02:10:26.399482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T02:10:26.399516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-05-21T02:10:26.399608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-05-21T02:10:26.405916Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T02:10:26.406998Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T02:10:26.408041Z","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-21T02:10:26.410435Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T02:10:26.410771Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T02:10:26.411077Z","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-21T02:10:26.411118Z","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-21T02:10:26.41113Z","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-21T02:10:26.412494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-05-21T02:10:26.413025Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-21T02:10:26.416317Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-21T02:10:26.416349Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-21T02:10:26.416286Z","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-21T02:10:26.416644Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T02:10:26.416691Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T02:10:26.800032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T02:10:26.800102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T02:10:26.800175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-05-21T02:10:26.800202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-05-21T02:10:26.800223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-21T02:10:26.800245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-05-21T02:10:26.800297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-21T02:10:26.809533Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T02:10:26.809547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T02:10:26.809655Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T02:10:26.809935Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T02:10:26.810068Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T02:10:26.809571Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:10:26.811009Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:10:26.811172Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:10:26.811246Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:10:26.816197Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-21T02:10:26.816456Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"warn","ts":"2026-05-21T02:10:29.660668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.202014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-21T02:10:29.660802Z","caller":"traceutil/trace.go:171","msg":"trace[792607420] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"267.46345ms","start":"2026-05-21T02:10:29.393321Z","end":"2026-05-21T02:10:29.660784Z","steps":["trace[792607420] 'read index received' (duration: 114.414806ms)","trace[792607420] 'applied index is now lower than readState.Index' (duration: 153.047244ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:10:29.660854Z","caller":"traceutil/trace.go:171","msg":"trace[1686251623] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"267.850714ms","start":"2026-05-21T02:10:29.392951Z","end":"2026-05-21T02:10:29.660801Z","steps":["trace[1686251623] 'process raft request' (duration: 114.82153ms)","trace[1686251623] 'compare' (duration: 152.038092ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:10:29.661012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.22291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T02:10:29.66105Z","caller":"traceutil/trace.go:171","msg":"trace[1853070082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"225.293551ms","start":"2026-05-21T02:10:29.435747Z","end":"2026-05-21T02:10:29.66104Z","steps":["trace[1853070082] 'agreement among raft nodes before linearized reading' (duration: 225.158349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:10:29.661033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.703383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T02:10:29.661209Z","caller":"traceutil/trace.go:171","msg":"trace[840381389] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:73; }","duration":"267.920006ms","start":"2026-05-21T02:10:29.393269Z","end":"2026-05-21T02:10:29.661189Z","steps":["trace[840381389] 'agreement among raft nodes before linearized reading' (duration: 267.616402ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:10:35.93877Z","caller":"traceutil/trace.go:171","msg":"trace[1195888062] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:333; }","duration":"120.530308ms","start":"2026-05-21T02:10:35.818219Z","end":"2026-05-21T02:10:35.938749Z","steps":["trace[1195888062] 'read index received' (duration: 51.143146ms)","trace[1195888062] 'applied index is now lower than readState.Index' (duration: 69.386002ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:10:35.938832Z","caller":"traceutil/trace.go:171","msg":"trace[1414548241] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"157.039679ms","start":"2026-05-21T02:10:35.781768Z","end":"2026-05-21T02:10:35.938807Z","steps":["trace[1414548241] 'process raft request' (duration: 87.667817ms)","trace[1414548241] 'compare' (duration: 69.20663ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:10:35.938986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.75785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-21T02:10:35.939031Z","caller":"traceutil/trace.go:171","msg":"trace[1193401218] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:324; }","duration":"120.862332ms","start":"2026-05-21T02:10:35.818156Z","end":"2026-05-21T02:10:35.939018Z","steps":["trace[1193401218] 'agreement among raft nodes before linearized reading' (duration: 120.73583ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:11:09.64605Z","caller":"traceutil/trace.go:171","msg":"trace[212716032] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"252.634037ms","start":"2026-05-21T02:11:09.393391Z","end":"2026-05-21T02:11:09.646025Z","steps":["trace[212716032] 'process raft request' (duration: 252.467766ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:11:09.646227Z","caller":"traceutil/trace.go:171","msg":"trace[228030065] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"227.917943ms","start":"2026-05-21T02:11:09.418078Z","end":"2026-05-21T02:11:09.645996Z","steps":["trace[228030065] 'read index received' (duration: 227.838912ms)","trace[228030065] 'applied index is now lower than readState.Index' (duration: 78.211µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:11:09.646349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.244295ms","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-21T02:11:09.646387Z","caller":"traceutil/trace.go:171","msg":"trace[1208979265] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:638; }","duration":"228.322315ms","start":"2026-05-21T02:11:09.418051Z","end":"2026-05-21T02:11:09.646373Z","steps":["trace[1208979265] 'agreement among raft nodes before linearized reading' (duration: 228.234775ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:11:09.66686Z","caller":"traceutil/trace.go:171","msg":"trace[1924681640] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"173.413331ms","start":"2026-05-21T02:11:09.493427Z","end":"2026-05-21T02:11:09.66684Z","steps":["trace[1924681640] 'process raft request' (duration: 171.127774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:09.667298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.116223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:09.667335Z","caller":"traceutil/trace.go:171","msg":"trace[287608886] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:640; }","duration":"249.206234ms","start":"2026-05-21T02:11:09.418117Z","end":"2026-05-21T02:11:09.667324Z","steps":["trace[287608886] 'agreement among raft nodes before linearized reading' (duration: 249.113203ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:11:09.667456Z","caller":"traceutil/trace.go:171","msg":"trace[1497396374] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"149.314421ms","start":"2026-05-21T02:11:09.518132Z","end":"2026-05-21T02:11:09.667447Z","steps":["trace[1497396374] 'process raft request' (duration: 148.645346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:09.667588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.92392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:09.667616Z","caller":"traceutil/trace.go:171","msg":"trace[1706363610] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:640; }","duration":"225.961661ms","start":"2026-05-21T02:11:09.441646Z","end":"2026-05-21T02:11:09.667607Z","steps":["trace[1706363610] 'agreement among raft nodes before linearized reading' (duration: 225.90368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:09.667776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.127522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:09.667815Z","caller":"traceutil/trace.go:171","msg":"trace[1758015563] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:640; }","duration":"226.216222ms","start":"2026-05-21T02:11:09.441588Z","end":"2026-05-21T02:11:09.667804Z","steps":["trace[1758015563] 'agreement among raft nodes before linearized reading' (duration: 226.149232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:09.667879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.981941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T02:11:09.667837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.395568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T02:11:09.667934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.012292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:09.667956Z","caller":"traceutil/trace.go:171","msg":"trace[622000217] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:640; }","duration":"202.049532ms","start":"2026-05-21T02:11:09.465901Z","end":"2026-05-21T02:11:09.66795Z","steps":["trace[622000217] 'agreement among raft nodes before linearized reading' (duration: 202.018132ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:11:09.667957Z","caller":"traceutil/trace.go:171","msg":"trace[436451449] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:640; }","duration":"248.550339ms","start":"2026-05-21T02:11:09.419383Z","end":"2026-05-21T02:11:09.667933Z","steps":["trace[436451449] 'agreement among raft nodes before linearized reading' (duration: 248.321417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:09.668071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.214263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:09.667907Z","caller":"traceutil/trace.go:171","msg":"trace[565585807] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:640; }","duration":"202.024852ms","start":"2026-05-21T02:11:09.465875Z","end":"2026-05-21T02:11:09.6679Z","steps":["trace[565585807] 'agreement among raft nodes before linearized reading' (duration: 201.984561ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:11:09.668121Z","caller":"traceutil/trace.go:171","msg":"trace[356152405] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:640; }","duration":"202.295973ms","start":"2026-05-21T02:11:09.465815Z","end":"2026-05-21T02:11:09.668111Z","steps":["trace[356152405] 'agreement among raft nodes before linearized reading' (duration: 202.231563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:09.668379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.465186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:09.668464Z","caller":"traceutil/trace.go:171","msg":"trace[1855436128] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:640; }","duration":"225.588757ms","start":"2026-05-21T02:11:09.442853Z","end":"2026-05-21T02:11:09.668442Z","steps":["trace[1855436128] 'agreement among raft nodes before linearized reading' (duration: 224.656861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:11:28.904916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.298672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:11:28.905023Z","caller":"traceutil/trace.go:171","msg":"trace[1576980793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"136.461844ms","start":"2026-05-21T02:11:28.768536Z","end":"2026-05-21T02:11:28.904998Z","steps":["trace[1576980793] 'range keys from in-memory index tree' (duration: 136.154772ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:12:02.83899Z","caller":"traceutil/trace.go:171","msg":"trace[327406057] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"203.535556ms","start":"2026-05-21T02:12:02.635431Z","end":"2026-05-21T02:12:02.838967Z","steps":["trace[327406057] 'process raft request' (duration: 203.348538ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:12:02.841254Z","caller":"traceutil/trace.go:171","msg":"trace[567536223] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"205.481364ms","start":"2026-05-21T02:12:02.63576Z","end":"2026-05-21T02:12:02.841241Z","steps":["trace[567536223] 'process raft request' (duration: 205.283397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:12:47.969783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.383887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5589167-41e7-46b5-8153-67e575b57c9a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-21T02:12:47.969851Z","caller":"traceutil/trace.go:171","msg":"trace[1926070933] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5589167-41e7-46b5-8153-67e575b57c9a; range_end:; response_count:1; response_revision:1855; }","duration":"428.474909ms","start":"2026-05-21T02:12:47.541363Z","end":"2026-05-21T02:12:47.969838Z","steps":["trace[1926070933] 'range keys from in-memory index tree' (duration: 428.242584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:12:47.96988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:12:47.541357Z","time spent":"428.51743ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5589167-41e7-46b5-8153-67e575b57c9a\" "} {"level":"warn","ts":"2026-05-21T02:12:47.970346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.872236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:12:47.970394Z","caller":"traceutil/trace.go:171","msg":"trace[2143466443] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"351.982595ms","start":"2026-05-21T02:12:47.618404Z","end":"2026-05-21T02:12:47.970387Z","steps":["trace[2143466443] 'read index received' (duration: 168.955735ms)","trace[2143466443] 'applied index is now lower than readState.Index' (duration: 183.02616ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:12:47.970449Z","caller":"traceutil/trace.go:171","msg":"trace[839080913] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"421.261926ms","start":"2026-05-21T02:12:47.54918Z","end":"2026-05-21T02:12:47.970442Z","steps":["trace[839080913] 'process raft request' (duration: 238.169365ms)","trace[839080913] 'compare' (duration: 182.306484ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:12:47.970444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.726831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-21T02:12:47.970564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.160589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T02:12:47.970591Z","caller":"traceutil/trace.go:171","msg":"trace[702010574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1856; }","duration":"352.20551ms","start":"2026-05-21T02:12:47.618377Z","end":"2026-05-21T02:12:47.970583Z","steps":["trace[702010574] 'agreement among raft nodes before linearized reading' (duration: 352.137519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:12:47.97061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:12:47.618366Z","time spent":"352.240941ms","remote":"127.0.0.1:52550","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-21T02:12:47.97055Z","caller":"traceutil/trace.go:171","msg":"trace[378659193] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1855; }","duration":"431.892865ms","start":"2026-05-21T02:12:47.538635Z","end":"2026-05-21T02:12:47.970527Z","steps":["trace[378659193] 'range keys from in-memory index tree' (duration: 430.984585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:12:47.970719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:12:47.538615Z","time spent":"432.097309ms","remote":"127.0.0.1:48484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-21T02:12:47.970486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:12:47.549159Z","time spent":"421.308468ms","remote":"127.0.0.1:52550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:12:47.970534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.763162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T02:12:47.97194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.698685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T02:12:47.971974Z","caller":"traceutil/trace.go:171","msg":"trace[527640610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1856; }","duration":"154.766457ms","start":"2026-05-21T02:12:47.817198Z","end":"2026-05-21T02:12:47.971964Z","steps":["trace[527640610] 'agreement among raft nodes before linearized reading' (duration: 153.386717ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:12:47.971777Z","caller":"traceutil/trace.go:171","msg":"trace[370681230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1856; }","duration":"204.04382ms","start":"2026-05-21T02:12:47.76771Z","end":"2026-05-21T02:12:47.971754Z","steps":["trace[370681230] 'agreement among raft nodes before linearized reading' (duration: 202.761062ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:12:48.128855Z","caller":"traceutil/trace.go:171","msg":"trace[734905185] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"152.091842ms","start":"2026-05-21T02:12:47.976725Z","end":"2026-05-21T02:12:48.128817Z","steps":["trace[734905185] 'process raft request' (duration: 152.01845ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:12:48.12886Z","caller":"traceutil/trace.go:171","msg":"trace[1135764242] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"153.523414ms","start":"2026-05-21T02:12:47.975311Z","end":"2026-05-21T02:12:48.128834Z","steps":["trace[1135764242] 'process raft request' (duration: 105.100999ms)","trace[1135764242] 'compare' (duration: 48.166979ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:12:48.595707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.958561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:12:48.595963Z","caller":"traceutil/trace.go:171","msg":"trace[1714460125] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"225.515146ms","start":"2026-05-21T02:12:48.370427Z","end":"2026-05-21T02:12:48.595942Z","steps":["trace[1714460125] 'read index received' (duration: 88.156056ms)","trace[1714460125] 'applied index is now lower than readState.Index' (duration: 137.35717ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:12:48.596004Z","caller":"traceutil/trace.go:171","msg":"trace[715298050] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"450.959612ms","start":"2026-05-21T02:12:48.145007Z","end":"2026-05-21T02:12:48.595967Z","steps":["trace[715298050] 'process raft request' (duration: 313.656824ms)","trace[715298050] 'compare' (duration: 136.711755ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:12:48.596185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.738061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5589167-41e7-46b5-8153-67e575b57c9a\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-05-21T02:12:48.596278Z","caller":"traceutil/trace.go:171","msg":"trace[1713171228] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5589167-41e7-46b5-8153-67e575b57c9a; range_end:; response_count:1; response_revision:1860; }","duration":"225.888165ms","start":"2026-05-21T02:12:48.37037Z","end":"2026-05-21T02:12:48.596258Z","steps":["trace[1713171228] 'agreement among raft nodes before linearized reading' (duration: 225.622239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:12:48.596448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:12:48.144982Z","time spent":"451.213567ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:12:48.596612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.258486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-21T02:12:48.596692Z","caller":"traceutil/trace.go:171","msg":"trace[1652748848] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1860; }","duration":"105.39817ms","start":"2026-05-21T02:12:48.491275Z","end":"2026-05-21T02:12:48.596674Z","steps":["trace[1652748848] 'agreement among raft nodes before linearized reading' (duration: 105.109963ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:13:03.933387Z","caller":"traceutil/trace.go:171","msg":"trace[456210306] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"106.203547ms","start":"2026-05-21T02:13:03.82715Z","end":"2026-05-21T02:13:03.933354Z","steps":["trace[456210306] 'process raft request' (duration: 105.754928ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:13:04.541377Z","caller":"traceutil/trace.go:171","msg":"trace[1727535868] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"112.93362ms","start":"2026-05-21T02:13:04.428397Z","end":"2026-05-21T02:13:04.541331Z","steps":["trace[1727535868] 'process raft request' (duration: 112.177726ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:13:27.470486Z","caller":"traceutil/trace.go:171","msg":"trace[941286078] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"133.455981ms","start":"2026-05-21T02:13:27.336973Z","end":"2026-05-21T02:13:27.470429Z","steps":["trace[941286078] 'process raft request' (duration: 127.083777ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:13:27.511489Z","caller":"traceutil/trace.go:171","msg":"trace[2005724321] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2210; }","duration":"124.228541ms","start":"2026-05-21T02:13:27.387235Z","end":"2026-05-21T02:13:27.511464Z","steps":["trace[2005724321] 'read index received' (duration: 76.834673ms)","trace[2005724321] 'applied index is now lower than readState.Index' (duration: 47.392648ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:13:27.511639Z","caller":"traceutil/trace.go:171","msg":"trace[727417676] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"174.617898ms","start":"2026-05-21T02:13:27.337006Z","end":"2026-05-21T02:13:27.511624Z","steps":["trace[727417676] 'process raft request' (duration: 174.259832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:13:27.511808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.562766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-05-21T02:13:27.511877Z","caller":"traceutil/trace.go:171","msg":"trace[877700812] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2130; }","duration":"124.675548ms","start":"2026-05-21T02:13:27.387183Z","end":"2026-05-21T02:13:27.511858Z","steps":["trace[877700812] 'agreement among raft nodes before linearized reading' (duration: 124.505635ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:13:28.284816Z","caller":"traceutil/trace.go:171","msg":"trace[1775123913] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"117.942334ms","start":"2026-05-21T02:13:28.166846Z","end":"2026-05-21T02:13:28.284788Z","steps":["trace[1775123913] 'process raft request' (duration: 117.775902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:14:50.919726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.133971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:14:50.919841Z","caller":"traceutil/trace.go:171","msg":"trace[1246703516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2689; }","duration":"151.339853ms","start":"2026-05-21T02:14:50.768475Z","end":"2026-05-21T02:14:50.919815Z","steps":["trace[1246703516] 'range keys from in-memory index tree' (duration: 151.03597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:14:50.919946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.454499ms","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-21T02:14:50.920073Z","caller":"traceutil/trace.go:171","msg":"trace[818081502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2689; }","duration":"113.59256ms","start":"2026-05-21T02:14:50.806448Z","end":"2026-05-21T02:14:50.920041Z","steps":["trace[818081502] 'range keys from in-memory index tree' (duration: 113.258577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:14:50.919883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.982972ms","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-21T02:14:50.920815Z","caller":"traceutil/trace.go:171","msg":"trace[1686452546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2689; }","duration":"209.982395ms","start":"2026-05-21T02:14:50.710815Z","end":"2026-05-21T02:14:50.920797Z","steps":["trace[1686452546] 'range keys from in-memory index tree' (duration: 208.667569ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:26.57939Z","caller":"traceutil/trace.go:171","msg":"trace[2049050106] linearizableReadLoop","detail":"{readStateIndex:4719; appliedIndex:4718; }","duration":"267.532279ms","start":"2026-05-21T02:18:26.311839Z","end":"2026-05-21T02:18:26.579371Z","steps":["trace[2049050106] 'read index received' (duration: 267.502178ms)","trace[2049050106] 'applied index is now lower than readState.Index' (duration: 29.191µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:18:26.579488Z","caller":"traceutil/trace.go:171","msg":"trace[1415369576] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"309.074073ms","start":"2026-05-21T02:18:26.270404Z","end":"2026-05-21T02:18:26.579478Z","steps":["trace[1415369576] 'process raft request' (duration: 308.850009ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.579595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.270386Z","time spent":"309.126284ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14481,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:18:26.580634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.787891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2196733"} {"level":"info","ts":"2026-05-21T02:18:26.580675Z","caller":"traceutil/trace.go:171","msg":"trace[1032649147] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4547; }","duration":"268.861263ms","start":"2026-05-21T02:18:26.311804Z","end":"2026-05-21T02:18:26.580665Z","steps":["trace[1032649147] 'agreement among raft nodes before linearized reading' (duration: 267.888165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.909032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.224651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:18:26.909383Z","caller":"traceutil/trace.go:171","msg":"trace[1236732199] transaction","detail":"{read_only:false; response_revision:4548; number_of_response:1; }","duration":"392.08513ms","start":"2026-05-21T02:18:26.517259Z","end":"2026-05-21T02:18:26.909344Z","steps":["trace[1236732199] 'process raft request' (duration: 273.467352ms)","trace[1236732199] 'compare' (duration: 118.094949ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:18:26.909459Z","caller":"traceutil/trace.go:171","msg":"trace[1347131982] linearizableReadLoop","detail":"{readStateIndex:4720; appliedIndex:4719; }","duration":"329.990697ms","start":"2026-05-21T02:18:26.579458Z","end":"2026-05-21T02:18:26.909449Z","steps":["trace[1347131982] 'read index received' (duration: 211.337799ms)","trace[1347131982] 'applied index is now lower than readState.Index' (duration: 118.651768ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:18:26.909569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.517234Z","time spent":"392.240263ms","remote":"127.0.0.1:52550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:18:26.9097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.182586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:18:26.909787Z","caller":"traceutil/trace.go:171","msg":"trace[583437121] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:4549; }","duration":"497.41131ms","start":"2026-05-21T02:18:26.412364Z","end":"2026-05-21T02:18:26.909775Z","steps":["trace[583437121] 'agreement among raft nodes before linearized reading' (duration: 497.155415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.909835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.412311Z","time spent":"497.509351ms","remote":"127.0.0.1:48392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"info","ts":"2026-05-21T02:18:26.909411Z","caller":"traceutil/trace.go:171","msg":"trace[920554735] transaction","detail":"{read_only:false; response_revision:4549; number_of_response:1; }","duration":"324.686271ms","start":"2026-05-21T02:18:26.584502Z","end":"2026-05-21T02:18:26.909188Z","steps":["trace[920554735] 'process raft request' (duration: 324.63241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.90996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.584477Z","time spent":"325.436425ms","remote":"127.0.0.1:52394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":800,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T02:18:26.909999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.408674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T02:18:26.910025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.753882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-21T02:18:26.910086Z","caller":"traceutil/trace.go:171","msg":"trace[1021967101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4549; }","duration":"142.619128ms","start":"2026-05-21T02:18:26.767456Z","end":"2026-05-21T02:18:26.910075Z","steps":["trace[1021967101] 'agreement among raft nodes before linearized reading' (duration: 142.330013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.910496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.302055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-21T02:18:26.910586Z","caller":"traceutil/trace.go:171","msg":"trace[845991086] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4549; }","duration":"319.452517ms","start":"2026-05-21T02:18:26.59111Z","end":"2026-05-21T02:18:26.910562Z","steps":["trace[845991086] 'agreement among raft nodes before linearized reading' (duration: 318.44409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.91064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.591095Z","time spent":"319.533248ms","remote":"127.0.0.1:52466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-05-21T02:18:26.910824Z","caller":"traceutil/trace.go:171","msg":"trace[1531855210] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4549; }","duration":"301.018137ms","start":"2026-05-21T02:18:26.609168Z","end":"2026-05-21T02:18:26.910186Z","steps":["trace[1531855210] 'agreement among raft nodes before linearized reading' (duration: 300.397176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.910905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.609141Z","time spent":"301.745359ms","remote":"127.0.0.1:52412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1840,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-05-21T02:18:26.910834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.645581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14496"} {"level":"info","ts":"2026-05-21T02:18:26.911025Z","caller":"traceutil/trace.go:171","msg":"trace[274074278] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4549; }","duration":"319.843774ms","start":"2026-05-21T02:18:26.591164Z","end":"2026-05-21T02:18:26.911008Z","steps":["trace[274074278] 'agreement among raft nodes before linearized reading' (duration: 319.425327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:26.911058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:18:26.591161Z","time spent":"319.885745ms","remote":"127.0.0.1:52484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":14519,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-05-21T02:18:33.006452Z","caller":"traceutil/trace.go:171","msg":"trace[196000756] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"137.688341ms","start":"2026-05-21T02:18:32.86873Z","end":"2026-05-21T02:18:33.006418Z","steps":["trace[196000756] 'process raft request' (duration: 137.373485ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.006516Z","caller":"traceutil/trace.go:171","msg":"trace[547265125] linearizableReadLoop","detail":"{readStateIndex:4818; appliedIndex:4818; }","duration":"126.172898ms","start":"2026-05-21T02:18:32.880322Z","end":"2026-05-21T02:18:33.006495Z","steps":["trace[547265125] 'read index received' (duration: 126.167708ms)","trace[547265125] 'applied index is now lower than readState.Index' (duration: 4.57µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:18:33.006814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.483763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-21T02:18:33.00685Z","caller":"traceutil/trace.go:171","msg":"trace[393581084] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4644; }","duration":"126.532404ms","start":"2026-05-21T02:18:32.880308Z","end":"2026-05-21T02:18:33.00684Z","steps":["trace[393581084] 'agreement among raft nodes before linearized reading' (duration: 126.31647ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.165096Z","caller":"traceutil/trace.go:171","msg":"trace[588362659] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"229.599847ms","start":"2026-05-21T02:18:32.935466Z","end":"2026-05-21T02:18:33.165065Z","steps":["trace[588362659] 'process raft request' (duration: 229.532766ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.165525Z","caller":"traceutil/trace.go:171","msg":"trace[1918065272] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"284.261031ms","start":"2026-05-21T02:18:32.881251Z","end":"2026-05-21T02:18:33.165512Z","steps":["trace[1918065272] 'process raft request' (duration: 283.530569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.16608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.729396ms","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-21T02:18:33.166168Z","caller":"traceutil/trace.go:171","msg":"trace[960450824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4646; }","duration":"217.885279ms","start":"2026-05-21T02:18:32.948263Z","end":"2026-05-21T02:18:33.166148Z","steps":["trace[960450824] 'agreement among raft nodes before linearized reading' (duration: 217.682626ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.166732Z","caller":"traceutil/trace.go:171","msg":"trace[771018732] linearizableReadLoop","detail":"{readStateIndex:4820; appliedIndex:4820; }","duration":"160.14329ms","start":"2026-05-21T02:18:33.006565Z","end":"2026-05-21T02:18:33.166708Z","steps":["trace[771018732] 'read index received' (duration: 158.593493ms)","trace[771018732] 'applied index is now lower than readState.Index' (duration: 9.38µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:18:33.212985Z","caller":"traceutil/trace.go:171","msg":"trace[676117109] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"188.250605ms","start":"2026-05-21T02:18:33.024714Z","end":"2026-05-21T02:18:33.212965Z","steps":["trace[676117109] 'process raft request' (duration: 188.202184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.21318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.374474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-21T02:18:33.213242Z","caller":"traceutil/trace.go:171","msg":"trace[1767418361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4649; }","duration":"164.463927ms","start":"2026-05-21T02:18:33.048758Z","end":"2026-05-21T02:18:33.213222Z","steps":["trace[1767418361] 'agreement among raft nodes before linearized reading' (duration: 164.261353ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.213253Z","caller":"traceutil/trace.go:171","msg":"trace[157715118] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"201.887096ms","start":"2026-05-21T02:18:33.011337Z","end":"2026-05-21T02:18:33.213224Z","steps":["trace[157715118] 'process raft request' (duration: 201.445418ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.213277Z","caller":"traceutil/trace.go:171","msg":"trace[310764960] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"200.886448ms","start":"2026-05-21T02:18:33.012381Z","end":"2026-05-21T02:18:33.213267Z","steps":["trace[310764960] 'process raft request' (duration: 200.500702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.213459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.259645ms","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-21T02:18:33.21348Z","caller":"traceutil/trace.go:171","msg":"trace[11175008] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4649; }","duration":"159.293906ms","start":"2026-05-21T02:18:33.054181Z","end":"2026-05-21T02:18:33.213475Z","steps":["trace[11175008] 'agreement among raft nodes before linearized reading' (duration: 159.230155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.213766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.512637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-21T02:18:33.213807Z","caller":"traceutil/trace.go:171","msg":"trace[1882468394] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4649; }","duration":"202.597208ms","start":"2026-05-21T02:18:33.011195Z","end":"2026-05-21T02:18:33.213793Z","steps":["trace[1882468394] 'agreement among raft nodes before linearized reading' (duration: 202.438985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.214627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.759068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2196733"} {"level":"info","ts":"2026-05-21T02:18:33.214741Z","caller":"traceutil/trace.go:171","msg":"trace[935908945] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4649; }","duration":"191.901861ms","start":"2026-05-21T02:18:33.022814Z","end":"2026-05-21T02:18:33.214715Z","steps":["trace[935908945] 'agreement among raft nodes before linearized reading' (duration: 190.266131ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.332506Z","caller":"traceutil/trace.go:171","msg":"trace[618168260] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"105.863995ms","start":"2026-05-21T02:18:33.226618Z","end":"2026-05-21T02:18:33.332482Z","steps":["trace[618168260] 'process raft request' (duration: 105.432456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.333054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.790998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-59b59658b5-ljb2m.18b17320ba5181bc\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-05-21T02:18:33.333139Z","caller":"traceutil/trace.go:171","msg":"trace[1391683097] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-59b59658b5-ljb2m.18b17320ba5181bc; range_end:; response_count:1; response_revision:4655; }","duration":"103.90241ms","start":"2026-05-21T02:18:33.229217Z","end":"2026-05-21T02:18:33.333119Z","steps":["trace[1391683097] 'agreement among raft nodes before linearized reading' (duration: 103.663256ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.598593Z","caller":"traceutil/trace.go:171","msg":"trace[2060987336] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"116.568344ms","start":"2026-05-21T02:18:33.481998Z","end":"2026-05-21T02:18:33.598566Z","steps":["trace[2060987336] 'process raft request' (duration: 116.463472ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.598902Z","caller":"traceutil/trace.go:171","msg":"trace[110804936] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"117.272296ms","start":"2026-05-21T02:18:33.481596Z","end":"2026-05-21T02:18:33.598868Z","steps":["trace[110804936] 'process raft request' (duration: 97.788093ms)","trace[110804936] 'compare' (duration: 18.924973ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:18:33.599065Z","caller":"traceutil/trace.go:171","msg":"trace[1498124010] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"116.888969ms","start":"2026-05-21T02:18:33.482165Z","end":"2026-05-21T02:18:33.599054Z","steps":["trace[1498124010] 'process raft request' (duration: 116.36207ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.599194Z","caller":"traceutil/trace.go:171","msg":"trace[1008616663] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"116.875829ms","start":"2026-05-21T02:18:33.48229Z","end":"2026-05-21T02:18:33.599166Z","steps":["trace[1008616663] 'process raft request' (duration: 116.602674ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.599347Z","caller":"traceutil/trace.go:171","msg":"trace[1690161820] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"102.981944ms","start":"2026-05-21T02:18:33.496297Z","end":"2026-05-21T02:18:33.599279Z","steps":["trace[1690161820] 'process raft request' (duration: 102.75062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.599643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.250833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-05-21T02:18:33.599693Z","caller":"traceutil/trace.go:171","msg":"trace[1923035494] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4676; }","duration":"118.324024ms","start":"2026-05-21T02:18:33.481357Z","end":"2026-05-21T02:18:33.599681Z","steps":["trace[1923035494] 'agreement among raft nodes before linearized reading' (duration: 118.148171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.599648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.347574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-05-21T02:18:33.599836Z","caller":"traceutil/trace.go:171","msg":"trace[472677932] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4676; }","duration":"118.562547ms","start":"2026-05-21T02:18:33.481264Z","end":"2026-05-21T02:18:33.599827Z","steps":["trace[472677932] 'agreement among raft nodes before linearized reading' (duration: 118.259442ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.760655Z","caller":"traceutil/trace.go:171","msg":"trace[1229160114] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"123.201699ms","start":"2026-05-21T02:18:33.637407Z","end":"2026-05-21T02:18:33.760608Z","steps":["trace[1229160114] 'process raft request' (duration: 64.099528ms)","trace[1229160114] 'compare' (duration: 58.059513ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:18:33.760961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.957815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"} {"level":"info","ts":"2026-05-21T02:18:33.76106Z","caller":"traceutil/trace.go:171","msg":"trace[780996859] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4682; }","duration":"123.087588ms","start":"2026-05-21T02:18:33.637957Z","end":"2026-05-21T02:18:33.761044Z","steps":["trace[780996859] 'agreement among raft nodes before linearized reading' (duration: 122.758093ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:18:33.760702Z","caller":"traceutil/trace.go:171","msg":"trace[1453310757] linearizableReadLoop","detail":"{readStateIndex:4856; appliedIndex:4855; }","duration":"109.227124ms","start":"2026-05-21T02:18:33.651398Z","end":"2026-05-21T02:18:33.760625Z","steps":["trace[1453310757] 'read index received' (duration: 50.077072ms)","trace[1453310757] 'applied index is now lower than readState.Index' (duration: 59.146632ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:18:33.76136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.183535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-05-21T02:18:33.762498Z","caller":"traceutil/trace.go:171","msg":"trace[1143521487] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4682; }","duration":"126.359425ms","start":"2026-05-21T02:18:33.636117Z","end":"2026-05-21T02:18:33.762477Z","steps":["trace[1143521487] 'agreement among raft nodes before linearized reading' (duration: 125.022502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:18:33.763159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.463222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-05-21T02:18:33.763308Z","caller":"traceutil/trace.go:171","msg":"trace[928305968] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4682; }","duration":"107.624305ms","start":"2026-05-21T02:18:33.655641Z","end":"2026-05-21T02:18:33.763265Z","steps":["trace[928305968] 'agreement among raft nodes before linearized reading' (duration: 107.37083ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:20:27.14446Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879} {"level":"info","ts":"2026-05-21T02:20:27.216397Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"70.441646ms","hash":3122713291,"current-db-size-bytes":53460992,"current-db-size":"54 MB","current-db-size-in-use-bytes":29335552,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-21T02:20:27.216459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3122713291,"revision":2879,"compact-revision":-1} {"level":"info","ts":"2026-05-21T02:25:27.14876Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5641} {"level":"info","ts":"2026-05-21T02:25:27.248138Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5641,"took":"98.173908ms","hash":3740354286,"current-db-size-bytes":53460992,"current-db-size":"54 MB","current-db-size-in-use-bytes":18231296,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-21T02:25:27.248179Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3740354286,"revision":5641,"compact-revision":2879}