{"level":"warn","ts":"2026-09-30T07:48:32.049292Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-30T07:48:32.049374Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.210: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://162.253.55.210:2380","--initial-cluster=instance=https://162.253.55.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.210: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-09-30T07:48:32.049433Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-30T07:48:32.049442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.210:2380"]} {"level":"info","ts":"2026-09-30T07:48:32.049459Z","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-09-30T07:48:32.050082Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.210:2379"]} {"level":"info","ts":"2026-09-30T07:48:32.050165Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.210:2380"],"listen-peer-urls":["https://162.253.55.210:2380"],"advertise-client-urls":["https://162.253.55.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.210: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-09-30T07:48:32.057339Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.977499ms"} {"level":"info","ts":"2026-09-30T07:48:32.074851Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6d0019d52d78795","cluster-id":"c90109516379646"} {"level":"info","ts":"2026-09-30T07:48:32.075059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 switched to configuration voters=()"} {"level":"info","ts":"2026-09-30T07:48:32.07514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became follower at term 0"} {"level":"info","ts":"2026-09-30T07:48:32.075156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6d0019d52d78795 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-30T07:48:32.075163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became follower at term 1"} {"level":"info","ts":"2026-09-30T07:48:32.075203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 switched to configuration voters=(12020109180663203733)"} {"level":"warn","ts":"2026-09-30T07:48:32.085763Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-30T07:48:32.087116Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-30T07:48:32.088404Z","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-09-30T07:48:32.092979Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6d0019d52d78795","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-30T07:48:32.093315Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6d0019d52d78795","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-30T07:48:32.093446Z","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-09-30T07:48:32.09351Z","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-09-30T07:48:32.093519Z","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-09-30T07:48:32.099539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 switched to configuration voters=(12020109180663203733)"} {"level":"info","ts":"2026-09-30T07:48:32.100612Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c90109516379646","local-member-id":"a6d0019d52d78795","added-peer-id":"a6d0019d52d78795","added-peer-peer-urls":["https://162.253.55.210:2380"]} {"level":"info","ts":"2026-09-30T07:48:32.10227Z","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-09-30T07:48:32.10251Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6d0019d52d78795","initial-advertise-peer-urls":["https://162.253.55.210:2380"],"listen-peer-urls":["https://162.253.55.210:2380"],"advertise-client-urls":["https://162.253.55.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-30T07:48:32.102535Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-30T07:48:32.102674Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.210:2380"} {"level":"info","ts":"2026-09-30T07:48:32.102691Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.210:2380"} {"level":"info","ts":"2026-09-30T07:48:32.475916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 is starting a new election at term 1"} {"level":"info","ts":"2026-09-30T07:48:32.476077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-30T07:48:32.476383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 received MsgPreVoteResp from a6d0019d52d78795 at term 1"} {"level":"info","ts":"2026-09-30T07:48:32.476447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became candidate at term 2"} {"level":"info","ts":"2026-09-30T07:48:32.476506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 received MsgVoteResp from a6d0019d52d78795 at term 2"} {"level":"info","ts":"2026-09-30T07:48:32.476583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became leader at term 2"} {"level":"info","ts":"2026-09-30T07:48:32.476627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6d0019d52d78795 elected leader a6d0019d52d78795 at term 2"} {"level":"info","ts":"2026-09-30T07:48:32.478968Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T07:48:32.480665Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6d0019d52d78795","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.210:2379]}","request-path":"/0/members/a6d0019d52d78795/attributes","cluster-id":"c90109516379646","publish-timeout":"7s"} {"level":"info","ts":"2026-09-30T07:48:32.480704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-30T07:48:32.480845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-30T07:48:32.48124Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-30T07:48:32.481312Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-30T07:48:32.483678Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c90109516379646","local-member-id":"a6d0019d52d78795","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T07:48:32.483955Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T07:48:32.484079Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T07:48:32.484769Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.210:2379"} {"level":"info","ts":"2026-09-30T07:48:32.486389Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-30T07:48:35.834766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.8616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-30T07:48:35.834871Z","caller":"traceutil/trace.go:171","msg":"trace[1821062123] linearizableReadLoop","detail":"{readStateIndex:81; appliedIndex:80; }","duration":"419.481835ms","start":"2026-09-30T07:48:35.415374Z","end":"2026-09-30T07:48:35.834855Z","steps":["trace[1821062123] 'read index received' (duration: 34.25µs)","trace[1821062123] 'applied index is now lower than readState.Index' (duration: 419.443615ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:48:35.835117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.741326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-30T07:48:35.835155Z","caller":"traceutil/trace.go:171","msg":"trace[1528498023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:77; }","duration":"419.814428ms","start":"2026-09-30T07:48:35.415328Z","end":"2026-09-30T07:48:35.835143Z","steps":["trace[1528498023] 'agreement among raft nodes before linearized reading' (duration: 419.575206ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:48:35.835195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T07:48:35.415313Z","time spent":"419.875058ms","remote":"127.0.0.1:37270","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-09-30T07:48:35.83521Z","caller":"traceutil/trace.go:171","msg":"trace[2135596834] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"432.945022ms","start":"2026-09-30T07:48:35.40216Z","end":"2026-09-30T07:48:35.835105Z","steps":["trace[2135596834] 'compare' (duration: 424.713089ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:48:35.835936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T07:48:35.402143Z","time spent":"433.147864ms","remote":"127.0.0.1:37618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":665,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-30T07:48:36.474994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.808834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-30T07:48:36.475273Z","caller":"traceutil/trace.go:171","msg":"trace[1424012516] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"630.994821ms","start":"2026-09-30T07:48:35.844247Z","end":"2026-09-30T07:48:36.475242Z","steps":["trace[1424012516] 'process raft request' (duration: 391.856905ms)","trace[1424012516] 'compare' (duration: 238.673043ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:48:36.475465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T07:48:35.844206Z","time spent":"631.173563ms","remote":"127.0.0.1:37618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":600,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-30T07:48:36.629868Z","caller":"traceutil/trace.go:171","msg":"trace[95752240] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"148.52594ms","start":"2026-09-30T07:48:36.481315Z","end":"2026-09-30T07:48:36.629841Z","steps":["trace[95752240] 'process raft request' (duration: 145.763732ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:48:42.215169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.126091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-30T07:48:42.21525Z","caller":"traceutil/trace.go:171","msg":"trace[404631421] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:337; }","duration":"115.287767ms","start":"2026-09-30T07:48:42.099946Z","end":"2026-09-30T07:48:42.215234Z","steps":["trace[404631421] 'range keys from in-memory index tree' (duration: 115.042822ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.050503Z","caller":"traceutil/trace.go:171","msg":"trace[2049677741] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"188.50631ms","start":"2026-09-30T07:49:13.861969Z","end":"2026-09-30T07:49:14.050475Z","steps":["trace[2049677741] 'process raft request' (duration: 188.256873ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.05828Z","caller":"traceutil/trace.go:171","msg":"trace[718972536] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"150.182152ms","start":"2026-09-30T07:49:13.908087Z","end":"2026-09-30T07:49:14.058269Z","steps":["trace[718972536] 'process raft request' (duration: 149.770453ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.058533Z","caller":"traceutil/trace.go:171","msg":"trace[365869665] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"138.96312ms","start":"2026-09-30T07:49:13.919515Z","end":"2026-09-30T07:49:14.058478Z","steps":["trace[365869665] 'process raft request' (duration: 138.52756ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.05854Z","caller":"traceutil/trace.go:171","msg":"trace[131500811] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"192.796282ms","start":"2026-09-30T07:49:13.865674Z","end":"2026-09-30T07:49:14.05847Z","steps":["trace[131500811] 'process raft request' (duration: 191.863528ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.05855Z","caller":"traceutil/trace.go:171","msg":"trace[978017558] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"156.631852ms","start":"2026-09-30T07:49:13.901871Z","end":"2026-09-30T07:49:14.058503Z","steps":["trace[978017558] 'process raft request' (duration: 155.930663ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.058721Z","caller":"traceutil/trace.go:171","msg":"trace[1473793969] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"142.792327ms","start":"2026-09-30T07:49:13.915915Z","end":"2026-09-30T07:49:14.058707Z","steps":["trace[1473793969] 'process raft request' (duration: 142.082698ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.058788Z","caller":"traceutil/trace.go:171","msg":"trace[1429859871] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"187.837736ms","start":"2026-09-30T07:49:13.870935Z","end":"2026-09-30T07:49:14.058773Z","steps":["trace[1429859871] 'process raft request' (duration: 186.72734ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.05889Z","caller":"traceutil/trace.go:171","msg":"trace[477736139] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"122.724657ms","start":"2026-09-30T07:49:13.936139Z","end":"2026-09-30T07:49:14.058864Z","steps":["trace[477736139] 'process raft request' (duration: 121.946954ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.058935Z","caller":"traceutil/trace.go:171","msg":"trace[1931280136] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:561; }","duration":"142.374887ms","start":"2026-09-30T07:49:13.916544Z","end":"2026-09-30T07:49:14.058919Z","steps":["trace[1931280136] 'read index received' (duration: 133.883523ms)","trace[1931280136] 'applied index is now lower than readState.Index' (duration: 8.489534ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:49:14.058972Z","caller":"traceutil/trace.go:171","msg":"trace[1044019490] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"100.38356ms","start":"2026-09-30T07:49:13.95858Z","end":"2026-09-30T07:49:14.058963Z","steps":["trace[1044019490] 'process raft request' (duration: 99.712954ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.058981Z","caller":"traceutil/trace.go:171","msg":"trace[296727379] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"122.363742ms","start":"2026-09-30T07:49:13.936567Z","end":"2026-09-30T07:49:14.05893Z","steps":["trace[296727379] 'process raft request' (duration: 121.643783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:49:14.059166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.573962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-30T07:49:14.059207Z","caller":"traceutil/trace.go:171","msg":"trace[2105909542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"142.699119ms","start":"2026-09-30T07:49:13.916496Z","end":"2026-09-30T07:49:14.059195Z","steps":["trace[2105909542] 'agreement among raft nodes before linearized reading' (duration: 142.503076ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:14.058218Z","caller":"traceutil/trace.go:171","msg":"trace[2025165706] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"156.792052ms","start":"2026-09-30T07:49:13.901403Z","end":"2026-09-30T07:49:14.058195Z","steps":["trace[2025165706] 'process raft request' (duration: 156.31506ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:15.208347Z","caller":"traceutil/trace.go:171","msg":"trace[1707386034] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"263.399015ms","start":"2026-09-30T07:49:14.94493Z","end":"2026-09-30T07:49:15.208329Z","steps":["trace[1707386034] 'process raft request' (duration: 199.41622ms)","trace[1707386034] 'compare' (duration: 63.705457ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:49:15.211137Z","caller":"traceutil/trace.go:171","msg":"trace[1400917915] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"160.755702ms","start":"2026-09-30T07:49:15.050369Z","end":"2026-09-30T07:49:15.211124Z","steps":["trace[1400917915] 'process raft request' (duration: 160.524946ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:49:20.478337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.06203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8xwpf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-30T07:49:20.478474Z","caller":"traceutil/trace.go:171","msg":"trace[578569142] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8xwpf; range_end:; response_count:1; response_revision:645; }","duration":"137.22957ms","start":"2026-09-30T07:49:20.341218Z","end":"2026-09-30T07:49:20.478447Z","steps":["trace[578569142] 'range keys from in-memory index tree' (duration: 136.757179ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:20.665765Z","caller":"traceutil/trace.go:171","msg":"trace[759866777] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"166.104994ms","start":"2026-09-30T07:49:20.499627Z","end":"2026-09-30T07:49:20.665732Z","steps":["trace[759866777] 'process raft request' (duration: 165.89633ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:49:21.0443Z","caller":"traceutil/trace.go:171","msg":"trace[1195113469] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"313.221698ms","start":"2026-09-30T07:49:20.730975Z","end":"2026-09-30T07:49:21.044197Z","steps":["trace[1195113469] 'process raft request' (duration: 312.512563ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:49:21.044686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T07:49:20.730886Z","time spent":"313.492705ms","remote":"127.0.0.1:37332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T07:50:45.723273Z","caller":"traceutil/trace.go:171","msg":"trace[1140603207] transaction","detail":"{read_only:false; response_revision:1698; number_of_response:1; }","duration":"112.653862ms","start":"2026-09-30T07:50:45.610581Z","end":"2026-09-30T07:50:45.723235Z","steps":["trace[1140603207] 'process raft request' (duration: 96.720793ms)","trace[1140603207] 'compare' (duration: 15.778054ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:50:45.730005Z","caller":"traceutil/trace.go:171","msg":"trace[1657717909] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"101.816933ms","start":"2026-09-30T07:50:45.628169Z","end":"2026-09-30T07:50:45.729986Z","steps":["trace[1657717909] 'process raft request' (duration: 101.764611ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:50:45.730283Z","caller":"traceutil/trace.go:171","msg":"trace[1365176581] transaction","detail":"{read_only:false; response_revision:1699; number_of_response:1; }","duration":"114.899947ms","start":"2026-09-30T07:50:45.615377Z","end":"2026-09-30T07:50:45.730277Z","steps":["trace[1365176581] 'process raft request' (duration: 114.421032ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:50:45.730493Z","caller":"traceutil/trace.go:171","msg":"trace[917133638] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1699; }","duration":"111.536799ms","start":"2026-09-30T07:50:45.618951Z","end":"2026-09-30T07:50:45.730488Z","steps":["trace[917133638] 'process raft request' (duration: 110.959532ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:50:45.845629Z","caller":"traceutil/trace.go:171","msg":"trace[1487387916] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1702; }","duration":"105.681676ms","start":"2026-09-30T07:50:45.739928Z","end":"2026-09-30T07:50:45.84561Z","steps":["trace[1487387916] 'process raft request' (duration: 103.284066ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:50:45.845817Z","caller":"traceutil/trace.go:171","msg":"trace[1236799534] linearizableReadLoop","detail":"{readStateIndex:1773; appliedIndex:1771; }","duration":"100.962077ms","start":"2026-09-30T07:50:45.744846Z","end":"2026-09-30T07:50:45.845808Z","steps":["trace[1236799534] 'read index received' (duration: 23.214402ms)","trace[1236799534] 'applied index is now lower than readState.Index' (duration: 77.746645ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:50:45.845961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.104512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/rabbitmq-messaging-topology-operator-webhook-openstack\" ","response":"range_response_count:1 size:26978"} {"level":"info","ts":"2026-09-30T07:50:45.84599Z","caller":"traceutil/trace.go:171","msg":"trace[1070721296] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/rabbitmq-messaging-topology-operator-webhook-openstack; range_end:; response_count:1; response_revision:1703; }","duration":"101.184464ms","start":"2026-09-30T07:50:45.744796Z","end":"2026-09-30T07:50:45.845981Z","steps":["trace[1070721296] 'agreement among raft nodes before linearized reading' (duration: 101.04183ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.15387Z","caller":"traceutil/trace.go:171","msg":"trace[1137209791] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1986; }","duration":"194.1713ms","start":"2026-09-30T07:51:01.959676Z","end":"2026-09-30T07:51:02.153847Z","steps":["trace[1137209791] 'read index received' (duration: 194.059307ms)","trace[1137209791] 'applied index is now lower than readState.Index' (duration: 110.823µs)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:51:02.153968Z","caller":"traceutil/trace.go:171","msg":"trace[2022081445] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"221.558549ms","start":"2026-09-30T07:51:01.9324Z","end":"2026-09-30T07:51:02.153958Z","steps":["trace[2022081445] 'process raft request' (duration: 221.296822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:51:02.154272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.57782ms","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-09-30T07:51:02.154348Z","caller":"traceutil/trace.go:171","msg":"trace[682117555] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1909; }","duration":"194.693644ms","start":"2026-09-30T07:51:01.959637Z","end":"2026-09-30T07:51:02.154331Z","steps":["trace[682117555] 'agreement among raft nodes before linearized reading' (duration: 194.513709ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.163407Z","caller":"traceutil/trace.go:171","msg":"trace[601118387] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"126.669285ms","start":"2026-09-30T07:51:02.036718Z","end":"2026-09-30T07:51:02.163387Z","steps":["trace[601118387] 'process raft request' (duration: 126.537621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:51:02.16354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.144335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-30T07:51:02.163648Z","caller":"traceutil/trace.go:171","msg":"trace[36807638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1910; }","duration":"122.279969ms","start":"2026-09-30T07:51:02.041332Z","end":"2026-09-30T07:51:02.163612Z","steps":["trace[36807638] 'agreement among raft nodes before linearized reading' (duration: 122.048292ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.301057Z","caller":"traceutil/trace.go:171","msg":"trace[273941062] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"125.534035ms","start":"2026-09-30T07:51:02.175499Z","end":"2026-09-30T07:51:02.301033Z","steps":["trace[273941062] 'process raft request' (duration: 54.063252ms)","trace[273941062] 'compare' (duration: 71.292528ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:51:02.563657Z","caller":"traceutil/trace.go:171","msg":"trace[1741855682] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"257.342356ms","start":"2026-09-30T07:51:02.306282Z","end":"2026-09-30T07:51:02.563625Z","steps":["trace[1741855682] 'process raft request' (duration: 194.989185ms)","trace[1741855682] 'compare' (duration: 62.062023ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:51:02.564137Z","caller":"traceutil/trace.go:171","msg":"trace[1748656287] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"256.214256ms","start":"2026-09-30T07:51:02.307899Z","end":"2026-09-30T07:51:02.564113Z","steps":["trace[1748656287] 'process raft request' (duration: 255.6127ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.56417Z","caller":"traceutil/trace.go:171","msg":"trace[1701483104] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"256.159325ms","start":"2026-09-30T07:51:02.307989Z","end":"2026-09-30T07:51:02.564149Z","steps":["trace[1701483104] 'process raft request' (duration: 255.58974ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.564421Z","caller":"traceutil/trace.go:171","msg":"trace[671145983] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"256.36137ms","start":"2026-09-30T07:51:02.308045Z","end":"2026-09-30T07:51:02.564407Z","steps":["trace[671145983] 'process raft request' (duration: 255.59934ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.564603Z","caller":"traceutil/trace.go:171","msg":"trace[444219922] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"256.181075ms","start":"2026-09-30T07:51:02.308348Z","end":"2026-09-30T07:51:02.56453Z","steps":["trace[444219922] 'process raft request' (duration: 255.400794ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.565281Z","caller":"traceutil/trace.go:171","msg":"trace[1684151109] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"195.494938ms","start":"2026-09-30T07:51:02.369747Z","end":"2026-09-30T07:51:02.565242Z","steps":["trace[1684151109] 'process raft request' (duration: 195.422706ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:02.565869Z","caller":"traceutil/trace.go:171","msg":"trace[162190442] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"256.965386ms","start":"2026-09-30T07:51:02.308842Z","end":"2026-09-30T07:51:02.565808Z","steps":["trace[162190442] 'process raft request' (duration: 255.583429ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:14.773663Z","caller":"traceutil/trace.go:171","msg":"trace[1304538609] linearizableReadLoop","detail":"{readStateIndex:2101; appliedIndex:2099; }","duration":"142.876371ms","start":"2026-09-30T07:51:14.630766Z","end":"2026-09-30T07:51:14.773643Z","steps":["trace[1304538609] 'read index received' (duration: 49.270164ms)","trace[1304538609] 'applied index is now lower than readState.Index' (duration: 93.605167ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:51:14.77386Z","caller":"traceutil/trace.go:171","msg":"trace[1567913783] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"147.162488ms","start":"2026-09-30T07:51:14.626594Z","end":"2026-09-30T07:51:14.773757Z","steps":["trace[1567913783] 'process raft request' (duration: 98.085338ms)","trace[1567913783] 'compare' (duration: 48.840944ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:51:14.773938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.148777ms","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-09-30T07:51:14.77425Z","caller":"traceutil/trace.go:171","msg":"trace[1612053865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2019; }","duration":"143.460625ms","start":"2026-09-30T07:51:14.630762Z","end":"2026-09-30T07:51:14.774222Z","steps":["trace[1612053865] 'agreement among raft nodes before linearized reading' (duration: 142.971043ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:14.860357Z","caller":"traceutil/trace.go:171","msg":"trace[897675837] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"112.328531ms","start":"2026-09-30T07:51:14.747998Z","end":"2026-09-30T07:51:14.860327Z","steps":["trace[897675837] 'process raft request' (duration: 112.164497ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:18.07279Z","caller":"traceutil/trace.go:171","msg":"trace[1172947532] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"127.766131ms","start":"2026-09-30T07:51:17.945004Z","end":"2026-09-30T07:51:18.07277Z","steps":["trace[1172947532] 'process raft request' (duration: 127.638108ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:51:18.811274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.696603ms","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-09-30T07:51:18.811342Z","caller":"traceutil/trace.go:171","msg":"trace[875258287] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2052; }","duration":"118.809586ms","start":"2026-09-30T07:51:18.692515Z","end":"2026-09-30T07:51:18.811324Z","steps":["trace[875258287] 'range keys from in-memory index tree' (duration: 118.53433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:51:41.19092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.654408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-30T07:51:41.190995Z","caller":"traceutil/trace.go:171","msg":"trace[343204058] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2263; }","duration":"200.227274ms","start":"2026-09-30T07:51:40.990755Z","end":"2026-09-30T07:51:41.190982Z","steps":["trace[343204058] 'read index received' (duration: 85.33903ms)","trace[343204058] 'applied index is now lower than readState.Index' (duration: 114.887434ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:51:41.191135Z","caller":"traceutil/trace.go:171","msg":"trace[1151537103] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"238.930334ms","start":"2026-09-30T07:51:40.952196Z","end":"2026-09-30T07:51:41.191126Z","steps":["trace[1151537103] 'process raft request' (duration: 124.01394ms)","trace[1151537103] 'compare' (duration: 114.537186ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:51:41.191753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.997451ms","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-09-30T07:51:41.191785Z","caller":"traceutil/trace.go:171","msg":"trace[1479075768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2177; }","duration":"201.072222ms","start":"2026-09-30T07:51:40.990705Z","end":"2026-09-30T07:51:41.191778Z","steps":["trace[1479075768] 'agreement among raft nodes before linearized reading' (duration: 200.93923ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:51:41.192348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.045898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-30T07:51:41.192448Z","caller":"traceutil/trace.go:171","msg":"trace[1181537412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2177; }","duration":"162.211961ms","start":"2026-09-30T07:51:41.030218Z","end":"2026-09-30T07:51:41.19243Z","steps":["trace[1181537412] 'agreement among raft nodes before linearized reading' (duration: 161.476195ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:51:42.422097Z","caller":"traceutil/trace.go:171","msg":"trace[1600772961] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"114.392014ms","start":"2026-09-30T07:51:42.30768Z","end":"2026-09-30T07:51:42.422072Z","steps":["trace[1600772961] 'process raft request' (duration: 114.166909ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:53:05.463422Z","caller":"traceutil/trace.go:171","msg":"trace[590589136] linearizableReadLoop","detail":"{readStateIndex:2848; appliedIndex:2847; }","duration":"230.950063ms","start":"2026-09-30T07:53:05.232448Z","end":"2026-09-30T07:53:05.463398Z","steps":["trace[590589136] 'read index received' (duration: 164.076016ms)","trace[590589136] 'applied index is now lower than readState.Index' (duration: 66.873067ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:53:05.463548Z","caller":"traceutil/trace.go:171","msg":"trace[905152850] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"278.120938ms","start":"2026-09-30T07:53:05.185413Z","end":"2026-09-30T07:53:05.463534Z","steps":["trace[905152850] 'process raft request' (duration: 211.178038ms)","trace[905152850] 'compare' (duration: 66.698082ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:53:05.464218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.27068ms","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-09-30T07:53:05.464302Z","caller":"traceutil/trace.go:171","msg":"trace[1524709680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2741; }","duration":"114.399935ms","start":"2026-09-30T07:53:05.349881Z","end":"2026-09-30T07:53:05.464281Z","steps":["trace[1524709680] 'agreement among raft nodes before linearized reading' (duration: 114.170307ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:53:05.464308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.836345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-30T07:53:05.464627Z","caller":"traceutil/trace.go:171","msg":"trace[1045199527] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2741; }","duration":"232.208957ms","start":"2026-09-30T07:53:05.232404Z","end":"2026-09-30T07:53:05.464613Z","steps":["trace[1045199527] 'agreement among raft nodes before linearized reading' (duration: 231.249394ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:53:10.969653Z","caller":"traceutil/trace.go:171","msg":"trace[1336573590] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"129.442638ms","start":"2026-09-30T07:53:10.840189Z","end":"2026-09-30T07:53:10.969631Z","steps":["trace[1336573590] 'process raft request' (duration: 129.318394ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:53:11.077545Z","caller":"traceutil/trace.go:171","msg":"trace[1510032282] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"102.647917ms","start":"2026-09-30T07:53:10.974859Z","end":"2026-09-30T07:53:11.077507Z","steps":["trace[1510032282] 'process raft request' (duration: 76.927944ms)","trace[1510032282] 'compare' (duration: 25.476515ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:57:45.114576Z","caller":"traceutil/trace.go:171","msg":"trace[110096941] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"106.122288ms","start":"2026-09-30T07:57:45.0084Z","end":"2026-09-30T07:57:45.114523Z","steps":["trace[110096941] 'process raft request' (duration: 48.766575ms)","trace[110096941] 'compare' (duration: 56.991696ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:57:45.376264Z","caller":"traceutil/trace.go:171","msg":"trace[224075598] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"123.166783ms","start":"2026-09-30T07:57:45.253059Z","end":"2026-09-30T07:57:45.376226Z","steps":["trace[224075598] 'process raft request' (duration: 97.141462ms)","trace[224075598] 'compare' (duration: 25.759436ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:57:45.376625Z","caller":"traceutil/trace.go:171","msg":"trace[740892500] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"122.932999ms","start":"2026-09-30T07:57:45.253647Z","end":"2026-09-30T07:57:45.37658Z","steps":["trace[740892500] 'process raft request' (duration: 122.748355ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.376637Z","caller":"traceutil/trace.go:171","msg":"trace[1287952975] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"122.818306ms","start":"2026-09-30T07:57:45.253791Z","end":"2026-09-30T07:57:45.37661Z","steps":["trace[1287952975] 'process raft request' (duration: 122.707914ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.376885Z","caller":"traceutil/trace.go:171","msg":"trace[1607420955] linearizableReadLoop","detail":"{readStateIndex:5076; appliedIndex:5069; }","duration":"120.773573ms","start":"2026-09-30T07:57:45.256091Z","end":"2026-09-30T07:57:45.376865Z","steps":["trace[1607420955] 'read index received' (duration: 94.130029ms)","trace[1607420955] 'applied index is now lower than readState.Index' (duration: 26.642404ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:57:45.377097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.984308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-30T07:57:45.37713Z","caller":"traceutil/trace.go:171","msg":"trace[33589365] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4889; }","duration":"121.056509ms","start":"2026-09-30T07:57:45.256066Z","end":"2026-09-30T07:57:45.377123Z","steps":["trace[33589365] 'agreement among raft nodes before linearized reading' (duration: 120.886665ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.377108Z","caller":"traceutil/trace.go:171","msg":"trace[1501055285] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"112.108193ms","start":"2026-09-30T07:57:45.264959Z","end":"2026-09-30T07:57:45.377067Z","steps":["trace[1501055285] 'process raft request' (duration: 111.713224ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.377082Z","caller":"traceutil/trace.go:171","msg":"trace[1257185838] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"123.481189ms","start":"2026-09-30T07:57:45.253557Z","end":"2026-09-30T07:57:45.377038Z","steps":["trace[1257185838] 'process raft request' (duration: 122.598291ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.37715Z","caller":"traceutil/trace.go:171","msg":"trace[929031244] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"120.59366ms","start":"2026-09-30T07:57:45.256527Z","end":"2026-09-30T07:57:45.377121Z","steps":["trace[929031244] 'process raft request' (duration: 120.10401ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.377239Z","caller":"traceutil/trace.go:171","msg":"trace[472426352] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"123.175413ms","start":"2026-09-30T07:57:45.254047Z","end":"2026-09-30T07:57:45.377223Z","steps":["trace[472426352] 'process raft request' (duration: 122.479778ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.377364Z","caller":"traceutil/trace.go:171","msg":"trace[1946513892] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"123.207844ms","start":"2026-09-30T07:57:45.254144Z","end":"2026-09-30T07:57:45.377352Z","steps":["trace[1946513892] 'process raft request' (duration: 122.414567ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:45.377373Z","caller":"traceutil/trace.go:171","msg":"trace[86310754] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"122.706404ms","start":"2026-09-30T07:57:45.254222Z","end":"2026-09-30T07:57:45.376929Z","steps":["trace[86310754] 'process raft request' (duration: 122.378227ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:52.952401Z","caller":"traceutil/trace.go:171","msg":"trace[52474538] linearizableReadLoop","detail":"{readStateIndex:5150; appliedIndex:5149; }","duration":"170.38263ms","start":"2026-09-30T07:57:52.781994Z","end":"2026-09-30T07:57:52.952377Z","steps":["trace[52474538] 'read index received' (duration: 115.802639ms)","trace[52474538] 'applied index is now lower than readState.Index' (duration: 54.578531ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:57:52.952646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.636205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-30T07:57:52.952717Z","caller":"traceutil/trace.go:171","msg":"trace[139398165] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4957; }","duration":"170.759328ms","start":"2026-09-30T07:57:52.781947Z","end":"2026-09-30T07:57:52.952706Z","steps":["trace[139398165] 'agreement among raft nodes before linearized reading' (duration: 170.617755ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:53.122067Z","caller":"traceutil/trace.go:171","msg":"trace[1527937566] linearizableReadLoop","detail":"{readStateIndex:5152; appliedIndex:5150; }","duration":"157.071673ms","start":"2026-09-30T07:57:52.96497Z","end":"2026-09-30T07:57:53.122042Z","steps":["trace[1527937566] 'read index received' (duration: 1.862709ms)","trace[1527937566] 'applied index is now lower than readState.Index' (duration: 155.207844ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:57:53.122322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.326298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-30T07:57:53.122373Z","caller":"traceutil/trace.go:171","msg":"trace[147484751] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4959; }","duration":"157.411869ms","start":"2026-09-30T07:57:52.964943Z","end":"2026-09-30T07:57:53.122355Z","steps":["trace[147484751] 'agreement among raft nodes before linearized reading' (duration: 157.223255ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:53.122664Z","caller":"traceutil/trace.go:171","msg":"trace[1295741299] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"160.040235ms","start":"2026-09-30T07:57:52.962569Z","end":"2026-09-30T07:57:53.12261Z","steps":["trace[1295741299] 'process raft request' (duration: 87.234447ms)","trace[1295741299] 'compare' (duration: 72.108973ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:57:59.873827Z","caller":"traceutil/trace.go:171","msg":"trace[2038017394] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5054; }","duration":"189.12807ms","start":"2026-09-30T07:57:59.684681Z","end":"2026-09-30T07:57:59.873809Z","steps":["trace[2038017394] 'process raft request' (duration: 188.946577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:57:59.874089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.734649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-30T07:57:59.874143Z","caller":"traceutil/trace.go:171","msg":"trace[116233245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5054; }","duration":"184.839132ms","start":"2026-09-30T07:57:59.689291Z","end":"2026-09-30T07:57:59.87413Z","steps":["trace[116233245] 'agreement among raft nodes before linearized reading' (duration: 184.654788ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:59.87376Z","caller":"traceutil/trace.go:171","msg":"trace[730634996] linearizableReadLoop","detail":"{readStateIndex:5250; appliedIndex:5248; }","duration":"184.425333ms","start":"2026-09-30T07:57:59.689317Z","end":"2026-09-30T07:57:59.873742Z","steps":["trace[730634996] 'read index received' (duration: 66.795698ms)","trace[730634996] 'applied index is now lower than readState.Index' (duration: 117.628985ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:57:59.875009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.723587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-30T07:57:59.875093Z","caller":"traceutil/trace.go:171","msg":"trace[842454443] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5055; }","duration":"181.86248ms","start":"2026-09-30T07:57:59.693211Z","end":"2026-09-30T07:57:59.875073Z","steps":["trace[842454443] 'agreement among raft nodes before linearized reading' (duration: 181.605365ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:57:59.875254Z","caller":"traceutil/trace.go:171","msg":"trace[1547163913] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"115.40316ms","start":"2026-09-30T07:57:59.75983Z","end":"2026-09-30T07:57:59.875233Z","steps":["trace[1547163913] 'process raft request' (duration: 114.777177ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:57:59.875859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.514482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-8shnv\" ","response":"range_response_count:1 size:2596"} {"level":"info","ts":"2026-09-30T07:57:59.875922Z","caller":"traceutil/trace.go:171","msg":"trace[1995884983] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-8shnv; range_end:; response_count:1; response_revision:5055; }","duration":"116.604435ms","start":"2026-09-30T07:57:59.7593Z","end":"2026-09-30T07:57:59.875905Z","steps":["trace[1995884983] 'agreement among raft nodes before linearized reading' (duration: 116.435461ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:00.143732Z","caller":"traceutil/trace.go:171","msg":"trace[787944437] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"134.712218ms","start":"2026-09-30T07:58:00.008963Z","end":"2026-09-30T07:58:00.143675Z","steps":["trace[787944437] 'process raft request' (duration: 74.928935ms)","trace[787944437] 'compare' (duration: 59.459436ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:58:00.143894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.690545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-30T07:58:00.143979Z","caller":"traceutil/trace.go:171","msg":"trace[79468627] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5060; }","duration":"131.817448ms","start":"2026-09-30T07:58:00.012139Z","end":"2026-09-30T07:58:00.143957Z","steps":["trace[79468627] 'agreement among raft nodes before linearized reading' (duration: 131.45983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:00.264463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.873032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-09-30T07:58:00.264552Z","caller":"traceutil/trace.go:171","msg":"trace[1236122878] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5062; }","duration":"105.008394ms","start":"2026-09-30T07:58:00.159524Z","end":"2026-09-30T07:58:00.264532Z","steps":["trace[1236122878] 'agreement among raft nodes before linearized reading' (duration: 104.675517ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:09.303278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.388337ms","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-09-30T07:58:09.303534Z","caller":"traceutil/trace.go:171","msg":"trace[705830284] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5192; }","duration":"116.639652ms","start":"2026-09-30T07:58:09.186851Z","end":"2026-09-30T07:58:09.303491Z","steps":["trace[705830284] 'range keys from in-memory index tree' (duration: 116.300215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:09.607052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.209469ms","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-09-30T07:58:09.607125Z","caller":"traceutil/trace.go:171","msg":"trace[1541140153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5193; }","duration":"106.327741ms","start":"2026-09-30T07:58:09.500781Z","end":"2026-09-30T07:58:09.607108Z","steps":["trace[1541140153] 'range keys from in-memory index tree' (duration: 106.093126ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:09.794651Z","caller":"traceutil/trace.go:171","msg":"trace[1010151808] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"182.529854ms","start":"2026-09-30T07:58:09.612092Z","end":"2026-09-30T07:58:09.794621Z","steps":["trace[1010151808] 'process raft request' (duration: 146.084006ms)","trace[1010151808] 'compare' (duration: 36.298794ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:58:20.933044Z","caller":"traceutil/trace.go:171","msg":"trace[1620502681] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"210.627736ms","start":"2026-09-30T07:58:20.72236Z","end":"2026-09-30T07:58:20.932988Z","steps":["trace[1620502681] 'process raft request' (duration: 210.403661ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:21.084695Z","caller":"traceutil/trace.go:171","msg":"trace[704984565] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"296.860873ms","start":"2026-09-30T07:58:20.787802Z","end":"2026-09-30T07:58:21.084663Z","steps":["trace[704984565] 'process raft request' (duration: 247.424645ms)","trace[704984565] 'compare' (duration: 49.160272ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:58:21.08472Z","caller":"traceutil/trace.go:171","msg":"trace[941739998] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"238.408381ms","start":"2026-09-30T07:58:20.846284Z","end":"2026-09-30T07:58:21.084693Z","steps":["trace[941739998] 'process raft request' (duration: 238.303858ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:21.084908Z","caller":"traceutil/trace.go:171","msg":"trace[1262222969] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"236.847989ms","start":"2026-09-30T07:58:20.848048Z","end":"2026-09-30T07:58:21.084896Z","steps":["trace[1262222969] 'process raft request' (duration: 236.597414ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:21.085018Z","caller":"traceutil/trace.go:171","msg":"trace[360457387] linearizableReadLoop","detail":"{readStateIndex:5486; appliedIndex:5482; }","duration":"165.444183ms","start":"2026-09-30T07:58:20.919559Z","end":"2026-09-30T07:58:21.085003Z","steps":["trace[360457387] 'read index received' (duration: 13.185569ms)","trace[360457387] 'applied index is now lower than readState.Index' (duration: 152.257324ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T07:58:21.085122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.547205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-30T07:58:21.085197Z","caller":"traceutil/trace.go:171","msg":"trace[1302600801] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5286; }","duration":"165.687367ms","start":"2026-09-30T07:58:20.919492Z","end":"2026-09-30T07:58:21.08518Z","steps":["trace[1302600801] 'agreement among raft nodes before linearized reading' (duration: 165.581125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:21.470317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.704798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-30T07:58:21.470404Z","caller":"traceutil/trace.go:171","msg":"trace[1752502444] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5286; }","duration":"220.870371ms","start":"2026-09-30T07:58:21.249511Z","end":"2026-09-30T07:58:21.470381Z","steps":["trace[1752502444] 'range keys from in-memory index tree' (duration: 220.456743ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:21.470397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.309904ms","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-09-30T07:58:21.470478Z","caller":"traceutil/trace.go:171","msg":"trace[13761547] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5286; }","duration":"178.437727ms","start":"2026-09-30T07:58:21.292019Z","end":"2026-09-30T07:58:21.470456Z","steps":["trace[13761547] 'range keys from in-memory index tree' (duration: 178.184661ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:21.586689Z","caller":"traceutil/trace.go:171","msg":"trace[1707467556] linearizableReadLoop","detail":"{readStateIndex:5488; appliedIndex:5487; }","duration":"109.825278ms","start":"2026-09-30T07:58:21.476841Z","end":"2026-09-30T07:58:21.586666Z","steps":["trace[1707467556] 'read index received' (duration: 109.599874ms)","trace[1707467556] 'applied index is now lower than readState.Index' (duration: 224.374µs)"],"step_count":2} {"level":"info","ts":"2026-09-30T07:58:21.586762Z","caller":"traceutil/trace.go:171","msg":"trace[2060322243] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"111.870761ms","start":"2026-09-30T07:58:21.474867Z","end":"2026-09-30T07:58:21.586737Z","steps":["trace[2060322243] 'process raft request' (duration: 111.669857ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:21.586997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.120444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11721"} {"level":"info","ts":"2026-09-30T07:58:21.587113Z","caller":"traceutil/trace.go:171","msg":"trace[1441038455] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5287; }","duration":"110.287148ms","start":"2026-09-30T07:58:21.476803Z","end":"2026-09-30T07:58:21.58709Z","steps":["trace[1441038455] 'agreement among raft nodes before linearized reading' (duration: 109.971972ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T07:58:21.587147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.298898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-30T07:58:21.587213Z","caller":"traceutil/trace.go:171","msg":"trace[858038060] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5287; }","duration":"109.39455ms","start":"2026-09-30T07:58:21.477797Z","end":"2026-09-30T07:58:21.587192Z","steps":["trace[858038060] 'agreement among raft nodes before linearized reading' (duration: 109.214146ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T07:58:32.849337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-09-30T07:58:32.947133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"96.400415ms","hash":2951132533,"current-db-size-bytes":51097600,"current-db-size":"51 MB","current-db-size-in-use-bytes":27525120,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-30T07:58:32.94721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2951132533,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-09-30T08:03:32.85729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5351} {"level":"info","ts":"2026-09-30T08:03:32.973816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5351,"took":"114.447779ms","hash":712881947,"current-db-size-bytes":51097600,"current-db-size":"51 MB","current-db-size-in-use-bytes":18841600,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-30T08:03:32.973904Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":712881947,"revision":5351,"compact-revision":2886} {"level":"warn","ts":"2026-09-30T08:06:00.835604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.785976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/rabbitmq-messaging-topology-operator\" ","response":"range_response_count:1 size:1286"} {"level":"info","ts":"2026-09-30T08:06:00.835779Z","caller":"traceutil/trace.go:171","msg":"trace[982821968] range","detail":"{range_begin:/registry/roles/openstack/rabbitmq-messaging-topology-operator; range_end:; response_count:1; response_revision:8157; }","duration":"118.040782ms","start":"2026-09-30T08:06:00.7177Z","end":"2026-09-30T08:06:00.835741Z","steps":["trace[982821968] 'range keys from in-memory index tree' (duration: 117.54596ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:00.83597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.719657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/secretgen-controller/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"info","ts":"2026-09-30T08:06:00.836079Z","caller":"traceutil/trace.go:171","msg":"trace[1296282278] range","detail":"{range_begin:/registry/configmaps/secretgen-controller/kube-root-ca.crt; range_end:; response_count:1; response_revision:8157; }","duration":"114.880991ms","start":"2026-09-30T08:06:00.721177Z","end":"2026-09-30T08:06:00.836058Z","steps":["trace[1296282278] 'range keys from in-memory index tree' (duration: 114.596844ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T08:06:03.223554Z","caller":"traceutil/trace.go:171","msg":"trace[2081331488] linearizableReadLoop","detail":"{readStateIndex:8476; appliedIndex:8475; }","duration":"282.663165ms","start":"2026-09-30T08:06:02.940856Z","end":"2026-09-30T08:06:03.223519Z","steps":["trace[2081331488] 'read index received' (duration: 247.654861ms)","trace[2081331488] 'applied index is now lower than readState.Index' (duration: 34.984803ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T08:06:03.223958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.864386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/keystone-db-user\" ","response":"range_response_count:1 size:721"} {"level":"info","ts":"2026-09-30T08:06:03.224018Z","caller":"traceutil/trace.go:171","msg":"trace[215484585] range","detail":"{range_begin:/registry/secrets/openstack/keystone-db-user; range_end:; response_count:1; response_revision:8169; }","duration":"229.030209ms","start":"2026-09-30T08:06:02.994973Z","end":"2026-09-30T08:06:03.224003Z","steps":["trace[215484585] 'agreement among raft nodes before linearized reading' (duration: 228.775773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:03.225534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.659636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/\" range_end:\"/registry/events/openstack0\" limit:500 ","response":"range_response_count:267 size:208389"} {"level":"info","ts":"2026-09-30T08:06:03.225591Z","caller":"traceutil/trace.go:171","msg":"trace[1970388643] range","detail":"{range_begin:/registry/events/openstack/; range_end:/registry/events/openstack0; response_count:267; response_revision:8169; }","duration":"284.763679ms","start":"2026-09-30T08:06:02.940814Z","end":"2026-09-30T08:06:03.225578Z","steps":["trace[1970388643] 'agreement among raft nodes before linearized reading' (duration: 282.8773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:04.830684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.878943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-30T08:06:04.830854Z","caller":"traceutil/trace.go:171","msg":"trace[994344390] linearizableReadLoop","detail":"{readStateIndex:8486; appliedIndex:8485; }","duration":"138.765979ms","start":"2026-09-30T08:06:04.692063Z","end":"2026-09-30T08:06:04.830829Z","steps":["trace[994344390] 'read index received' (duration: 35.583358ms)","trace[994344390] 'applied index is now lower than readState.Index' (duration: 103.17986ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T08:06:04.831015Z","caller":"traceutil/trace.go:171","msg":"trace[2141496588] transaction","detail":"{read_only:false; response_revision:8178; number_of_response:1; }","duration":"201.234099ms","start":"2026-09-30T08:06:04.629721Z","end":"2026-09-30T08:06:04.830955Z","steps":["trace[2141496588] 'process raft request' (duration: 97.931245ms)","trace[2141496588] 'compare' (duration: 102.619796ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T08:06:04.831148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.086746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/keystone-fernet-rotate\" ","response":"range_response_count:1 size:548"} {"level":"info","ts":"2026-09-30T08:06:04.831198Z","caller":"traceutil/trace.go:171","msg":"trace[1623909052] range","detail":"{range_begin:/registry/serviceaccounts/openstack/keystone-fernet-rotate; range_end:; response_count:1; response_revision:8178; }","duration":"139.188379ms","start":"2026-09-30T08:06:04.691994Z","end":"2026-09-30T08:06:04.831183Z","steps":["trace[1623909052] 'agreement among raft nodes before linearized reading' (duration: 138.968063ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:04.83138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.727801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/keystone-fernet-setup\" ","response":"range_response_count:1 size:546"} {"level":"info","ts":"2026-09-30T08:06:04.831454Z","caller":"traceutil/trace.go:171","msg":"trace[1017319424] range","detail":"{range_begin:/registry/serviceaccounts/openstack/keystone-fernet-setup; range_end:; response_count:1; response_revision:8178; }","duration":"130.871774ms","start":"2026-09-30T08:06:04.700563Z","end":"2026-09-30T08:06:04.831435Z","steps":["trace[1017319424] 'agreement among raft nodes before linearized reading' (duration: 130.670739ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T08:06:05.433283Z","caller":"traceutil/trace.go:171","msg":"trace[1598109490] transaction","detail":"{read_only:false; response_revision:8181; number_of_response:1; }","duration":"136.447895ms","start":"2026-09-30T08:06:05.296803Z","end":"2026-09-30T08:06:05.43325Z","steps":["trace[1598109490] 'process raft request' (duration: 135.622404ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T08:06:11.752901Z","caller":"traceutil/trace.go:171","msg":"trace[2074710015] transaction","detail":"{read_only:false; response_revision:8210; number_of_response:1; }","duration":"390.639401ms","start":"2026-09-30T08:06:11.362235Z","end":"2026-09-30T08:06:11.752874Z","steps":["trace[2074710015] 'process raft request' (duration: 390.462886ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:11.753108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T08:06:11.36217Z","time spent":"390.826966ms","remote":"127.0.0.1:37530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T08:06:11.786474Z","caller":"traceutil/trace.go:171","msg":"trace[858527427] transaction","detail":"{read_only:false; response_revision:8212; number_of_response:1; }","duration":"223.053922ms","start":"2026-09-30T08:06:11.563402Z","end":"2026-09-30T08:06:11.786456Z","steps":["trace[858527427] 'process raft request' (duration: 223.012261ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T08:06:11.786794Z","caller":"traceutil/trace.go:171","msg":"trace[806916479] transaction","detail":"{read_only:false; response_revision:8211; number_of_response:1; }","duration":"350.201474ms","start":"2026-09-30T08:06:11.436581Z","end":"2026-09-30T08:06:11.786782Z","steps":["trace[806916479] 'process raft request' (duration: 349.760792ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:11.78687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T08:06:11.436553Z","time spent":"350.274426ms","remote":"127.0.0.1:37530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T08:06:12.601517Z","caller":"traceutil/trace.go:171","msg":"trace[684624631] transaction","detail":"{read_only:false; response_revision:8215; number_of_response:1; }","duration":"135.670518ms","start":"2026-09-30T08:06:12.465811Z","end":"2026-09-30T08:06:12.601481Z","steps":["trace[684624631] 'process raft request' (duration: 135.382601ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T08:06:13.075655Z","caller":"traceutil/trace.go:171","msg":"trace[757756721] linearizableReadLoop","detail":"{readStateIndex:8527; appliedIndex:8526; }","duration":"163.469048ms","start":"2026-09-30T08:06:12.912154Z","end":"2026-09-30T08:06:13.075623Z","steps":["trace[757756721] 'read index received' (duration: 80.258417ms)","trace[757756721] 'applied index is now lower than readState.Index' (duration: 83.209051ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T08:06:13.075943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.690931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-30T08:06:13.075986Z","caller":"traceutil/trace.go:171","msg":"trace[1455976713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8217; }","duration":"157.816123ms","start":"2026-09-30T08:06:12.918159Z","end":"2026-09-30T08:06:13.075975Z","steps":["trace[1455976713] 'agreement among raft nodes before linearized reading' (duration: 157.709641ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:13.076263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.270868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-30T08:06:13.076372Z","caller":"traceutil/trace.go:171","msg":"trace[1764336132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8217; }","duration":"137.445362ms","start":"2026-09-30T08:06:12.938898Z","end":"2026-09-30T08:06:13.076344Z","steps":["trace[1764336132] 'agreement among raft nodes before linearized reading' (duration: 137.112023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T08:06:13.076921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.096845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-public/\" range_end:\"/registry/pods/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-30T08:06:13.077295Z","caller":"traceutil/trace.go:171","msg":"trace[1472357776] range","detail":"{range_begin:/registry/pods/kube-public/; range_end:/registry/pods/kube-public0; response_count:0; response_revision:8217; }","duration":"165.171753ms","start":"2026-09-30T08:06:12.912101Z","end":"2026-09-30T08:06:13.077273Z","steps":["trace[1472357776] 'agreement among raft nodes before linearized reading' (duration: 163.657414ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T08:06:13.236103Z","caller":"traceutil/trace.go:171","msg":"trace[1238376022] transaction","detail":"{read_only:false; response_revision:8218; number_of_response:1; }","duration":"153.501502ms","start":"2026-09-30T08:06:13.082561Z","end":"2026-09-30T08:06:13.236063Z","steps":["trace[1238376022] 'process raft request' (duration: 153.196235ms)"],"step_count":1}