{"level":"warn","ts":"2026-06-15T08:12:48.578736Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T08:12:48.578847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-06-15T08:12:48.578917Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T08:12:48.578925Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-06-15T08:12:48.578942Z","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-06-15T08:12:48.579559Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-06-15T08:12:48.579639Z","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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-06-15T08:12:48.583751Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.90538ms"} {"level":"info","ts":"2026-06-15T08:12:48.598217Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-06-15T08:12:48.598419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T08:12:48.598478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-06-15T08:12:48.598503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T08:12:48.598531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-06-15T08:12:48.598604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-06-15T08:12:48.606059Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T08:12:48.607851Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T08:12:48.609927Z","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-06-15T08:12:48.612469Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T08:12:48.612614Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T08:12:48.613052Z","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-06-15T08:12:48.613155Z","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-06-15T08:12:48.613177Z","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-06-15T08:12:48.613427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-06-15T08:12:48.613521Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-06-15T08:12:48.617052Z","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-06-15T08:12:48.617184Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-06-15T08:12:48.617236Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-06-15T08:12:48.617453Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T08:12:48.617516Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T08:12:48.899664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T08:12:48.899751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T08:12:48.899801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-06-15T08:12:48.89982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-06-15T08:12:48.899831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-06-15T08:12:48.899847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-06-15T08:12:48.89986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-06-15T08:12:48.901101Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T08:12:48.901276Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T08:12:48.901368Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T08:12:48.901696Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T08:12:48.90336Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T08:12:48.903473Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T08:12:48.903508Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T08:12:48.903542Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T08:12:48.90356Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T08:12:48.904676Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T08:12:48.905471Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-06-15T08:13:25.600591Z","caller":"traceutil/trace.go:171","msg":"trace[1846808733] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"107.124795ms","start":"2026-06-15T08:13:25.493445Z","end":"2026-06-15T08:13:25.60057Z","steps":["trace[1846808733] 'process raft request' (duration: 106.91441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:13:31.526316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.02531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:13:31.526482Z","caller":"traceutil/trace.go:171","msg":"trace[1577829819] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:579; }","duration":"161.284676ms","start":"2026-06-15T08:13:31.365175Z","end":"2026-06-15T08:13:31.52646Z","steps":["trace[1577829819] 'range keys from in-memory index tree' (duration: 160.930688ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:13:32.165352Z","caller":"traceutil/trace.go:171","msg":"trace[395408642] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"221.707843ms","start":"2026-06-15T08:13:31.943601Z","end":"2026-06-15T08:13:32.165309Z","steps":["trace[395408642] 'process raft request' (duration: 221.024237ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:13:32.845018Z","caller":"traceutil/trace.go:171","msg":"trace[1547114319] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"662.716972ms","start":"2026-06-15T08:13:32.182272Z","end":"2026-06-15T08:13:32.844988Z","steps":["trace[1547114319] 'process raft request' (duration: 611.929059ms)","trace[1547114319] 'compare' (duration: 49.569055ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:13:32.845438Z","caller":"traceutil/trace.go:171","msg":"trace[869227568] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"624.810176ms","start":"2026-06-15T08:13:32.220597Z","end":"2026-06-15T08:13:32.845407Z","steps":["trace[869227568] 'process raft request' (duration: 624.312984ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:13:32.845486Z","caller":"traceutil/trace.go:171","msg":"trace[1775037734] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:600; }","duration":"514.438045ms","start":"2026-06-15T08:13:32.330956Z","end":"2026-06-15T08:13:32.845394Z","steps":["trace[1775037734] 'read index received' (duration: 463.194101ms)","trace[1775037734] 'applied index is now lower than readState.Index' (duration: 51.240854ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:13:32.84559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:13:32.220568Z","time spent":"624.952249ms","remote":"127.0.0.1:55032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T08:13:32.845661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.697341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T08:13:32.845709Z","caller":"traceutil/trace.go:171","msg":"trace[345232401] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:583; }","duration":"514.793783ms","start":"2026-06-15T08:13:32.330902Z","end":"2026-06-15T08:13:32.845696Z","steps":["trace[345232401] 'agreement among raft nodes before linearized reading' (duration: 514.621079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:13:32.845696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:13:32.182243Z","time spent":"662.844574ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:13:32.845745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:13:32.33088Z","time spent":"514.857854ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"info","ts":"2026-06-15T08:13:34.409581Z","caller":"traceutil/trace.go:171","msg":"trace[1123398637] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"122.49141ms","start":"2026-06-15T08:13:34.28706Z","end":"2026-06-15T08:13:34.409551Z","steps":["trace[1123398637] 'process raft request' (duration: 122.352876ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:13:34.417376Z","caller":"traceutil/trace.go:171","msg":"trace[1363597251] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"122.970881ms","start":"2026-06-15T08:13:34.29438Z","end":"2026-06-15T08:13:34.417351Z","steps":["trace[1363597251] 'process raft request' (duration: 121.910087ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:13:47.388704Z","caller":"traceutil/trace.go:171","msg":"trace[264436761] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"256.098357ms","start":"2026-06-15T08:13:47.132575Z","end":"2026-06-15T08:13:47.388674Z","steps":["trace[264436761] 'read index received' (duration: 255.889382ms)","trace[264436761] 'applied index is now lower than readState.Index' (duration: 207.845µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:13:47.388761Z","caller":"traceutil/trace.go:171","msg":"trace[327143681] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"462.488305ms","start":"2026-06-15T08:13:46.926235Z","end":"2026-06-15T08:13:47.388723Z","steps":["trace[327143681] 'process raft request' (duration: 462.285171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:13:47.38889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.292551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:13:47.388938Z","caller":"traceutil/trace.go:171","msg":"trace[501651041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"256.386744ms","start":"2026-06-15T08:13:47.132538Z","end":"2026-06-15T08:13:47.388924Z","steps":["trace[501651041] 'agreement among raft nodes before linearized reading' (duration: 256.299822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:13:47.388979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.982045ms","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-06-15T08:13:47.389038Z","caller":"traceutil/trace.go:171","msg":"trace[627862005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"240.081287ms","start":"2026-06-15T08:13:47.148942Z","end":"2026-06-15T08:13:47.389023Z","steps":["trace[627862005] 'agreement among raft nodes before linearized reading' (duration: 239.930834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:13:47.389105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.539857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k7v46\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-15T08:13:47.389222Z","caller":"traceutil/trace.go:171","msg":"trace[686204872] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k7v46; range_end:; response_count:1; response_revision:754; }","duration":"140.704271ms","start":"2026-06-15T08:13:47.248493Z","end":"2026-06-15T08:13:47.389197Z","steps":["trace[686204872] 'agreement among raft nodes before linearized reading' (duration: 140.413944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:13:47.389442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:13:46.926192Z","time spent":"462.651969ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:14:16.122906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.156609ms","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-06-15T08:14:16.122985Z","caller":"traceutil/trace.go:171","msg":"trace[1679515835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1148; }","duration":"604.289761ms","start":"2026-06-15T08:14:15.518679Z","end":"2026-06-15T08:14:16.122969Z","steps":["trace[1679515835] 'range keys from in-memory index tree' (duration: 603.949094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:14:16.123017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:14:15.518659Z","time spent":"604.351993ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T08:14:16.123198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.320758ms","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-06-15T08:14:16.123285Z","caller":"traceutil/trace.go:171","msg":"trace[1250823876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1148; }","duration":"609.452611ms","start":"2026-06-15T08:14:15.513814Z","end":"2026-06-15T08:14:16.123267Z","steps":["trace[1250823876] 'range keys from in-memory index tree' (duration: 609.089352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:14:16.123234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.025248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T08:14:16.123279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.602454ms","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-06-15T08:14:16.123324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:14:15.513789Z","time spent":"609.526933ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-15T08:14:16.123358Z","caller":"traceutil/trace.go:171","msg":"trace[1371742980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1148; }","duration":"261.763968ms","start":"2026-06-15T08:14:15.861575Z","end":"2026-06-15T08:14:16.123339Z","steps":["trace[1371742980] 'range keys from in-memory index tree' (duration: 261.207665ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:14:16.123352Z","caller":"traceutil/trace.go:171","msg":"trace[1830199983] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1148; }","duration":"231.234003ms","start":"2026-06-15T08:14:15.892095Z","end":"2026-06-15T08:14:16.123329Z","steps":["trace[1830199983] 'count revisions from in-memory index tree' (duration: 230.889154ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:01.953668Z","caller":"traceutil/trace.go:171","msg":"trace[1809785715] linearizableReadLoop","detail":"{readStateIndex:1883; appliedIndex:1882; }","duration":"182.34589ms","start":"2026-06-15T08:15:01.771292Z","end":"2026-06-15T08:15:01.953638Z","steps":["trace[1809785715] 'read index received' (duration: 182.082904ms)","trace[1809785715] 'applied index is now lower than readState.Index' (duration: 261.886µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:15:01.953752Z","caller":"traceutil/trace.go:171","msg":"trace[1714260554] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"312.262343ms","start":"2026-06-15T08:15:01.641443Z","end":"2026-06-15T08:15:01.953706Z","steps":["trace[1714260554] 'process raft request' (duration: 311.923365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:01.953925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.617447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-846b7f62-0e3e-4b08-86c8-f0d42551d10c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-15T08:15:01.953971Z","caller":"traceutil/trace.go:171","msg":"trace[1357713021] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-846b7f62-0e3e-4b08-86c8-f0d42551d10c; range_end:; response_count:1; response_revision:1816; }","duration":"182.74063ms","start":"2026-06-15T08:15:01.771219Z","end":"2026-06-15T08:15:01.953959Z","steps":["trace[1357713021] 'agreement among raft nodes before linearized reading' (duration: 182.568776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:01.953958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:15:01.641411Z","time spent":"312.438006ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:15:01.954349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.21839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-15T08:15:01.954492Z","caller":"traceutil/trace.go:171","msg":"trace[1301824919] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1816; }","duration":"103.424416ms","start":"2026-06-15T08:15:01.851026Z","end":"2026-06-15T08:15:01.95445Z","steps":["trace[1301824919] 'agreement among raft nodes before linearized reading' (duration: 103.097698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:02.473512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.028576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T08:15:02.473595Z","caller":"traceutil/trace.go:171","msg":"trace[50662661] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1821; }","duration":"137.15406ms","start":"2026-06-15T08:15:02.336424Z","end":"2026-06-15T08:15:02.473578Z","steps":["trace[50662661] 'range keys from in-memory index tree' (duration: 136.813141ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:14.708921Z","caller":"traceutil/trace.go:171","msg":"trace[1419690464] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"136.446443ms","start":"2026-06-15T08:15:14.572455Z","end":"2026-06-15T08:15:14.708901Z","steps":["trace[1419690464] 'process raft request' (duration: 136.258749ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:14.813952Z","caller":"traceutil/trace.go:171","msg":"trace[582026233] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"241.347503ms","start":"2026-06-15T08:15:14.572573Z","end":"2026-06-15T08:15:14.81392Z","steps":["trace[582026233] 'process raft request' (duration: 240.452362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:14.814202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.101835ms","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-06-15T08:15:14.814301Z","caller":"traceutil/trace.go:171","msg":"trace[832515550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1924; }","duration":"237.223147ms","start":"2026-06-15T08:15:14.577057Z","end":"2026-06-15T08:15:14.81428Z","steps":["trace[832515550] 'agreement among raft nodes before linearized reading' (duration: 236.991152ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:14.814612Z","caller":"traceutil/trace.go:171","msg":"trace[727542770] linearizableReadLoop","detail":"{readStateIndex:1995; appliedIndex:1993; }","duration":"236.778458ms","start":"2026-06-15T08:15:14.577072Z","end":"2026-06-15T08:15:14.81385Z","steps":["trace[727542770] 'read index received' (duration: 131.677983ms)","trace[727542770] 'applied index is now lower than readState.Index' (duration: 105.099115ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:15:14.814868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.173781ms","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-06-15T08:15:14.814923Z","caller":"traceutil/trace.go:171","msg":"trace[1117406110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1924; }","duration":"205.295474ms","start":"2026-06-15T08:15:14.609613Z","end":"2026-06-15T08:15:14.814908Z","steps":["trace[1117406110] 'agreement among raft nodes before linearized reading' (duration: 205.087269ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:15.207984Z","caller":"traceutil/trace.go:171","msg":"trace[976747298] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"266.372125ms","start":"2026-06-15T08:15:14.941595Z","end":"2026-06-15T08:15:15.207968Z","steps":["trace[976747298] 'process raft request' (duration: 266.132519ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:15.207959Z","caller":"traceutil/trace.go:171","msg":"trace[607195974] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1997; }","duration":"211.680252ms","start":"2026-06-15T08:15:14.996248Z","end":"2026-06-15T08:15:15.207928Z","steps":["trace[607195974] 'read index received' (duration: 211.518728ms)","trace[607195974] 'applied index is now lower than readState.Index' (duration: 160.154µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:15:15.208204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.932287ms","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-06-15T08:15:15.208315Z","caller":"traceutil/trace.go:171","msg":"trace[1891043780] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1927; }","duration":"212.03664ms","start":"2026-06-15T08:15:14.996232Z","end":"2026-06-15T08:15:15.208269Z","steps":["trace[1891043780] 'agreement among raft nodes before linearized reading' (duration: 211.844485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:15.211918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.199909ms","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-06-15T08:15:15.211957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.123028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"info","ts":"2026-06-15T08:15:15.212006Z","caller":"traceutil/trace.go:171","msg":"trace[1689101031] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1928; }","duration":"152.19358ms","start":"2026-06-15T08:15:15.059801Z","end":"2026-06-15T08:15:15.211994Z","steps":["trace[1689101031] 'agreement among raft nodes before linearized reading' (duration: 152.072717ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:15.211997Z","caller":"traceutil/trace.go:171","msg":"trace[1922856945] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1928; }","duration":"164.317602ms","start":"2026-06-15T08:15:15.047656Z","end":"2026-06-15T08:15:15.211974Z","steps":["trace[1922856945] 'agreement among raft nodes before linearized reading' (duration: 164.079796ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:45.954885Z","caller":"traceutil/trace.go:171","msg":"trace[619002424] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"209.175279ms","start":"2026-06-15T08:15:45.745673Z","end":"2026-06-15T08:15:45.954849Z","steps":["trace[619002424] 'process raft request' (duration: 208.949064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:46.12834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.257913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T08:15:46.128443Z","caller":"traceutil/trace.go:171","msg":"trace[2086077944] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"351.065898ms","start":"2026-06-15T08:15:45.777359Z","end":"2026-06-15T08:15:46.128425Z","steps":["trace[2086077944] 'process raft request' (duration: 244.506248ms)","trace[2086077944] 'compare' (duration: 106.136831ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:15:46.128506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:15:45.777346Z","time spent":"351.129959ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:15:52.489712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.042665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T08:15:52.489793Z","caller":"traceutil/trace.go:171","msg":"trace[294673893] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:2142; }","duration":"152.178189ms","start":"2026-06-15T08:15:52.337596Z","end":"2026-06-15T08:15:52.489774Z","steps":["trace[294673893] 'range keys from in-memory index tree' (duration: 151.788399ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:53.038396Z","caller":"traceutil/trace.go:171","msg":"trace[1046308189] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"158.76833ms","start":"2026-06-15T08:15:52.879596Z","end":"2026-06-15T08:15:53.038365Z","steps":["trace[1046308189] 'process raft request' (duration: 155.932305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:53.43466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.915435ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T08:15:53.43479Z","caller":"traceutil/trace.go:171","msg":"trace[612372958] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"392.075269ms","start":"2026-06-15T08:15:53.04267Z","end":"2026-06-15T08:15:53.434745Z","steps":["trace[612372958] 'process raft request' (duration: 214.0054ms)","trace[612372958] 'compare' (duration: 177.625519ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:15:53.434851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:15:53.042648Z","time spent":"392.175252ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:15:53.56193Z","caller":"traceutil/trace.go:171","msg":"trace[330093198] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"519.191605ms","start":"2026-06-15T08:15:53.042703Z","end":"2026-06-15T08:15:53.561894Z","steps":["trace[330093198] 'process raft request' (duration: 504.175648ms)","trace[330093198] 'compare' (duration: 14.465595ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:15:53.562087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:15:53.04267Z","time spent":"519.334749ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:15:53.562593Z","caller":"traceutil/trace.go:171","msg":"trace[1235097077] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"519.624437ms","start":"2026-06-15T08:15:53.042954Z","end":"2026-06-15T08:15:53.562578Z","steps":["trace[1235097077] 'process raft request' (duration: 519.368771ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:15:53.562593Z","caller":"traceutil/trace.go:171","msg":"trace[1128173693] linearizableReadLoop","detail":"{readStateIndex:2227; appliedIndex:2224; }","duration":"429.58374ms","start":"2026-06-15T08:15:53.132977Z","end":"2026-06-15T08:15:53.562561Z","steps":["trace[1128173693] 'read index received' (duration: 123.779229ms)","trace[1128173693] 'applied index is now lower than readState.Index' (duration: 305.803461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:15:53.56267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:15:53.042928Z","time spent":"519.702668ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:15:53.563008Z","caller":"traceutil/trace.go:171","msg":"trace[761200217] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"229.142663ms","start":"2026-06-15T08:15:53.333834Z","end":"2026-06-15T08:15:53.562977Z","steps":["trace[761200217] 'process raft request' (duration: 228.684403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:53.563043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.05418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:15:53.563105Z","caller":"traceutil/trace.go:171","msg":"trace[55603652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2149; }","duration":"430.160803ms","start":"2026-06-15T08:15:53.132929Z","end":"2026-06-15T08:15:53.563089Z","steps":["trace[55603652] 'agreement among raft nodes before linearized reading' (duration: 429.722223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:15:53.563137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:15:53.132911Z","time spent":"430.219555ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T08:15:53.563158Z","caller":"traceutil/trace.go:171","msg":"trace[168889646] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"225.098518ms","start":"2026-06-15T08:15:53.338042Z","end":"2026-06-15T08:15:53.56314Z","steps":["trace[168889646] 'process raft request' (duration: 224.898663ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:16:47.883262Z","caller":"traceutil/trace.go:171","msg":"trace[912131769] transaction","detail":"{read_only:false; response_revision:2609; number_of_response:1; }","duration":"175.907525ms","start":"2026-06-15T08:16:47.7073Z","end":"2026-06-15T08:16:47.883208Z","steps":["trace[912131769] 'process raft request' (duration: 170.542441ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:16:47.904671Z","caller":"traceutil/trace.go:171","msg":"trace[1919860076] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"150.656453ms","start":"2026-06-15T08:16:47.75395Z","end":"2026-06-15T08:16:47.904606Z","steps":["trace[1919860076] 'process raft request' (duration: 150.54798ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:16:47.904746Z","caller":"traceutil/trace.go:171","msg":"trace[963420722] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"155.32441ms","start":"2026-06-15T08:16:47.749383Z","end":"2026-06-15T08:16:47.904707Z","steps":["trace[963420722] 'process raft request' (duration: 154.957022ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:16:47.904874Z","caller":"traceutil/trace.go:171","msg":"trace[1115961123] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"123.825472ms","start":"2026-06-15T08:16:47.781018Z","end":"2026-06-15T08:16:47.904844Z","steps":["trace[1115961123] 'process raft request' (duration: 123.516255ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:17:22.144558Z","caller":"traceutil/trace.go:171","msg":"trace[2003321124] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"134.51576ms","start":"2026-06-15T08:17:22.010018Z","end":"2026-06-15T08:17:22.144534Z","steps":["trace[2003321124] 'process raft request' (duration: 134.358065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:17:22.620364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.750923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T08:17:22.620863Z","caller":"traceutil/trace.go:171","msg":"trace[366489919] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"130.407394ms","start":"2026-06-15T08:17:22.490429Z","end":"2026-06-15T08:17:22.620836Z","steps":["trace[366489919] 'process raft request' (duration: 130.256451ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:17:22.620905Z","caller":"traceutil/trace.go:171","msg":"trace[1815718914] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"608.695512ms","start":"2026-06-15T08:17:22.012185Z","end":"2026-06-15T08:17:22.620881Z","steps":["trace[1815718914] 'process raft request' (duration: 345.323604ms)","trace[1815718914] 'compare' (duration: 262.61529ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:17:22.621021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:17:22.012179Z","time spent":"608.776174ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:17:22.621049Z","caller":"traceutil/trace.go:171","msg":"trace[1179647971] transaction","detail":"{read_only:false; response_revision:2818; number_of_response:1; }","duration":"607.847411ms","start":"2026-06-15T08:17:22.013172Z","end":"2026-06-15T08:17:22.62102Z","steps":["trace[1179647971] 'process raft request' (duration: 607.311318ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:17:22.621159Z","caller":"traceutil/trace.go:171","msg":"trace[1251001157] linearizableReadLoop","detail":"{readStateIndex:2923; appliedIndex:2920; }","duration":"575.204147ms","start":"2026-06-15T08:17:22.045935Z","end":"2026-06-15T08:17:22.621139Z","steps":["trace[1251001157] 'read index received' (duration: 98.462316ms)","trace[1251001157] 'applied index is now lower than readState.Index' (duration: 476.740631ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:17:22.621251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:17:22.013159Z","time spent":"607.996265ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:17:22.621358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.414332ms","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-06-15T08:17:22.621365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.48341ms","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-06-15T08:17:22.621412Z","caller":"traceutil/trace.go:171","msg":"trace[621196775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2819; }","duration":"575.489774ms","start":"2026-06-15T08:17:22.045897Z","end":"2026-06-15T08:17:22.621387Z","steps":["trace[621196775] 'agreement among raft nodes before linearized reading' (duration: 575.344391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:17:22.621454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:17:22.045879Z","time spent":"575.562275ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T08:17:22.621516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.516428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:17:22.621431Z","caller":"traceutil/trace.go:171","msg":"trace[1036172784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2819; }","duration":"574.572952ms","start":"2026-06-15T08:17:22.046844Z","end":"2026-06-15T08:17:22.621417Z","steps":["trace[1036172784] 'agreement among raft nodes before linearized reading' (duration: 574.428808ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:17:22.621575Z","caller":"traceutil/trace.go:171","msg":"trace[535837951] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2819; }","duration":"377.585358ms","start":"2026-06-15T08:17:22.243961Z","end":"2026-06-15T08:17:22.621546Z","steps":["trace[535837951] 'agreement among raft nodes before linearized reading' (duration: 377.511757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:17:22.621568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:17:22.046832Z","time spent":"574.726056ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T08:17:22.621639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:17:22.243943Z","time spent":"377.668741ms","remote":"127.0.0.1:51968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true "} {"level":"warn","ts":"2026-06-15T08:17:22.621513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.150923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T08:17:22.62173Z","caller":"traceutil/trace.go:171","msg":"trace[908947265] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:2819; }","duration":"279.400259ms","start":"2026-06-15T08:17:22.342305Z","end":"2026-06-15T08:17:22.621705Z","steps":["trace[908947265] 'agreement among raft nodes before linearized reading' (duration: 279.102972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:17:22.621765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.778256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.18b933332bd5aa68\" ","response":"range_response_count:1 size:765"} {"level":"warn","ts":"2026-06-15T08:17:22.621783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.628461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-15T08:17:22.621848Z","caller":"traceutil/trace.go:171","msg":"trace[574043135] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.18b933332bd5aa68; range_end:; response_count:1; response_revision:2819; }","duration":"134.916999ms","start":"2026-06-15T08:17:22.486912Z","end":"2026-06-15T08:17:22.621829Z","steps":["trace[574043135] 'agreement among raft nodes before linearized reading' (duration: 134.627902ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:17:22.621875Z","caller":"traceutil/trace.go:171","msg":"trace[1491910213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2819; }","duration":"570.736373ms","start":"2026-06-15T08:17:22.051118Z","end":"2026-06-15T08:17:22.621854Z","steps":["trace[1491910213] 'agreement among raft nodes before linearized reading' (duration: 570.547079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:17:22.621923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:17:22.051109Z","time spent":"570.801515ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T08:17:22.622554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.198007ms","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-06-15T08:17:22.6227Z","caller":"traceutil/trace.go:171","msg":"trace[1944180769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2819; }","duration":"142.422822ms","start":"2026-06-15T08:17:22.480249Z","end":"2026-06-15T08:17:22.622672Z","steps":["trace[1944180769] 'agreement among raft nodes before linearized reading' (duration: 141.296706ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:19:52.857375Z","caller":"traceutil/trace.go:171","msg":"trace[674877873] linearizableReadLoop","detail":"{readStateIndex:3956; appliedIndex:3955; }","duration":"128.570916ms","start":"2026-06-15T08:19:52.728785Z","end":"2026-06-15T08:19:52.857356Z","steps":["trace[674877873] 'read index received' (duration: 128.438533ms)","trace[674877873] 'applied index is now lower than readState.Index' (duration: 131.503µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:19:52.857418Z","caller":"traceutil/trace.go:171","msg":"trace[707212875] transaction","detail":"{read_only:false; response_revision:3813; number_of_response:1; }","duration":"194.844429ms","start":"2026-06-15T08:19:52.662543Z","end":"2026-06-15T08:19:52.857387Z","steps":["trace[707212875] 'process raft request' (duration: 194.681216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:19:52.857563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.755311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-15T08:19:52.857598Z","caller":"traceutil/trace.go:171","msg":"trace[876348188] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3813; }","duration":"128.856593ms","start":"2026-06-15T08:19:52.728734Z","end":"2026-06-15T08:19:52.85759Z","steps":["trace[876348188] 'agreement among raft nodes before linearized reading' (duration: 128.71083ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:12.405921Z","caller":"traceutil/trace.go:171","msg":"trace[277978330] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"106.645416ms","start":"2026-06-15T08:21:12.299242Z","end":"2026-06-15T08:21:12.405887Z","steps":["trace[277978330] 'process raft request' (duration: 106.501342ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:15.861511Z","caller":"traceutil/trace.go:171","msg":"trace[1029398159] linearizableReadLoop","detail":"{readStateIndex:5175; appliedIndex:5174; }","duration":"112.797066ms","start":"2026-06-15T08:21:15.748693Z","end":"2026-06-15T08:21:15.86149Z","steps":["trace[1029398159] 'read index received' (duration: 14.418801ms)","trace[1029398159] 'applied index is now lower than readState.Index' (duration: 98.377275ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:21:15.861607Z","caller":"traceutil/trace.go:171","msg":"trace[1671040932] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"177.882209ms","start":"2026-06-15T08:21:15.683694Z","end":"2026-06-15T08:21:15.861576Z","steps":["trace[1671040932] 'process raft request' (duration: 79.449853ms)","trace[1671040932] 'compare' (duration: 98.231732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:21:15.861781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.083012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-tcjkc-tls\" ","response":"range_response_count:1 size:2184"} {"level":"info","ts":"2026-06-15T08:21:15.861836Z","caller":"traceutil/trace.go:171","msg":"trace[430067453] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-tcjkc-tls; range_end:; response_count:1; response_revision:4991; }","duration":"113.182355ms","start":"2026-06-15T08:21:15.748639Z","end":"2026-06-15T08:21:15.861822Z","steps":["trace[430067453] 'agreement among raft nodes before linearized reading' (duration: 112.933889ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:16.103869Z","caller":"traceutil/trace.go:171","msg":"trace[8617284] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"204.766265ms","start":"2026-06-15T08:21:15.899072Z","end":"2026-06-15T08:21:16.103838Z","steps":["trace[8617284] 'process raft request' (duration: 174.893791ms)","trace[8617284] 'compare' (duration: 29.625019ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:21:16.14063Z","caller":"traceutil/trace.go:171","msg":"trace[2027683689] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"240.176777ms","start":"2026-06-15T08:21:15.900419Z","end":"2026-06-15T08:21:16.140596Z","steps":["trace[2027683689] 'process raft request' (duration: 240.082575ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:16.140636Z","caller":"traceutil/trace.go:171","msg":"trace[1210269628] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"239.100492ms","start":"2026-06-15T08:21:15.901513Z","end":"2026-06-15T08:21:16.140614Z","steps":["trace[1210269628] 'process raft request' (duration: 239.023081ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:16.140629Z","caller":"traceutil/trace.go:171","msg":"trace[2135660895] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"240.31177ms","start":"2026-06-15T08:21:15.900304Z","end":"2026-06-15T08:21:16.140616Z","steps":["trace[2135660895] 'process raft request' (duration: 240.083955ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:29.493924Z","caller":"traceutil/trace.go:171","msg":"trace[1541894252] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"204.791155ms","start":"2026-06-15T08:21:29.289106Z","end":"2026-06-15T08:21:29.493897Z","steps":["trace[1541894252] 'process raft request' (duration: 204.611591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:21:36.706999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.178686ms","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-06-15T08:21:36.707057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.613847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v92p2\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-06-15T08:21:36.707108Z","caller":"traceutil/trace.go:171","msg":"trace[1083232000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5400; }","duration":"397.33606ms","start":"2026-06-15T08:21:36.309747Z","end":"2026-06-15T08:21:36.707083Z","steps":["trace[1083232000] 'range keys from in-memory index tree' (duration: 397.016172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:21:36.707015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.31411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e83c849-59fb-42fb-8f24-23d59fddf3cb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-15T08:21:36.707131Z","caller":"traceutil/trace.go:171","msg":"trace[1891072090] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v92p2; range_end:; response_count:1; response_revision:5400; }","duration":"394.72864ms","start":"2026-06-15T08:21:36.312384Z","end":"2026-06-15T08:21:36.707113Z","steps":["trace[1891072090] 'range keys from in-memory index tree' (duration: 394.426993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:21:36.707163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:21:36.30972Z","time spent":"397.427302ms","remote":"127.0.0.1:55102","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":"info","ts":"2026-06-15T08:21:36.707177Z","caller":"traceutil/trace.go:171","msg":"trace[501332776] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4e83c849-59fb-42fb-8f24-23d59fddf3cb; range_end:; response_count:1; response_revision:5400; }","duration":"213.542685ms","start":"2026-06-15T08:21:36.493618Z","end":"2026-06-15T08:21:36.70716Z","steps":["trace[501332776] 'range keys from in-memory index tree' (duration: 213.098676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:21:36.707193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:21:36.312368Z","time spent":"394.815162ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-v92p2\" "} {"level":"warn","ts":"2026-06-15T08:21:36.707027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.377341ms","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-06-15T08:21:36.707264Z","caller":"traceutil/trace.go:171","msg":"trace[711074191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5400; }","duration":"397.675217ms","start":"2026-06-15T08:21:36.30958Z","end":"2026-06-15T08:21:36.707256Z","steps":["trace[711074191] 'range keys from in-memory index tree' (duration: 397.203256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:21:36.707289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:21:36.309559Z","time spent":"397.721678ms","remote":"127.0.0.1:55102","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-06-15T08:21:36.92779Z","caller":"traceutil/trace.go:171","msg":"trace[551621892] linearizableReadLoop","detail":"{readStateIndex:5599; appliedIndex:5597; }","duration":"215.925821ms","start":"2026-06-15T08:21:36.711838Z","end":"2026-06-15T08:21:36.927764Z","steps":["trace[551621892] 'read index received' (duration: 36.745272ms)","trace[551621892] 'applied index is now lower than readState.Index' (duration: 179.179309ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:21:36.927897Z","caller":"traceutil/trace.go:171","msg":"trace[527091287] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"216.287179ms","start":"2026-06-15T08:21:36.711572Z","end":"2026-06-15T08:21:36.927859Z","steps":["trace[527091287] 'process raft request' (duration: 174.404659ms)","trace[527091287] 'compare' (duration: 41.521982ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:21:36.92806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.203867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-12d67f73-efac-4cdd-b538-225cc8005dd8\" ","response":"range_response_count:1 size:1275"} {"level":"warn","ts":"2026-06-15T08:21:36.92804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.516654ms","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-06-15T08:21:36.928143Z","caller":"traceutil/trace.go:171","msg":"trace[187508417] range","detail":"{range_begin:/registry/persistentvolumes/pvc-12d67f73-efac-4cdd-b538-225cc8005dd8; range_end:; response_count:1; response_revision:5403; }","duration":"216.31896ms","start":"2026-06-15T08:21:36.711802Z","end":"2026-06-15T08:21:36.928121Z","steps":["trace[187508417] 'agreement among raft nodes before linearized reading' (duration: 216.126185ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:36.928143Z","caller":"traceutil/trace.go:171","msg":"trace[680045487] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"214.820416ms","start":"2026-06-15T08:21:36.713298Z","end":"2026-06-15T08:21:36.928118Z","steps":["trace[680045487] 'process raft request' (duration: 214.401006ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:36.928139Z","caller":"traceutil/trace.go:171","msg":"trace[1314897564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5403; }","duration":"134.698048ms","start":"2026-06-15T08:21:36.793427Z","end":"2026-06-15T08:21:36.928126Z","steps":["trace[1314897564] 'agreement among raft nodes before linearized reading' (duration: 134.474553ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:21:48.403254Z","caller":"traceutil/trace.go:171","msg":"trace[1421182665] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"109.308396ms","start":"2026-06-15T08:21:48.29391Z","end":"2026-06-15T08:21:48.403218Z","steps":["trace[1421182665] 'process raft request' (duration: 10.618713ms)","trace[1421182665] 'compare' (duration: 98.56217ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:22:49.56297Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292186858556645,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T08:22:50.03546Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.313710839s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T08:22:50.035852Z","caller":"traceutil/trace.go:171","msg":"trace[1390817463] transaction","detail":"{read_only:false; response_revision:6065; number_of_response:1; }","duration":"1.314205681s","start":"2026-06-15T08:22:48.721626Z","end":"2026-06-15T08:22:50.035832Z","steps":["trace[1390817463] 'process raft request' (duration: 1.314084368s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.035972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:48.721603Z","time spent":"1.314295422s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:22:50.03826Z","caller":"traceutil/trace.go:171","msg":"trace[2050908968] transaction","detail":"{read_only:false; response_revision:6066; number_of_response:1; }","duration":"998.454479ms","start":"2026-06-15T08:22:49.039782Z","end":"2026-06-15T08:22:50.038237Z","steps":["trace[2050908968] 'process raft request' (duration: 998.301576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.038395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.039764Z","time spent":"998.555941ms","remote":"127.0.0.1:54916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":527,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:22:50.038678Z","caller":"traceutil/trace.go:171","msg":"trace[892968497] transaction","detail":"{read_only:false; response_revision:6068; number_of_response:1; }","duration":"253.669067ms","start":"2026-06-15T08:22:49.784988Z","end":"2026-06-15T08:22:50.038657Z","steps":["trace[892968497] 'process raft request' (duration: 253.505023ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:22:50.038682Z","caller":"traceutil/trace.go:171","msg":"trace[412030036] transaction","detail":"{read_only:false; response_revision:6069; number_of_response:1; }","duration":"170.48084ms","start":"2026-06-15T08:22:49.868182Z","end":"2026-06-15T08:22:50.038663Z","steps":["trace[412030036] 'process raft request' (duration: 170.408018ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:22:50.038789Z","caller":"traceutil/trace.go:171","msg":"trace[1814055016] linearizableReadLoop","detail":"{readStateIndex:6282; appliedIndex:6279; }","duration":"976.781402ms","start":"2026-06-15T08:22:49.061953Z","end":"2026-06-15T08:22:50.038734Z","steps":["trace[1814055016] 'read index received' (duration: 973.784933ms)","trace[1814055016] 'applied index is now lower than readState.Index' (duration: 2.995499ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:22:50.038828Z","caller":"traceutil/trace.go:171","msg":"trace[1107222838] transaction","detail":"{read_only:false; response_revision:6067; number_of_response:1; }","duration":"927.076592ms","start":"2026-06-15T08:22:49.11172Z","end":"2026-06-15T08:22:50.038797Z","steps":["trace[1107222838] 'process raft request' (duration: 926.478508ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:22:50.038859Z","caller":"traceutil/trace.go:171","msg":"trace[1282751540] transaction","detail":"{read_only:false; response_revision:6070; number_of_response:1; }","duration":"165.742351ms","start":"2026-06-15T08:22:49.873107Z","end":"2026-06-15T08:22:50.038849Z","steps":["trace[1282751540] 'process raft request' (duration: 165.516396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.038904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.111703Z","time spent":"927.163405ms","remote":"127.0.0.1:54840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:22:50.038813Z","caller":"traceutil/trace.go:171","msg":"trace[1700252986] transaction","detail":"{read_only:false; response_revision:6071; number_of_response:1; }","duration":"165.66858ms","start":"2026-06-15T08:22:49.873129Z","end":"2026-06-15T08:22:50.038797Z","steps":["trace[1700252986] 'process raft request' (duration: 165.520577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.039097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.096913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T08:22:50.039098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.140069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T08:22:50.039137Z","caller":"traceutil/trace.go:171","msg":"trace[215532812] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:6072; }","duration":"977.237513ms","start":"2026-06-15T08:22:49.061887Z","end":"2026-06-15T08:22:50.039125Z","steps":["trace[215532812] 'agreement among raft nodes before linearized reading' (duration: 977.165322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.039169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.061875Z","time spent":"977.285754ms","remote":"127.0.0.1:43318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":2,"response size":29,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-06-15T08:22:50.039362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.386111ms","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-06-15T08:22:50.039414Z","caller":"traceutil/trace.go:171","msg":"trace[1434669245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6072; }","duration":"679.483274ms","start":"2026-06-15T08:22:49.359918Z","end":"2026-06-15T08:22:50.039401Z","steps":["trace[1434669245] 'agreement among raft nodes before linearized reading' (duration: 679.34601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.039449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.359899Z","time spent":"679.540694ms","remote":"127.0.0.1:55102","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-06-15T08:22:50.039469Z","caller":"traceutil/trace.go:171","msg":"trace[744402922] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:6072; }","duration":"965.131704ms","start":"2026-06-15T08:22:49.073987Z","end":"2026-06-15T08:22:50.039119Z","steps":["trace[744402922] 'agreement among raft nodes before linearized reading' (duration: 965.068563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.03951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.188035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T08:22:50.039471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.831921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-15T08:22:50.039531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.006601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:22:50.039594Z","caller":"traceutil/trace.go:171","msg":"trace[329122771] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:6072; }","duration":"355.114154ms","start":"2026-06-15T08:22:49.684463Z","end":"2026-06-15T08:22:50.039577Z","steps":["trace[329122771] 'agreement among raft nodes before linearized reading' (duration: 354.997321ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:22:50.039606Z","caller":"traceutil/trace.go:171","msg":"trace[1101828115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6072; }","duration":"907.944664ms","start":"2026-06-15T08:22:49.131598Z","end":"2026-06-15T08:22:50.039543Z","steps":["trace[1101828115] 'agreement among raft nodes before linearized reading' (duration: 907.78299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.039646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.684445Z","time spent":"355.187497ms","remote":"127.0.0.1:52140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-06-15T08:22:50.039668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.131583Z","time spent":"908.077237ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T08:22:50.039554Z","caller":"traceutil/trace.go:171","msg":"trace[250486951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6072; }","duration":"907.250217ms","start":"2026-06-15T08:22:49.13229Z","end":"2026-06-15T08:22:50.03954Z","steps":["trace[250486951] 'agreement among raft nodes before linearized reading' (duration: 907.199106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.039836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.132234Z","time spent":"907.573865ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T08:22:50.039509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.07392Z","time spent":"965.578875ms","remote":"127.0.0.1:51978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-06-15T08:22:50.039616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.198812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v92p2\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-06-15T08:22:50.040216Z","caller":"traceutil/trace.go:171","msg":"trace[1488572952] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v92p2; range_end:; response_count:1; response_revision:6072; }","duration":"953.828916ms","start":"2026-06-15T08:22:49.086377Z","end":"2026-06-15T08:22:50.040206Z","steps":["trace[1488572952] 'agreement among raft nodes before linearized reading' (duration: 953.15917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.039629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.901798ms","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-06-15T08:22:50.042255Z","caller":"traceutil/trace.go:171","msg":"trace[240132812] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6072; }","duration":"671.579162ms","start":"2026-06-15T08:22:49.368691Z","end":"2026-06-15T08:22:50.04027Z","steps":["trace[240132812] 'agreement among raft nodes before linearized reading' (duration: 670.881805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:50.042382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.368675Z","time spent":"673.68332ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T08:22:50.040271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:49.086361Z","time spent":"953.902188ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-v92p2\" "} {"level":"info","ts":"2026-06-15T08:22:50.047746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2967} {"level":"info","ts":"2026-06-15T08:22:50.132706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2967,"took":"81.826077ms","hash":1794819612,"current-db-size-bytes":58298368,"current-db-size":"58 MB","current-db-size-in-use-bytes":33808384,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-15T08:22:50.132853Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1794819612,"revision":2967,"compact-revision":-1} {"level":"warn","ts":"2026-06-15T08:22:55.061672Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292186858556789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T08:22:55.562265Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292186858556789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T08:22:56.062827Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938292186858556789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T08:22:56.428477Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.099088041s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-15T08:22:56.729395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.917977568s","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-06-15T08:22:56.729529Z","caller":"traceutil/trace.go:171","msg":"trace[376165441] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6119; }","duration":"1.918120332s","start":"2026-06-15T08:22:54.811386Z","end":"2026-06-15T08:22:56.729506Z","steps":["trace[376165441] 'range keys from in-memory index tree' (duration: 1.917960188s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:56.730274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.26745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T08:22:56.730415Z","caller":"traceutil/trace.go:171","msg":"trace[633390579] transaction","detail":"{read_only:false; response_revision:6120; number_of_response:1; }","duration":"2.401127298s","start":"2026-06-15T08:22:54.329258Z","end":"2026-06-15T08:22:56.730386Z","steps":["trace[633390579] 'process raft request' (duration: 2.099577002s)","trace[633390579] 'compare' (duration: 300.187185ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:22:56.730507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:54.329241Z","time spent":"2.401217121s","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9995,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:22:57.132777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000299997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-15T08:22:57.132851Z","caller":"traceutil/trace.go:171","msg":"trace[537970040] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00042551s","start":"2026-06-15T08:22:55.132409Z","end":"2026-06-15T08:22:57.132835Z","steps":["trace[537970040] 'agreement among raft nodes before linearized reading' (duration: 2.000333848s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:57.132884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:55.132388Z","time spent":"2.000489591s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/15 08:22:57 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-15T08:22:59.133256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000356367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-15T08:22:59.133344Z","caller":"traceutil/trace.go:171","msg":"trace[1905602960] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00050615s","start":"2026-06-15T08:22:57.132818Z","end":"2026-06-15T08:22:59.133324Z","steps":["trace[1905602960] 'agreement among raft nodes before linearized reading' (duration: 2.000388438s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:59.133393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:57.132797Z","time spent":"2.000586433s","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/15 08:22:59 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-15T08:22:59.617161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999808958s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-15T08:22:59.617245Z","caller":"traceutil/trace.go:171","msg":"trace[2102074098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999945601s","start":"2026-06-15T08:22:54.617278Z","end":"2026-06-15T08:22:59.617224Z","steps":["trace[2102074098] 'agreement among raft nodes before linearized reading' (duration: 4.999847179s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:22:59.617291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:54.617257Z","time spent":"5.000024533s","remote":"127.0.0.1:55102","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/06/15 08:22:59 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-15T08:23:00.575763Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.141105156s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T08:23:00.57619Z","caller":"traceutil/trace.go:171","msg":"trace[1418027927] transaction","detail":"{read_only:false; response_revision:6121; number_of_response:1; }","duration":"4.828930931s","start":"2026-06-15T08:22:55.747235Z","end":"2026-06-15T08:23:00.576166Z","steps":["trace[1418027927] 'process raft request' (duration: 4.828751567s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:00.576333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:55.747209Z","time spent":"4.829051374s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:23:00.576443Z","caller":"traceutil/trace.go:171","msg":"trace[720310208] transaction","detail":"{read_only:false; response_revision:6122; number_of_response:1; }","duration":"4.516092695s","start":"2026-06-15T08:22:56.060325Z","end":"2026-06-15T08:23:00.576417Z","steps":["trace[720310208] 'process raft request' (duration: 4.515798109s)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:00.576539Z","caller":"traceutil/trace.go:171","msg":"trace[448312754] transaction","detail":"{read_only:false; response_revision:6124; number_of_response:1; }","duration":"4.5158916s","start":"2026-06-15T08:22:56.06062Z","end":"2026-06-15T08:23:00.576511Z","steps":["trace[448312754] 'process raft request' (duration: 4.515811949s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:00.576578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.060283Z","time spent":"4.516216258s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:23:00.576618Z","caller":"traceutil/trace.go:171","msg":"trace[472530283] linearizableReadLoop","detail":"{readStateIndex:6342; appliedIndex:6336; }","duration":"6.015885213s","start":"2026-06-15T08:22:54.560711Z","end":"2026-06-15T08:23:00.576596Z","steps":["trace[472530283] 'read index received' (duration: 1.868151466s)","trace[472530283] 'applied index is now lower than readState.Index' (duration: 4.147732627s)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:00.576639Z","caller":"traceutil/trace.go:171","msg":"trace[1903542094] transaction","detail":"{read_only:false; response_revision:6125; number_of_response:1; }","duration":"4.515526173s","start":"2026-06-15T08:22:56.061086Z","end":"2026-06-15T08:23:00.576612Z","steps":["trace[1903542094] 'process raft request' (duration: 4.51538695s)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:00.576639Z","caller":"traceutil/trace.go:171","msg":"trace[445731273] transaction","detail":"{read_only:false; response_revision:6123; number_of_response:1; }","duration":"4.516077495s","start":"2026-06-15T08:22:56.060502Z","end":"2026-06-15T08:23:00.576579Z","steps":["trace[445731273] 'process raft request' (duration: 4.515831079s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:00.576696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.06061Z","time spent":"4.516010223s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:23:00.576764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.060494Z","time spent":"4.516209678s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:23:00.576759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.061064Z","time spent":"4.515633105s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:23:00.576806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.016099348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8242"} {"level":"info","ts":"2026-06-15T08:23:00.576843Z","caller":"traceutil/trace.go:171","msg":"trace[628438015] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:6125; }","duration":"6.01617764s","start":"2026-06-15T08:22:54.560654Z","end":"2026-06-15T08:23:00.576832Z","steps":["trace[628438015] 'agreement among raft nodes before linearized reading' (duration: 6.016042457s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:00.576874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:54.560623Z","time spent":"6.016243531s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":8264,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"info","ts":"2026-06-15T08:23:00.801334Z","caller":"traceutil/trace.go:171","msg":"trace[925257733] transaction","detail":"{read_only:false; response_revision:6127; number_of_response:1; }","duration":"3.256913827s","start":"2026-06-15T08:22:57.544386Z","end":"2026-06-15T08:23:00.8013Z","steps":["trace[925257733] 'process raft request' (duration: 3.256750893s)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:00.801327Z","caller":"traceutil/trace.go:171","msg":"trace[1604449154] transaction","detail":"{read_only:false; response_revision:6126; number_of_response:1; }","duration":"3.46335587s","start":"2026-06-15T08:22:57.337933Z","end":"2026-06-15T08:23:00.801289Z","steps":["trace[1604449154] 'process raft request' (duration: 3.370064861s)","trace[1604449154] 'compare' (duration: 93.009923ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:00.801483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:57.544362Z","time spent":"3.25704896s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:23:00.801671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:57.337909Z","time spent":"3.463622837s","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19637,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:23:00.909807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.600391ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-15T08:23:00.910147Z","caller":"traceutil/trace.go:171","msg":"trace[648291116] linearizableReadLoop","detail":"{readStateIndex:6346; appliedIndex:6342; }","duration":"333.464548ms","start":"2026-06-15T08:23:00.576664Z","end":"2026-06-15T08:23:00.910129Z","steps":["trace[648291116] 'read index received' (duration: 131.402514ms)","trace[648291116] 'applied index is now lower than readState.Index' (duration: 202.061094ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:00.910172Z","caller":"traceutil/trace.go:171","msg":"trace[496438180] transaction","detail":"{read_only:false; response_revision:6128; number_of_response:1; }","duration":"1.772541333s","start":"2026-06-15T08:22:59.13759Z","end":"2026-06-15T08:23:00.910131Z","steps":["trace[496438180] 'process raft request' (duration: 1.772314438s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:00.910443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:59.137559Z","time spent":"1.772802139s","remote":"127.0.0.1:54896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T08:23:01.029639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.033553514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T08:23:01.029728Z","caller":"traceutil/trace.go:171","msg":"trace[410289939] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:6128; }","duration":"3.033653546s","start":"2026-06-15T08:22:57.99605Z","end":"2026-06-15T08:23:01.029704Z","steps":["trace[410289939] 'agreement among raft nodes before linearized reading' (duration: 2.914233057s)","trace[410289939] 'count revisions from in-memory index tree' (duration: 119.296627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.029853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.584263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T08:23:01.029895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:57.996017Z","time spent":"3.033803779s","remote":"127.0.0.1:43328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":11,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"info","ts":"2026-06-15T08:23:01.029953Z","caller":"traceutil/trace.go:171","msg":"trace[1025956591] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:6128; }","duration":"698.720855ms","start":"2026-06-15T08:23:00.331202Z","end":"2026-06-15T08:23:01.029923Z","steps":["trace[1025956591] 'agreement among raft nodes before linearized reading' (duration: 579.059151ms)","trace[1025956591] 'count revisions from in-memory index tree' (duration: 119.524431ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.029885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.970857036s","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":"warn","ts":"2026-06-15T08:23:01.030118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.888738218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:23:01.030154Z","caller":"traceutil/trace.go:171","msg":"trace[1635399544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6128; }","duration":"1.888800238s","start":"2026-06-15T08:22:59.141342Z","end":"2026-06-15T08:23:01.030142Z","steps":["trace[1635399544] 'agreement among raft nodes before linearized reading' (duration: 1.768930509s)","trace[1635399544] 'range keys from in-memory index tree' (duration: 119.830699ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.030174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:59.14133Z","time spent":"1.88884045s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T08:23:01.030166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.918309551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v92p2\" ","response":"range_response_count:1 size:6445"} {"level":"warn","ts":"2026-06-15T08:23:01.030208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.930028009s","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-06-15T08:23:01.030103Z","caller":"traceutil/trace.go:171","msg":"trace[34946436] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6128; }","duration":"4.971132832s","start":"2026-06-15T08:22:56.058944Z","end":"2026-06-15T08:23:01.030076Z","steps":["trace[34946436] 'agreement among raft nodes before linearized reading' (duration: 4.851356605s)","trace[34946436] 'range keys from in-memory index tree' (duration: 119.329247ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.030256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.738824243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-15T08:23:01.030245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.466747674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:1 size:6019"} {"level":"warn","ts":"2026-06-15T08:23:01.030331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.92354578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T08:23:01.030319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.058912Z","time spent":"4.971385778s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T08:23:01.030327Z","caller":"traceutil/trace.go:171","msg":"trace[461871903] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6128; }","duration":"4.738937456s","start":"2026-06-15T08:22:56.291366Z","end":"2026-06-15T08:23:01.030303Z","steps":["trace[461871903] 'agreement among raft nodes before linearized reading' (duration: 4.618861592s)","trace[461871903] 'range keys from in-memory index tree' (duration: 119.898859ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:01.030355Z","caller":"traceutil/trace.go:171","msg":"trace[1597076242] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6128; }","duration":"4.923646773s","start":"2026-06-15T08:22:56.106699Z","end":"2026-06-15T08:23:01.030345Z","steps":["trace[1597076242] 'agreement among raft nodes before linearized reading' (duration: 4.803564469s)","trace[1597076242] 'range keys from in-memory index tree' (duration: 119.999572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.030375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.106653Z","time spent":"4.923717424s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T08:23:01.030012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:23:00.331186Z","time spent":"698.814317ms","remote":"127.0.0.1:51890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"info","ts":"2026-06-15T08:23:01.03036Z","caller":"traceutil/trace.go:171","msg":"trace[797002624] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v92p2; range_end:; response_count:1; response_revision:6128; }","duration":"4.918487574s","start":"2026-06-15T08:22:56.111821Z","end":"2026-06-15T08:23:01.030309Z","steps":["trace[797002624] 'agreement among raft nodes before linearized reading' (duration: 4.79841738s)","trace[797002624] 'range keys from in-memory index tree' (duration: 119.792537ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.030387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.291346Z","time spent":"4.739027539s","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-15T08:23:01.030309Z","caller":"traceutil/trace.go:171","msg":"trace[897428811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6128; }","duration":"4.930183972s","start":"2026-06-15T08:22:56.100098Z","end":"2026-06-15T08:23:01.030282Z","steps":["trace[897428811] 'agreement among raft nodes before linearized reading' (duration: 4.81019237s)","trace[897428811] 'range keys from in-memory index tree' (duration: 119.433319ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.030447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.111809Z","time spent":"4.918619127s","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-v92p2\" "} {"level":"warn","ts":"2026-06-15T08:23:01.030245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.881136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:23:01.030737Z","caller":"traceutil/trace.go:171","msg":"trace[179639986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6128; }","duration":"364.412717ms","start":"2026-06-15T08:23:00.666302Z","end":"2026-06-15T08:23:01.030715Z","steps":["trace[179639986] 'agreement among raft nodes before linearized reading' (duration: 243.978955ms)","trace[179639986] 'range keys from in-memory index tree' (duration: 119.926431ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:01.030365Z","caller":"traceutil/trace.go:171","msg":"trace[1853893646] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:1; response_revision:6128; }","duration":"6.466900927s","start":"2026-06-15T08:22:54.563437Z","end":"2026-06-15T08:23:01.030338Z","steps":["trace[1853893646] 'agreement among raft nodes before linearized reading' (duration: 6.346833573s)","trace[1853893646] 'range keys from in-memory index tree' (duration: 119.789458ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.032552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:23:00.666279Z","time spent":"366.25244ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T08:23:01.03256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:54.563428Z","time spent":"6.469111637s","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":6041,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-06-15T08:23:01.030279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.628023002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:23:01.032827Z","caller":"traceutil/trace.go:171","msg":"trace[1824011058] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:6128; }","duration":"4.630633972s","start":"2026-06-15T08:22:56.402167Z","end":"2026-06-15T08:23:01.032801Z","steps":["trace[1824011058] 'agreement among raft nodes before linearized reading' (duration: 4.508129943s)","trace[1824011058] 'count revisions from in-memory index tree' (duration: 119.940061ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.032905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.402137Z","time spent":"4.630742045s","remote":"127.0.0.1:43998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-15T08:23:01.030507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.100071Z","time spent":"4.930396447s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T08:23:01.030597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.923712704s","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-06-15T08:23:01.033011Z","caller":"traceutil/trace.go:171","msg":"trace[54362946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6128; }","duration":"4.926176302s","start":"2026-06-15T08:22:56.106814Z","end":"2026-06-15T08:23:01.03299Z","steps":["trace[54362946] 'agreement among raft nodes before linearized reading' (duration: 4.803439357s)","trace[54362946] 'range keys from in-memory index tree' (duration: 120.008792ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.03307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:56.10679Z","time spent":"4.926263393s","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T08:23:01.030023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.909099864s","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-06-15T08:23:01.0332Z","caller":"traceutil/trace.go:171","msg":"trace[1899449055] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:6128; }","duration":"3.912310428s","start":"2026-06-15T08:22:57.120868Z","end":"2026-06-15T08:23:01.033178Z","steps":["trace[1899449055] 'agreement among raft nodes before linearized reading' (duration: 3.789420029s)","trace[1899449055] 'count revisions from in-memory index tree' (duration: 119.692395ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:01.033275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:22:57.120843Z","time spent":"3.91240909s","remote":"127.0.0.1:55384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":691,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-15T08:23:01.176664Z","caller":"traceutil/trace.go:171","msg":"trace[606530681] transaction","detail":"{read_only:false; response_revision:6130; number_of_response:1; }","duration":"139.782436ms","start":"2026-06-15T08:23:01.036802Z","end":"2026-06-15T08:23:01.176585Z","steps":["trace[606530681] 'process raft request' (duration: 139.577371ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:01.17695Z","caller":"traceutil/trace.go:171","msg":"trace[686879425] transaction","detail":"{read_only:false; response_revision:6132; number_of_response:1; }","duration":"139.51095ms","start":"2026-06-15T08:23:01.037427Z","end":"2026-06-15T08:23:01.176938Z","steps":["trace[686879425] 'process raft request' (duration: 139.356036ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:01.177037Z","caller":"traceutil/trace.go:171","msg":"trace[1598168907] transaction","detail":"{read_only:false; response_revision:6131; number_of_response:1; }","duration":"139.929199ms","start":"2026-06-15T08:23:01.037082Z","end":"2026-06-15T08:23:01.177012Z","steps":["trace[1598168907] 'process raft request' (duration: 139.454729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:01.177359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.130223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:14 size:126500"} {"level":"info","ts":"2026-06-15T08:23:01.17747Z","caller":"traceutil/trace.go:171","msg":"trace[1251633899] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:14; response_revision:6132; }","duration":"140.321138ms","start":"2026-06-15T08:23:01.037129Z","end":"2026-06-15T08:23:01.17745Z","steps":["trace[1251633899] 'agreement among raft nodes before linearized reading' (duration: 139.818947ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:01.594031Z","caller":"traceutil/trace.go:171","msg":"trace[922629943] transaction","detail":"{read_only:false; response_revision:6134; number_of_response:1; }","duration":"208.851829ms","start":"2026-06-15T08:23:01.385158Z","end":"2026-06-15T08:23:01.59401Z","steps":["trace[922629943] 'process raft request' (duration: 208.713466ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:02.694792Z","caller":"traceutil/trace.go:171","msg":"trace[1770916096] transaction","detail":"{read_only:false; response_revision:6137; number_of_response:1; }","duration":"113.667718ms","start":"2026-06-15T08:23:02.581057Z","end":"2026-06-15T08:23:02.694724Z","steps":["trace[1770916096] 'process raft request' (duration: 53.217031ms)","trace[1770916096] 'compare' (duration: 60.290483ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.046669Z","caller":"traceutil/trace.go:171","msg":"trace[1367514957] transaction","detail":"{read_only:false; response_revision:6138; number_of_response:1; }","duration":"464.910792ms","start":"2026-06-15T08:23:02.58173Z","end":"2026-06-15T08:23:03.046641Z","steps":["trace[1367514957] 'process raft request' (duration: 464.708118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.046921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:23:02.581701Z","time spent":"465.139518ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:23:03.047124Z","caller":"traceutil/trace.go:171","msg":"trace[858372565] transaction","detail":"{read_only:false; response_revision:6139; number_of_response:1; }","duration":"464.224417ms","start":"2026-06-15T08:23:02.582882Z","end":"2026-06-15T08:23:03.047106Z","steps":["trace[858372565] 'process raft request' (duration: 463.709335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.047229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:23:02.58287Z","time spent":"464.305099ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:23:03.04731Z","caller":"traceutil/trace.go:171","msg":"trace[1533705468] linearizableReadLoop","detail":"{readStateIndex:6357; appliedIndex:6355; }","duration":"465.066726ms","start":"2026-06-15T08:23:02.582216Z","end":"2026-06-15T08:23:03.047283Z","steps":["trace[1533705468] 'read index received' (duration: 52.069823ms)","trace[1533705468] 'applied index is now lower than readState.Index' (duration: 412.995683ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.047365Z","caller":"traceutil/trace.go:171","msg":"trace[161243643] transaction","detail":"{read_only:false; response_revision:6140; number_of_response:1; }","duration":"464.417942ms","start":"2026-06-15T08:23:02.582905Z","end":"2026-06-15T08:23:03.047323Z","steps":["trace[161243643] 'process raft request' (duration: 464.135465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.047458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.23401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8242"} {"level":"info","ts":"2026-06-15T08:23:03.047488Z","caller":"traceutil/trace.go:171","msg":"trace[1661464612] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:6140; }","duration":"465.331412ms","start":"2026-06-15T08:23:02.582148Z","end":"2026-06-15T08:23:03.047479Z","steps":["trace[1661464612] 'agreement among raft nodes before linearized reading' (duration: 465.196829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.047517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:23:02.582132Z","time spent":"465.377923ms","remote":"127.0.0.1:55076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":8264,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"warn","ts":"2026-06-15T08:23:03.047528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:23:02.58288Z","time spent":"464.558624ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:23:03.317036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.593118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T08:23:03.317508Z","caller":"traceutil/trace.go:171","msg":"trace[1870191556] transaction","detail":"{read_only:false; response_revision:6141; number_of_response:1; }","duration":"264.448865ms","start":"2026-06-15T08:23:03.053028Z","end":"2026-06-15T08:23:03.317477Z","steps":["trace[1870191556] 'process raft request' (duration: 57.322095ms)","trace[1870191556] 'compare' (duration: 206.317312ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.317593Z","caller":"traceutil/trace.go:171","msg":"trace[965506868] linearizableReadLoop","detail":"{readStateIndex:6360; appliedIndex:6359; }","duration":"202.505374ms","start":"2026-06-15T08:23:03.115067Z","end":"2026-06-15T08:23:03.317573Z","steps":["trace[965506868] 'read index received' (duration: 95.062µs)","trace[965506868] 'applied index is now lower than readState.Index' (duration: 202.408512ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.317759Z","caller":"traceutil/trace.go:171","msg":"trace[772002859] transaction","detail":"{read_only:false; response_revision:6142; number_of_response:1; }","duration":"149.687773ms","start":"2026-06-15T08:23:03.168048Z","end":"2026-06-15T08:23:03.317735Z","steps":["trace[772002859] 'process raft request' (duration: 149.454208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.317861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.693625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T08:23:03.317911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.836361ms","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-06-15T08:23:03.31801Z","caller":"traceutil/trace.go:171","msg":"trace[957815516] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6142; }","duration":"202.986215ms","start":"2026-06-15T08:23:03.115Z","end":"2026-06-15T08:23:03.317987Z","steps":["trace[957815516] 'agreement among raft nodes before linearized reading' (duration: 202.684988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.318175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.772801ms","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-06-15T08:23:03.317951Z","caller":"traceutil/trace.go:171","msg":"trace[2102889525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6142; }","duration":"177.825548ms","start":"2026-06-15T08:23:03.140072Z","end":"2026-06-15T08:23:03.317898Z","steps":["trace[2102889525] 'agreement among raft nodes before linearized reading' (duration: 177.700165ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.318236Z","caller":"traceutil/trace.go:171","msg":"trace[876889194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6142; }","duration":"137.865233ms","start":"2026-06-15T08:23:03.180357Z","end":"2026-06-15T08:23:03.318223Z","steps":["trace[876889194] 'agreement among raft nodes before linearized reading' (duration: 137.675518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.318224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.993652ms","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-06-15T08:23:03.318235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.095402ms","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-06-15T08:23:03.318318Z","caller":"traceutil/trace.go:171","msg":"trace[1273615725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6142; }","duration":"137.112215ms","start":"2026-06-15T08:23:03.18119Z","end":"2026-06-15T08:23:03.318303Z","steps":["trace[1273615725] 'agreement among raft nodes before linearized reading' (duration: 136.836128ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.318405Z","caller":"traceutil/trace.go:171","msg":"trace[1591659431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6142; }","duration":"136.289356ms","start":"2026-06-15T08:23:03.182063Z","end":"2026-06-15T08:23:03.318352Z","steps":["trace[1591659431] 'agreement among raft nodes before linearized reading' (duration: 135.816204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.31819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.304958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v92p2\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-06-15T08:23:03.318648Z","caller":"traceutil/trace.go:171","msg":"trace[1560127612] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v92p2; range_end:; response_count:1; response_revision:6142; }","duration":"133.804769ms","start":"2026-06-15T08:23:03.184823Z","end":"2026-06-15T08:23:03.318628Z","steps":["trace[1560127612] 'agreement among raft nodes before linearized reading' (duration: 133.180714ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.546382Z","caller":"traceutil/trace.go:171","msg":"trace[1171122001] transaction","detail":"{read_only:false; response_revision:6144; number_of_response:1; }","duration":"222.621465ms","start":"2026-06-15T08:23:03.323729Z","end":"2026-06-15T08:23:03.546351Z","steps":["trace[1171122001] 'process raft request' (duration: 184.778387ms)","trace[1171122001] 'compare' (duration: 37.520151ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.546537Z","caller":"traceutil/trace.go:171","msg":"trace[2104680955] transaction","detail":"{read_only:false; response_revision:6145; number_of_response:1; }","duration":"222.689176ms","start":"2026-06-15T08:23:03.323834Z","end":"2026-06-15T08:23:03.546523Z","steps":["trace[2104680955] 'process raft request' (duration: 222.432471ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.546969Z","caller":"traceutil/trace.go:171","msg":"trace[581373099] transaction","detail":"{read_only:false; response_revision:6146; number_of_response:1; }","duration":"221.803037ms","start":"2026-06-15T08:23:03.325131Z","end":"2026-06-15T08:23:03.546934Z","steps":["trace[581373099] 'process raft request' (duration: 221.352866ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.546993Z","caller":"traceutil/trace.go:171","msg":"trace[1977045910] linearizableReadLoop","detail":"{readStateIndex:6364; appliedIndex:6361; }","duration":"222.143664ms","start":"2026-06-15T08:23:03.324826Z","end":"2026-06-15T08:23:03.54697Z","steps":["trace[1977045910] 'read index received' (duration: 58.464031ms)","trace[1977045910] 'applied index is now lower than readState.Index' (duration: 163.678353ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.547451Z","caller":"traceutil/trace.go:171","msg":"trace[385449410] transaction","detail":"{read_only:false; response_revision:6147; number_of_response:1; }","duration":"215.803919ms","start":"2026-06-15T08:23:03.331629Z","end":"2026-06-15T08:23:03.547433Z","steps":["trace[385449410] 'process raft request' (duration: 215.257307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.547792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.943952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:14 size:126511"} {"level":"info","ts":"2026-06-15T08:23:03.547848Z","caller":"traceutil/trace.go:171","msg":"trace[1714197323] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:14; response_revision:6147; }","duration":"223.030225ms","start":"2026-06-15T08:23:03.324806Z","end":"2026-06-15T08:23:03.547836Z","steps":["trace[1714197323] 'agreement among raft nodes before linearized reading' (duration: 222.669206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.548006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.182532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:23:03.548123Z","caller":"traceutil/trace.go:171","msg":"trace[151123353] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:6147; }","duration":"207.373296ms","start":"2026-06-15T08:23:03.340735Z","end":"2026-06-15T08:23:03.548108Z","steps":["trace[151123353] 'agreement among raft nodes before linearized reading' (duration: 207.190292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.54825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.356747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T08:23:03.548298Z","caller":"traceutil/trace.go:171","msg":"trace[1098511631] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:6147; }","duration":"105.422778ms","start":"2026-06-15T08:23:03.442865Z","end":"2026-06-15T08:23:03.548287Z","steps":["trace[1098511631] 'agreement among raft nodes before linearized reading' (duration: 105.325336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.548383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.834402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-db-sync-2r7p7\" ","response":"range_response_count:1 size:10021"} {"level":"info","ts":"2026-06-15T08:23:03.548435Z","caller":"traceutil/trace.go:171","msg":"trace[1033211139] range","detail":"{range_begin:/registry/pods/openstack/keystone-db-sync-2r7p7; range_end:; response_count:1; response_revision:6147; }","duration":"154.931424ms","start":"2026-06-15T08:23:03.393491Z","end":"2026-06-15T08:23:03.548422Z","steps":["trace[1033211139] 'agreement among raft nodes before linearized reading' (duration: 154.779821ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.771166Z","caller":"traceutil/trace.go:171","msg":"trace[1001197597] linearizableReadLoop","detail":"{readStateIndex:6367; appliedIndex:6366; }","duration":"171.742318ms","start":"2026-06-15T08:23:03.599401Z","end":"2026-06-15T08:23:03.771143Z","steps":["trace[1001197597] 'read index received' (duration: 171.548644ms)","trace[1001197597] 'applied index is now lower than readState.Index' (duration: 192.834µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:23:03.771591Z","caller":"traceutil/trace.go:171","msg":"trace[1678840416] transaction","detail":"{read_only:false; response_revision:6148; number_of_response:1; }","duration":"214.461938ms","start":"2026-06-15T08:23:03.557114Z","end":"2026-06-15T08:23:03.771575Z","steps":["trace[1678840416] 'process raft request' (duration: 213.898925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:23:03.771949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.528188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T08:23:03.772244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.054454ms","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-06-15T08:23:03.772318Z","caller":"traceutil/trace.go:171","msg":"trace[922549641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6148; }","duration":"134.177837ms","start":"2026-06-15T08:23:03.638122Z","end":"2026-06-15T08:23:03.7723Z","steps":["trace[922549641] 'agreement among raft nodes before linearized reading' (duration: 133.976933ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:03.77226Z","caller":"traceutil/trace.go:171","msg":"trace[1692612625] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:6148; }","duration":"172.881705ms","start":"2026-06-15T08:23:03.599358Z","end":"2026-06-15T08:23:03.772239Z","steps":["trace[1692612625] 'agreement among raft nodes before linearized reading' (duration: 172.519066ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:04.002716Z","caller":"traceutil/trace.go:171","msg":"trace[901376937] transaction","detail":"{read_only:false; response_revision:6149; number_of_response:1; }","duration":"226.494324ms","start":"2026-06-15T08:23:03.776182Z","end":"2026-06-15T08:23:04.002676Z","steps":["trace[901376937] 'process raft request' (duration: 189.054376ms)","trace[901376937] 'compare' (duration: 37.196503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:23:04.925944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.585077ms","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-06-15T08:23:04.926056Z","caller":"traceutil/trace.go:171","msg":"trace[2006524360] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6150; }","duration":"114.70902ms","start":"2026-06-15T08:23:04.81133Z","end":"2026-06-15T08:23:04.926039Z","steps":["trace[2006524360] 'range keys from in-memory index tree' (duration: 114.572337ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:04.926338Z","caller":"traceutil/trace.go:171","msg":"trace[86863759] transaction","detail":"{read_only:false; response_revision:6151; number_of_response:1; }","duration":"143.133653ms","start":"2026-06-15T08:23:04.783189Z","end":"2026-06-15T08:23:04.926322Z","steps":["trace[86863759] 'process raft request' (duration: 142.813435ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:23:32.49246Z","caller":"traceutil/trace.go:171","msg":"trace[370274303] transaction","detail":"{read_only:false; response_revision:6344; number_of_response:1; }","duration":"110.909094ms","start":"2026-06-15T08:23:32.381525Z","end":"2026-06-15T08:23:32.492434Z","steps":["trace[370274303] 'process raft request' (duration: 31.104113ms)","trace[370274303] 'compare' (duration: 79.653338ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:24:26.146774Z","caller":"traceutil/trace.go:171","msg":"trace[476521028] transaction","detail":"{read_only:false; response_revision:6628; number_of_response:1; }","duration":"104.166364ms","start":"2026-06-15T08:24:26.042546Z","end":"2026-06-15T08:24:26.146713Z","steps":["trace[476521028] 'process raft request' (duration: 95.004293ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:27:48.400856Z","caller":"traceutil/trace.go:171","msg":"trace[339635548] transaction","detail":"{read_only:false; response_revision:8231; number_of_response:1; }","duration":"226.651061ms","start":"2026-06-15T08:27:48.174181Z","end":"2026-06-15T08:27:48.400832Z","steps":["trace[339635548] 'process raft request' (duration: 226.476067ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:27:48.658579Z","caller":"traceutil/trace.go:171","msg":"trace[1416002816] transaction","detail":"{read_only:false; response_revision:8233; number_of_response:1; }","duration":"454.07247ms","start":"2026-06-15T08:27:48.204482Z","end":"2026-06-15T08:27:48.658554Z","steps":["trace[1416002816] 'process raft request' (duration: 454.020669ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:27:48.658687Z","caller":"traceutil/trace.go:171","msg":"trace[1128937082] transaction","detail":"{read_only:false; response_revision:8232; number_of_response:1; }","duration":"456.20848ms","start":"2026-06-15T08:27:48.202431Z","end":"2026-06-15T08:27:48.658639Z","steps":["trace[1128937082] 'process raft request' (duration: 455.919413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:27:48.658739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:27:48.204475Z","time spent":"454.183052ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:27:48.658897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:27:48.202418Z","time spent":"456.381794ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:27:50.0903Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6067} {"level":"info","ts":"2026-06-15T08:27:50.249942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6067,"took":"157.58183ms","hash":3195895735,"current-db-size-bytes":58298368,"current-db-size":"58 MB","current-db-size-in-use-bytes":23822336,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-15T08:27:50.249997Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3195895735,"revision":6067,"compact-revision":2967} {"level":"info","ts":"2026-06-15T08:27:59.776878Z","caller":"traceutil/trace.go:171","msg":"trace[338771318] transaction","detail":"{read_only:false; response_revision:8292; number_of_response:1; }","duration":"259.715773ms","start":"2026-06-15T08:27:59.517139Z","end":"2026-06-15T08:27:59.776855Z","steps":["trace[338771318] 'process raft request' (duration: 259.56387ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:00.028642Z","caller":"traceutil/trace.go:171","msg":"trace[1684356763] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"137.518289ms","start":"2026-06-15T08:27:59.891098Z","end":"2026-06-15T08:28:00.028616Z","steps":["trace[1684356763] 'process raft request' (duration: 137.348555ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:00.063329Z","caller":"traceutil/trace.go:171","msg":"trace[574191340] transaction","detail":"{read_only:false; response_revision:8294; number_of_response:1; }","duration":"107.005655ms","start":"2026-06-15T08:27:59.956297Z","end":"2026-06-15T08:28:00.063302Z","steps":["trace[574191340] 'process raft request' (duration: 106.82724ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:00.819881Z","caller":"traceutil/trace.go:171","msg":"trace[378559499] transaction","detail":"{read_only:false; response_revision:8296; number_of_response:1; }","duration":"121.53311ms","start":"2026-06-15T08:28:00.698318Z","end":"2026-06-15T08:28:00.819852Z","steps":["trace[378559499] 'process raft request' (duration: 121.369046ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:00.982685Z","caller":"traceutil/trace.go:171","msg":"trace[2063155477] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"246.722834ms","start":"2026-06-15T08:28:00.735927Z","end":"2026-06-15T08:28:00.98265Z","steps":["trace[2063155477] 'process raft request' (duration: 202.216248ms)","trace[2063155477] 'compare' (duration: 44.24907ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:28:01.27504Z","caller":"traceutil/trace.go:171","msg":"trace[1923888707] linearizableReadLoop","detail":"{readStateIndex:8592; appliedIndex:8591; }","duration":"115.376758ms","start":"2026-06-15T08:28:01.159638Z","end":"2026-06-15T08:28:01.275015Z","steps":["trace[1923888707] 'read index received' (duration: 75.960899ms)","trace[1923888707] 'applied index is now lower than readState.Index' (duration: 39.414359ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:28:01.275216Z","caller":"traceutil/trace.go:171","msg":"trace[2017133378] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"132.169036ms","start":"2026-06-15T08:28:01.142998Z","end":"2026-06-15T08:28:01.275167Z","steps":["trace[2017133378] 'process raft request' (duration: 92.636804ms)","trace[2017133378] 'compare' (duration: 39.256694ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:28:01.275426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.775368ms","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-06-15T08:28:01.275465Z","caller":"traceutil/trace.go:171","msg":"trace[1859972619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8300; }","duration":"115.853389ms","start":"2026-06-15T08:28:01.159603Z","end":"2026-06-15T08:28:01.275457Z","steps":["trace[1859972619] 'agreement among raft nodes before linearized reading' (duration: 115.745687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:26.649911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.220627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-mon-endpoints\" ","response":"range_response_count:1 size:389"} {"level":"info","ts":"2026-06-15T08:28:26.650016Z","caller":"traceutil/trace.go:171","msg":"trace[1142199914] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-mon-endpoints; range_end:; response_count:1; response_revision:8485; }","duration":"119.3824ms","start":"2026-06-15T08:28:26.53061Z","end":"2026-06-15T08:28:26.649992Z","steps":["trace[1142199914] 'range keys from in-memory index tree' (duration: 118.958969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:30.03416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.347855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v92p2\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-06-15T08:28:30.034245Z","caller":"traceutil/trace.go:171","msg":"trace[2080728270] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v92p2; range_end:; response_count:1; response_revision:8505; }","duration":"393.477318ms","start":"2026-06-15T08:28:29.640747Z","end":"2026-06-15T08:28:30.034224Z","steps":["trace[2080728270] 'range keys from in-memory index tree' (duration: 393.199112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:30.034282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:28:29.640726Z","time spent":"393.54616ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-v92p2\" "} {"level":"info","ts":"2026-06-15T08:28:30.381012Z","caller":"traceutil/trace.go:171","msg":"trace[1418539227] transaction","detail":"{read_only:false; response_revision:8506; number_of_response:1; }","duration":"341.924148ms","start":"2026-06-15T08:28:30.039055Z","end":"2026-06-15T08:28:30.38098Z","steps":["trace[1418539227] 'process raft request' (duration: 341.700303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:30.381217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:28:30.039034Z","time spent":"342.078652ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T08:28:30.387088Z","caller":"traceutil/trace.go:171","msg":"trace[269320820] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"208.931601ms","start":"2026-06-15T08:28:30.178121Z","end":"2026-06-15T08:28:30.387053Z","steps":["trace[269320820] 'process raft request' (duration: 208.753487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:42.75832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.841199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T08:28:42.758457Z","caller":"traceutil/trace.go:171","msg":"trace[1315418348] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"293.230755ms","start":"2026-06-15T08:28:42.465218Z","end":"2026-06-15T08:28:42.758448Z","steps":["trace[1315418348] 'process raft request' (duration: 293.178264ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:42.758451Z","caller":"traceutil/trace.go:171","msg":"trace[1555232601] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"322.423628ms","start":"2026-06-15T08:28:42.435998Z","end":"2026-06-15T08:28:42.758421Z","steps":["trace[1555232601] 'process raft request' (duration: 152.411325ms)","trace[1555232601] 'compare' (duration: 169.481321ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:28:42.758638Z","caller":"traceutil/trace.go:171","msg":"trace[282138191] linearizableReadLoop","detail":"{readStateIndex:8921; appliedIndex:8920; }","duration":"320.288819ms","start":"2026-06-15T08:28:42.43834Z","end":"2026-06-15T08:28:42.758629Z","steps":["trace[282138191] 'read index received' (duration: 150.072622ms)","trace[282138191] 'applied index is now lower than readState.Index' (duration: 170.215307ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:28:42.758731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:28:42.435972Z","time spent":"322.615783ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T08:28:42.758877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.560126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-mntfk\" ","response":"range_response_count:1 size:4650"} {"level":"info","ts":"2026-06-15T08:28:42.758906Z","caller":"traceutil/trace.go:171","msg":"trace[1330837038] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-mntfk; range_end:; response_count:1; response_revision:8616; }","duration":"320.625317ms","start":"2026-06-15T08:28:42.438272Z","end":"2026-06-15T08:28:42.758898Z","steps":["trace[1330837038] 'agreement among raft nodes before linearized reading' (duration: 320.534424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:42.758926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:28:42.438229Z","time spent":"320.691288ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4672,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-mntfk\" "} {"level":"info","ts":"2026-06-15T08:28:42.94292Z","caller":"traceutil/trace.go:171","msg":"trace[96880840] linearizableReadLoop","detail":"{readStateIndex:8923; appliedIndex:8922; }","duration":"184.242141ms","start":"2026-06-15T08:28:42.758658Z","end":"2026-06-15T08:28:42.9429Z","steps":["trace[96880840] 'read index received' (duration: 169.401128ms)","trace[96880840] 'applied index is now lower than readState.Index' (duration: 14.840423ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:28:42.942973Z","caller":"traceutil/trace.go:171","msg":"trace[326851306] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"237.684943ms","start":"2026-06-15T08:28:42.705271Z","end":"2026-06-15T08:28:42.942956Z","steps":["trace[326851306] 'process raft request' (duration: 222.783388ms)","trace[326851306] 'compare' (duration: 14.718871ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:28:42.943093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7758dc77cc-85m2n.18b933c834f399ac\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-06-15T08:28:42.943121Z","caller":"traceutil/trace.go:171","msg":"trace[1455042968] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7758dc77cc-85m2n.18b933c834f399ac; range_end:; response_count:1; response_revision:8617; }","duration":"363.319871ms","start":"2026-06-15T08:28:42.579792Z","end":"2026-06-15T08:28:42.943112Z","steps":["trace[1455042968] 'agreement among raft nodes before linearized reading' (duration: 363.206589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:42.943142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:28:42.579773Z","time spent":"363.362743ms","remote":"127.0.0.1:54896","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-7758dc77cc-85m2n.18b933c834f399ac\" "} {"level":"warn","ts":"2026-06-15T08:28:42.943134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.82052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-15T08:28:42.943171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.090294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-15T08:28:42.943198Z","caller":"traceutil/trace.go:171","msg":"trace[1058289658] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8617; }","duration":"199.926493ms","start":"2026-06-15T08:28:42.743258Z","end":"2026-06-15T08:28:42.943184Z","steps":["trace[1058289658] 'agreement among raft nodes before linearized reading' (duration: 199.698748ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:42.943211Z","caller":"traceutil/trace.go:171","msg":"trace[1440859027] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:8617; }","duration":"183.131345ms","start":"2026-06-15T08:28:42.76007Z","end":"2026-06-15T08:28:42.943201Z","steps":["trace[1440859027] 'agreement among raft nodes before linearized reading' (duration: 183.025873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:42.943277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.466762ms","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-06-15T08:28:42.943305Z","caller":"traceutil/trace.go:171","msg":"trace[1462431274] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:8617; }","duration":"157.511174ms","start":"2026-06-15T08:28:42.785785Z","end":"2026-06-15T08:28:42.943297Z","steps":["trace[1462431274] 'agreement among raft nodes before linearized reading' (duration: 157.469483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:42.943321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.14784ms","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-06-15T08:28:42.94337Z","caller":"traceutil/trace.go:171","msg":"trace[1013726838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8617; }","duration":"468.219452ms","start":"2026-06-15T08:28:42.475133Z","end":"2026-06-15T08:28:42.943353Z","steps":["trace[1013726838] 'agreement among raft nodes before linearized reading' (duration: 468.035748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:42.943412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T08:28:42.47512Z","time spent":"468.280983ms","remote":"127.0.0.1:55102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T08:28:43.256736Z","caller":"traceutil/trace.go:171","msg":"trace[875327168] linearizableReadLoop","detail":"{readStateIndex:8927; appliedIndex:8926; }","duration":"102.225628ms","start":"2026-06-15T08:28:43.154488Z","end":"2026-06-15T08:28:43.256713Z","steps":["trace[875327168] 'read index received' (duration: 102.042564ms)","trace[875327168] 'applied index is now lower than readState.Index' (duration: 182.184µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:28:43.256837Z","caller":"traceutil/trace.go:171","msg":"trace[871315101] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"102.497535ms","start":"2026-06-15T08:28:43.154329Z","end":"2026-06-15T08:28:43.256827Z","steps":["trace[871315101] 'process raft request' (duration: 102.254049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:43.257108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.607658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-mntfk\" ","response":"range_response_count:1 size:4650"} {"level":"info","ts":"2026-06-15T08:28:43.257183Z","caller":"traceutil/trace.go:171","msg":"trace[845126038] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-mntfk; range_end:; response_count:1; response_revision:8621; }","duration":"102.691349ms","start":"2026-06-15T08:28:43.154475Z","end":"2026-06-15T08:28:43.257166Z","steps":["trace[845126038] 'agreement among raft nodes before linearized reading' (duration: 102.482415ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:43.290836Z","caller":"traceutil/trace.go:171","msg":"trace[526177069] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"114.174025ms","start":"2026-06-15T08:28:43.176633Z","end":"2026-06-15T08:28:43.290807Z","steps":["trace[526177069] 'process raft request' (duration: 114.004001ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:43.290859Z","caller":"traceutil/trace.go:171","msg":"trace[1837530239] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"133.005709ms","start":"2026-06-15T08:28:43.157826Z","end":"2026-06-15T08:28:43.290832Z","steps":["trace[1837530239] 'process raft request' (duration: 126.023078ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:43.654769Z","caller":"traceutil/trace.go:171","msg":"trace[1858107069] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"109.194809ms","start":"2026-06-15T08:28:43.545519Z","end":"2026-06-15T08:28:43.654714Z","steps":["trace[1858107069] 'process raft request' (duration: 108.926933ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:57.233702Z","caller":"traceutil/trace.go:171","msg":"trace[1634162821] linearizableReadLoop","detail":"{readStateIndex:9038; appliedIndex:9036; }","duration":"127.098591ms","start":"2026-06-15T08:28:57.106579Z","end":"2026-06-15T08:28:57.233678Z","steps":["trace[1634162821] 'read index received' (duration: 116.22328ms)","trace[1634162821] 'applied index is now lower than readState.Index' (duration: 10.874061ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:28:57.233882Z","caller":"traceutil/trace.go:171","msg":"trace[1879265008] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"154.870913ms","start":"2026-06-15T08:28:57.078997Z","end":"2026-06-15T08:28:57.233868Z","steps":["trace[1879265008] 'process raft request' (duration: 154.622817ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:28:57.233731Z","caller":"traceutil/trace.go:171","msg":"trace[1603990968] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"233.728912ms","start":"2026-06-15T08:28:56.999965Z","end":"2026-06-15T08:28:57.233694Z","steps":["trace[1603990968] 'process raft request' (duration: 222.85135ms)","trace[1603990968] 'compare' (duration: 10.549164ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:28:57.234024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.434889ms","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-06-15T08:28:57.23416Z","caller":"traceutil/trace.go:171","msg":"trace[203982299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8729; }","duration":"127.611984ms","start":"2026-06-15T08:28:57.106526Z","end":"2026-06-15T08:28:57.234138Z","steps":["trace[203982299] 'agreement among raft nodes before linearized reading' (duration: 127.366768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T08:28:57.233954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.801932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T08:28:57.23423Z","caller":"traceutil/trace.go:171","msg":"trace[1587159516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8729; }","duration":"103.090808ms","start":"2026-06-15T08:28:57.131124Z","end":"2026-06-15T08:28:57.234215Z","steps":["trace[1587159516] 'agreement among raft nodes before linearized reading' (duration: 102.761721ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:29:02.654976Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023bb.wal"} {"level":"info","ts":"2026-06-15T08:30:01.401187Z","caller":"traceutil/trace.go:171","msg":"trace[169653241] transaction","detail":"{read_only:false; response_revision:9374; number_of_response:1; }","duration":"120.551061ms","start":"2026-06-15T08:30:01.280611Z","end":"2026-06-15T08:30:01.401162Z","steps":["trace[169653241] 'process raft request' (duration: 59.303618ms)","trace[169653241] 'compare' (duration: 61.141191ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:30:01.642598Z","caller":"traceutil/trace.go:171","msg":"trace[841576331] linearizableReadLoop","detail":"{readStateIndex:9702; appliedIndex:9701; }","duration":"103.531388ms","start":"2026-06-15T08:30:01.539037Z","end":"2026-06-15T08:30:01.642569Z","steps":["trace[841576331] 'read index received' (duration: 64.126649ms)","trace[841576331] 'applied index is now lower than readState.Index' (duration: 39.403649ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T08:30:01.642679Z","caller":"traceutil/trace.go:171","msg":"trace[1389324405] transaction","detail":"{read_only:false; response_revision:9376; number_of_response:1; }","duration":"163.83726ms","start":"2026-06-15T08:30:01.478808Z","end":"2026-06-15T08:30:01.642645Z","steps":["trace[1389324405] 'process raft request' (duration: 124.341219ms)","trace[1389324405] 'compare' (duration: 39.172244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T08:30:01.64297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.915358ms","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-06-15T08:30:01.643018Z","caller":"traceutil/trace.go:171","msg":"trace[2053641966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9376; }","duration":"104.019259ms","start":"2026-06-15T08:30:01.538986Z","end":"2026-06-15T08:30:01.643006Z","steps":["trace[2053641966] 'agreement among raft nodes before linearized reading' (duration: 103.690902ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:30:41.316562Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5f170c75a1d97cc","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T08:30:41.322274Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-15T08:30:41.322361Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-15T08:31:52.784213Z","caller":"traceutil/trace.go:171","msg":"trace[768777457] transaction","detail":"{read_only:false; response_revision:10177; number_of_response:1; }","duration":"123.167614ms","start":"2026-06-15T08:31:52.661021Z","end":"2026-06-15T08:31:52.784188Z","steps":["trace[768777457] 'process raft request' (duration: 122.56309ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T08:32:50.097768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8241} {"level":"info","ts":"2026-06-15T08:32:50.178466Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8241,"took":"78.466537ms","hash":1414495665,"current-db-size-bytes":58298368,"current-db-size":"58 MB","current-db-size-in-use-bytes":26226688,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-15T08:32:50.178569Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1414495665,"revision":8241,"compact-revision":6067}