{"level":"warn","ts":"2026-10-15T11:10:31.333864Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T11:10:31.333959Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.237: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.237:2380","--initial-cluster=instance=https://199.204.45.237:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.237:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.237: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-10-15T11:10:31.33403Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T11:10:31.334044Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.237:2380"]} {"level":"info","ts":"2026-10-15T11:10:31.334067Z","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-10-15T11:10:31.335165Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.237:2379"]} {"level":"info","ts":"2026-10-15T11:10:31.335267Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.237:2380"],"listen-peer-urls":["https://199.204.45.237:2380"],"advertise-client-urls":["https://199.204.45.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.237: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-10-15T11:10:31.339913Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.414299ms"} {"level":"info","ts":"2026-10-15T11:10:31.349963Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"208757c2a41558c1","cluster-id":"14128f4624e10873"} {"level":"info","ts":"2026-10-15T11:10:31.350045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T11:10:31.350065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 became follower at term 0"} {"level":"info","ts":"2026-10-15T11:10:31.350079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 208757c2a41558c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T11:10:31.350088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 became follower at term 1"} {"level":"info","ts":"2026-10-15T11:10:31.350133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 switched to configuration voters=(2343938624557766849)"} {"level":"warn","ts":"2026-10-15T11:10:31.359439Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T11:10:31.360972Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T11:10:31.362688Z","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-10-15T11:10:31.364415Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"208757c2a41558c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T11:10:31.364535Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"208757c2a41558c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T11:10:31.364674Z","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-10-15T11:10:31.364751Z","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-10-15T11:10:31.364761Z","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-10-15T11:10:31.365736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 switched to configuration voters=(2343938624557766849)"} {"level":"info","ts":"2026-10-15T11:10:31.365902Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14128f4624e10873","local-member-id":"208757c2a41558c1","added-peer-id":"208757c2a41558c1","added-peer-peer-urls":["https://199.204.45.237:2380"]} {"level":"info","ts":"2026-10-15T11:10:31.368648Z","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-10-15T11:10:31.368877Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"208757c2a41558c1","initial-advertise-peer-urls":["https://199.204.45.237:2380"],"listen-peer-urls":["https://199.204.45.237:2380"],"advertise-client-urls":["https://199.204.45.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T11:10:31.368906Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T11:10:31.369013Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.237:2380"} {"level":"info","ts":"2026-10-15T11:10:31.369029Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.237:2380"} {"level":"info","ts":"2026-10-15T11:10:31.651473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T11:10:31.651551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T11:10:31.651579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 received MsgPreVoteResp from 208757c2a41558c1 at term 1"} {"level":"info","ts":"2026-10-15T11:10:31.651647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 became candidate at term 2"} {"level":"info","ts":"2026-10-15T11:10:31.651665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 received MsgVoteResp from 208757c2a41558c1 at term 2"} {"level":"info","ts":"2026-10-15T11:10:31.65168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"208757c2a41558c1 became leader at term 2"} {"level":"info","ts":"2026-10-15T11:10:31.651732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 208757c2a41558c1 elected leader 208757c2a41558c1 at term 2"} {"level":"info","ts":"2026-10-15T11:10:31.652879Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"208757c2a41558c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.237:2379]}","request-path":"/0/members/208757c2a41558c1/attributes","cluster-id":"14128f4624e10873","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T11:10:31.652921Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:10:31.653275Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T11:10:31.653344Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T11:10:31.655025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.237:2379"} {"level":"info","ts":"2026-10-15T11:10:31.655399Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:10:31.656445Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14128f4624e10873","local-member-id":"208757c2a41558c1","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:10:31.656622Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:10:31.656659Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:10:31.660737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:10:31.663151Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T11:11:02.66454Z","caller":"traceutil/trace.go:171","msg":"trace[1144931773] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"102.354351ms","start":"2026-10-15T11:11:02.562159Z","end":"2026-10-15T11:11:02.664513Z","steps":["trace[1144931773] 'process raft request' (duration: 96.460008ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:02.665033Z","caller":"traceutil/trace.go:171","msg":"trace[1940087756] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"101.352271ms","start":"2026-10-15T11:11:02.563625Z","end":"2026-10-15T11:11:02.664977Z","steps":["trace[1940087756] 'process raft request' (duration: 101.120433ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:17.361762Z","caller":"traceutil/trace.go:171","msg":"trace[205094603] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"106.23903ms","start":"2026-10-15T11:11:17.255505Z","end":"2026-10-15T11:11:17.361744Z","steps":["trace[205094603] 'process raft request' (duration: 106.136987ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:17.394088Z","caller":"traceutil/trace.go:171","msg":"trace[994768215] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"126.56436ms","start":"2026-10-15T11:11:17.267476Z","end":"2026-10-15T11:11:17.39404Z","steps":["trace[994768215] 'process raft request' (duration: 126.379114ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:17.394385Z","caller":"traceutil/trace.go:171","msg":"trace[965194307] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"102.935232ms","start":"2026-10-15T11:11:17.291432Z","end":"2026-10-15T11:11:17.394367Z","steps":["trace[965194307] 'process raft request' (duration: 102.583201ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:17.394544Z","caller":"traceutil/trace.go:171","msg":"trace[1150172206] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"111.074327ms","start":"2026-10-15T11:11:17.283458Z","end":"2026-10-15T11:11:17.394532Z","steps":["trace[1150172206] 'process raft request' (duration: 110.477487ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:11:18.153457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.774968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:11:18.153576Z","caller":"traceutil/trace.go:171","msg":"trace[1208875553] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"186.648893ms","start":"2026-10-15T11:11:17.96691Z","end":"2026-10-15T11:11:18.153558Z","steps":["trace[1208875553] 'process raft request' (duration: 82.261595ms)","trace[1208875553] 'compare' (duration: 103.653574ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:11:18.185983Z","caller":"traceutil/trace.go:171","msg":"trace[854485375] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"162.408318ms","start":"2026-10-15T11:11:18.02355Z","end":"2026-10-15T11:11:18.185958Z","steps":["trace[854485375] 'process raft request' (duration: 162.281553ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:23.280403Z","caller":"traceutil/trace.go:171","msg":"trace[1936814617] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"189.937828ms","start":"2026-10-15T11:11:23.090432Z","end":"2026-10-15T11:11:23.28037Z","steps":["trace[1936814617] 'process raft request' (duration: 189.7041ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:23.290339Z","caller":"traceutil/trace.go:171","msg":"trace[1680803474] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"175.495892ms","start":"2026-10-15T11:11:23.114812Z","end":"2026-10-15T11:11:23.290308Z","steps":["trace[1680803474] 'process raft request' (duration: 174.704486ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:23.967868Z","caller":"traceutil/trace.go:171","msg":"trace[692998713] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"188.734437ms","start":"2026-10-15T11:11:23.779094Z","end":"2026-10-15T11:11:23.967828Z","steps":["trace[692998713] 'process raft request' (duration: 187.947971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:11:24.606106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.563143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:11:24.606426Z","caller":"traceutil/trace.go:171","msg":"trace[1598739138] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"629.862323ms","start":"2026-10-15T11:11:23.976527Z","end":"2026-10-15T11:11:24.606389Z","steps":["trace[1598739138] 'process raft request' (duration: 381.856915ms)","trace[1598739138] 'compare' (duration: 247.425468ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:11:24.606506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:11:23.976494Z","time spent":"629.971106ms","remote":"127.0.0.1:57356","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-10-15T11:11:24.606719Z","caller":"traceutil/trace.go:171","msg":"trace[1651824689] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"552.812941ms","start":"2026-10-15T11:11:24.053826Z","end":"2026-10-15T11:11:24.606639Z","steps":["trace[1651824689] 'process raft request' (duration: 552.415218ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:11:24.60687Z","caller":"traceutil/trace.go:171","msg":"trace[571112503] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"284.540424ms","start":"2026-10-15T11:11:24.322318Z","end":"2026-10-15T11:11:24.606858Z","steps":["trace[571112503] 'process raft request' (duration: 284.211493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:11:24.606949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.369021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rs2vb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T11:11:24.607012Z","caller":"traceutil/trace.go:171","msg":"trace[532586657] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rs2vb; range_end:; response_count:1; response_revision:656; }","duration":"275.491916ms","start":"2026-10-15T11:11:24.331505Z","end":"2026-10-15T11:11:24.606997Z","steps":["trace[532586657] 'agreement among raft nodes before linearized reading' (duration: 275.260228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:11:24.607011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:11:24.053781Z","time spent":"553.002218ms","remote":"127.0.0.1:57458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T11:11:24.606692Z","caller":"traceutil/trace.go:171","msg":"trace[893101357] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:676; }","duration":"275.097202ms","start":"2026-10-15T11:11:24.331559Z","end":"2026-10-15T11:11:24.606656Z","steps":["trace[893101357] 'read index received' (duration: 26.837096ms)","trace[893101357] 'applied index is now lower than readState.Index' (duration: 248.258826ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:11:24.607359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.648152ms","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-10-15T11:11:24.607401Z","caller":"traceutil/trace.go:171","msg":"trace[1286259519] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"239.747425ms","start":"2026-10-15T11:11:24.36764Z","end":"2026-10-15T11:11:24.607388Z","steps":["trace[1286259519] 'agreement among raft nodes before linearized reading' (duration: 239.571209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:11:40.926338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.287357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-15T11:11:40.926437Z","caller":"traceutil/trace.go:171","msg":"trace[104895427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:825; }","duration":"241.407761ms","start":"2026-10-15T11:11:40.68499Z","end":"2026-10-15T11:11:40.926397Z","steps":["trace[104895427] 'range keys from in-memory index tree' (duration: 241.154592ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:11:40.926637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.467966ms","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-10-15T11:11:40.926672Z","caller":"traceutil/trace.go:171","msg":"trace[1826161455] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:825; }","duration":"222.556899ms","start":"2026-10-15T11:11:40.704106Z","end":"2026-10-15T11:11:40.926663Z","steps":["trace[1826161455] 'range keys from in-memory index tree' (duration: 222.328681ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:36.618205Z","caller":"traceutil/trace.go:171","msg":"trace[1104647052] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"199.466846ms","start":"2026-10-15T11:12:36.418677Z","end":"2026-10-15T11:12:36.618144Z","steps":["trace[1104647052] 'process raft request' (duration: 184.08934ms)","trace[1104647052] 'compare' (duration: 15.124417ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:36.618254Z","caller":"traceutil/trace.go:171","msg":"trace[59099753] linearizableReadLoop","detail":"{readStateIndex:1474; appliedIndex:1473; }","duration":"194.383073ms","start":"2026-10-15T11:12:36.423805Z","end":"2026-10-15T11:12:36.618188Z","steps":["trace[59099753] 'read index received' (duration: 52.264631ms)","trace[59099753] 'applied index is now lower than readState.Index' (duration: 142.07603ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:36.618241Z","caller":"traceutil/trace.go:171","msg":"trace[1851470648] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"135.800734ms","start":"2026-10-15T11:12:36.482409Z","end":"2026-10-15T11:12:36.61821Z","steps":["trace[1851470648] 'process raft request' (duration: 135.69894ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:36.618423Z","caller":"traceutil/trace.go:171","msg":"trace[811554183] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"135.789063ms","start":"2026-10-15T11:12:36.482408Z","end":"2026-10-15T11:12:36.618197Z","steps":["trace[811554183] 'process raft request' (duration: 135.752502ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:36.618427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.59784ms","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-10-15T11:12:36.618561Z","caller":"traceutil/trace.go:171","msg":"trace[1565978144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1428; }","duration":"194.765437ms","start":"2026-10-15T11:12:36.423775Z","end":"2026-10-15T11:12:36.618541Z","steps":["trace[1565978144] 'agreement among raft nodes before linearized reading' (duration: 194.447755ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:36.618691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.462009ms","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-10-15T11:12:36.618751Z","caller":"traceutil/trace.go:171","msg":"trace[1318491228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1428; }","duration":"146.563233ms","start":"2026-10-15T11:12:36.472172Z","end":"2026-10-15T11:12:36.618735Z","steps":["trace[1318491228] 'agreement among raft nodes before linearized reading' (duration: 146.420317ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:36.72893Z","caller":"traceutil/trace.go:171","msg":"trace[1268719421] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"104.276772ms","start":"2026-10-15T11:12:36.624621Z","end":"2026-10-15T11:12:36.728897Z","steps":["trace[1268719421] 'process raft request' (duration: 100.548217ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:36.729471Z","caller":"traceutil/trace.go:171","msg":"trace[1252414149] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"102.228568ms","start":"2026-10-15T11:12:36.627223Z","end":"2026-10-15T11:12:36.729451Z","steps":["trace[1252414149] 'process raft request' (duration: 101.640307ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:36.729725Z","caller":"traceutil/trace.go:171","msg":"trace[2074666668] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"104.615425ms","start":"2026-10-15T11:12:36.625084Z","end":"2026-10-15T11:12:36.7297Z","steps":["trace[2074666668] 'process raft request' (duration: 103.716403ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:43.827751Z","caller":"traceutil/trace.go:171","msg":"trace[13215224] linearizableReadLoop","detail":"{readStateIndex:1617; appliedIndex:1616; }","duration":"107.05132ms","start":"2026-10-15T11:12:43.720677Z","end":"2026-10-15T11:12:43.827728Z","steps":["trace[13215224] 'read index received' (duration: 96.565329ms)","trace[13215224] 'applied index is now lower than readState.Index' (duration: 10.484971ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:43.827776Z","caller":"traceutil/trace.go:171","msg":"trace[1815522966] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"107.137283ms","start":"2026-10-15T11:12:43.720612Z","end":"2026-10-15T11:12:43.827749Z","steps":["trace[1815522966] 'process raft request' (duration: 96.582959ms)","trace[1815522966] 'compare' (duration: 10.414148ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:43.828085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.390782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" ","response":"range_response_count:1 size:1035"} {"level":"warn","ts":"2026-10-15T11:12:43.828029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.843149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/shovels.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:12:43.828127Z","caller":"traceutil/trace.go:171","msg":"trace[1370592890] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:1; response_revision:1567; }","duration":"107.491126ms","start":"2026-10-15T11:12:43.720625Z","end":"2026-10-15T11:12:43.828116Z","steps":["trace[1370592890] 'agreement among raft nodes before linearized reading' (duration: 107.248157ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:43.828163Z","caller":"traceutil/trace.go:171","msg":"trace[1012058578] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/shovels.rabbitmq.com; range_end:; response_count:0; response_revision:1567; }","duration":"105.009416ms","start":"2026-10-15T11:12:43.723132Z","end":"2026-10-15T11:12:43.828141Z","steps":["trace[1012058578] 'agreement among raft nodes before linearized reading' (duration: 104.765947ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:44.023522Z","caller":"traceutil/trace.go:171","msg":"trace[1823172965] transaction","detail":"{read_only:false; response_revision:1574; number_of_response:1; }","duration":"124.699501ms","start":"2026-10-15T11:12:43.898787Z","end":"2026-10-15T11:12:44.023487Z","steps":["trace[1823172965] 'process raft request' (duration: 105.66981ms)","trace[1823172965] 'compare' (duration: 18.700519ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:44.023661Z","caller":"traceutil/trace.go:171","msg":"trace[1028057588] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"124.493944ms","start":"2026-10-15T11:12:43.899142Z","end":"2026-10-15T11:12:44.023636Z","steps":["trace[1028057588] 'process raft request' (duration: 124.250645ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:44.031751Z","caller":"traceutil/trace.go:171","msg":"trace[743298372] transaction","detail":"{read_only:false; response_revision:1576; number_of_response:1; }","duration":"104.912933ms","start":"2026-10-15T11:12:43.926811Z","end":"2026-10-15T11:12:44.031724Z","steps":["trace[743298372] 'process raft request' (duration: 104.721146ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:44.031925Z","caller":"traceutil/trace.go:171","msg":"trace[702560815] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"104.381774ms","start":"2026-10-15T11:12:43.927529Z","end":"2026-10-15T11:12:44.03191Z","steps":["trace[702560815] 'process raft request' (duration: 104.098053ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:44.032141Z","caller":"traceutil/trace.go:171","msg":"trace[656651451] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"102.37835ms","start":"2026-10-15T11:12:43.929572Z","end":"2026-10-15T11:12:44.03195Z","steps":["trace[656651451] 'process raft request' (duration: 102.11604ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:44.032199Z","caller":"traceutil/trace.go:171","msg":"trace[1666344134] linearizableReadLoop","detail":"{readStateIndex:1627; appliedIndex:1623; }","duration":"104.249338ms","start":"2026-10-15T11:12:43.927935Z","end":"2026-10-15T11:12:44.032184Z","steps":["trace[1666344134] 'read index received' (duration: 76.541881ms)","trace[1666344134] 'applied index is now lower than readState.Index' (duration: 27.706027ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:44.032298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.321621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/topicpermissions.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:12:44.032605Z","caller":"traceutil/trace.go:171","msg":"trace[1426358266] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/topicpermissions.rabbitmq.com; range_end:; response_count:0; response_revision:1578; }","duration":"104.498387ms","start":"2026-10-15T11:12:43.927897Z","end":"2026-10-15T11:12:44.032395Z","steps":["trace[1426358266] 'agreement among raft nodes before linearized reading' (duration: 104.333131ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:07.36219Z","caller":"traceutil/trace.go:171","msg":"trace[1312552737] linearizableReadLoop","detail":"{readStateIndex:2016; appliedIndex:2013; }","duration":"418.517234ms","start":"2026-10-15T11:13:06.943651Z","end":"2026-10-15T11:13:07.362168Z","steps":["trace[1312552737] 'read index received' (duration: 7.35345ms)","trace[1312552737] 'applied index is now lower than readState.Index' (duration: 411.162974ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:13:07.362316Z","caller":"traceutil/trace.go:171","msg":"trace[2139311214] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"434.842374ms","start":"2026-10-15T11:13:06.927462Z","end":"2026-10-15T11:13:07.362304Z","steps":["trace[2139311214] 'process raft request' (duration: 426.762767ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:07.3624Z","caller":"traceutil/trace.go:171","msg":"trace[1238704592] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"434.814852ms","start":"2026-10-15T11:13:06.927526Z","end":"2026-10-15T11:13:07.362341Z","steps":["trace[1238704592] 'process raft request' (duration: 434.584004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:07.362538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:06.927432Z","time spent":"435.040431ms","remote":"127.0.0.1:57260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:13:07.362631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.97605ms","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-10-15T11:13:07.362707Z","caller":"traceutil/trace.go:171","msg":"trace[1576251690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1940; }","duration":"419.070974ms","start":"2026-10-15T11:13:06.943616Z","end":"2026-10-15T11:13:07.362687Z","steps":["trace[1576251690] 'agreement among raft nodes before linearized reading' (duration: 418.788273ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:07.362755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:06.943586Z","time spent":"419.157647ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T11:13:07.362418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:06.927432Z","time spent":"434.912626ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:13:07.399378Z","caller":"traceutil/trace.go:171","msg":"trace[1312185400] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"113.406849ms","start":"2026-10-15T11:13:07.285946Z","end":"2026-10-15T11:13:07.399353Z","steps":["trace[1312185400] 'process raft request' (duration: 113.265663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:07.399645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.087913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a4e0fc7-fa25-48e6-94b6-c0ecba4e9dfb\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-10-15T11:13:07.399708Z","caller":"traceutil/trace.go:171","msg":"trace[911577653] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a4e0fc7-fa25-48e6-94b6-c0ecba4e9dfb; range_end:; response_count:1; response_revision:1941; }","duration":"398.227508ms","start":"2026-10-15T11:13:07.001462Z","end":"2026-10-15T11:13:07.39969Z","steps":["trace[911577653] 'agreement among raft nodes before linearized reading' (duration: 398.085473ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:07.399499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.760624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T11:13:07.399773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:07.001432Z","time spent":"398.306912ms","remote":"127.0.0.1:57260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a4e0fc7-fa25-48e6-94b6-c0ecba4e9dfb\" "} {"level":"info","ts":"2026-10-15T11:13:07.399799Z","caller":"traceutil/trace.go:171","msg":"trace[351470896] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1941; }","duration":"107.120328ms","start":"2026-10-15T11:13:07.292651Z","end":"2026-10-15T11:13:07.399771Z","steps":["trace[351470896] 'agreement among raft nodes before linearized reading' (duration: 106.753854ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:20.477617Z","caller":"traceutil/trace.go:171","msg":"trace[1319665706] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"129.080567ms","start":"2026-10-15T11:13:20.34851Z","end":"2026-10-15T11:13:20.477591Z","steps":["trace[1319665706] 'process raft request' (duration: 128.911501ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:20.792981Z","caller":"traceutil/trace.go:171","msg":"trace[837731832] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"307.398213ms","start":"2026-10-15T11:13:20.485558Z","end":"2026-10-15T11:13:20.792956Z","steps":["trace[837731832] 'process raft request' (duration: 307.134523ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:20.793242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:20.485526Z","time spent":"307.59945ms","remote":"127.0.0.1:57412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1712,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:13:20.868172Z","caller":"traceutil/trace.go:171","msg":"trace[676717535] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"381.768869ms","start":"2026-10-15T11:13:20.486374Z","end":"2026-10-15T11:13:20.868143Z","steps":["trace[676717535] 'process raft request' (duration: 359.016919ms)","trace[676717535] 'compare' (duration: 22.525512ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:13:20.868345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:20.486362Z","time spent":"381.892183ms","remote":"127.0.0.1:57596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5636,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:13:20.868622Z","caller":"traceutil/trace.go:171","msg":"trace[1154979156] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"297.077151ms","start":"2026-10-15T11:13:20.571514Z","end":"2026-10-15T11:13:20.868591Z","steps":["trace[1154979156] 'process raft request' (duration: 296.558711ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:20.929498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.219261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:13:20.929588Z","caller":"traceutil/trace.go:171","msg":"trace[760778183] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2053; }","duration":"299.372966ms","start":"2026-10-15T11:13:20.630199Z","end":"2026-10-15T11:13:20.929572Z","steps":["trace[760778183] 'agreement among raft nodes before linearized reading' (duration: 299.21124ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:20.929229Z","caller":"traceutil/trace.go:171","msg":"trace[2099456948] linearizableReadLoop","detail":"{readStateIndex:2132; appliedIndex:2128; }","duration":"298.94527ms","start":"2026-10-15T11:13:20.630251Z","end":"2026-10-15T11:13:20.929196Z","steps":["trace[2099456948] 'read index received' (duration: 162.538172ms)","trace[2099456948] 'applied index is now lower than readState.Index' (duration: 136.405458ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:13:48.238242Z","caller":"traceutil/trace.go:171","msg":"trace[909070128] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"462.759261ms","start":"2026-10-15T11:13:47.775452Z","end":"2026-10-15T11:13:48.238212Z","steps":["trace[909070128] 'process raft request' (duration: 462.554219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.238482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:47.775416Z","time spent":"462.981322ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:13:48.535038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.850413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:13:48.535311Z","caller":"traceutil/trace.go:171","msg":"trace[1203154065] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2296; }","duration":"401.739864ms","start":"2026-10-15T11:13:48.133546Z","end":"2026-10-15T11:13:48.535286Z","steps":["trace[1203154065] 'read index received' (duration: 104.573563ms)","trace[1203154065] 'applied index is now lower than readState.Index' (duration: 297.164801ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:13:48.535318Z","caller":"traceutil/trace.go:171","msg":"trace[1374615404] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"757.785555ms","start":"2026-10-15T11:13:47.777491Z","end":"2026-10-15T11:13:48.535276Z","steps":["trace[1374615404] 'process raft request' (duration: 561.541749ms)","trace[1374615404] 'compare' (duration: 195.665731ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:13:48.535412Z","caller":"traceutil/trace.go:171","msg":"trace[4423033] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"555.784277ms","start":"2026-10-15T11:13:47.979616Z","end":"2026-10-15T11:13:48.535401Z","steps":["trace[4423033] 'process raft request' (duration: 555.589715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.535494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:47.97956Z","time spent":"555.891687ms","remote":"127.0.0.1:57356","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-10-15T11:13:48.535545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:47.77747Z","time spent":"757.945866ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:13:48.535646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.089297ms","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-10-15T11:13:48.53572Z","caller":"traceutil/trace.go:171","msg":"trace[1351625796] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2214; }","duration":"402.208578ms","start":"2026-10-15T11:13:48.133488Z","end":"2026-10-15T11:13:48.535697Z","steps":["trace[1351625796] 'agreement among raft nodes before linearized reading' (duration: 401.954306ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.535774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:48.13346Z","time spent":"402.301389ms","remote":"127.0.0.1:56838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-15T11:13:48.612317Z","caller":"traceutil/trace.go:171","msg":"trace[1694969907] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"324.582414ms","start":"2026-10-15T11:13:48.287706Z","end":"2026-10-15T11:13:48.612289Z","steps":["trace[1694969907] 'process raft request' (duration: 324.260051ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.612535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:48.287673Z","time spent":"324.745005ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:13:48.612315Z","caller":"traceutil/trace.go:171","msg":"trace[29030616] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"301.462235ms","start":"2026-10-15T11:13:48.310817Z","end":"2026-10-15T11:13:48.61228Z","steps":["trace[29030616] 'process raft request' (duration: 301.379084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.613871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:13:48.31078Z","time spent":"302.985346ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:13:48.622702Z","caller":"traceutil/trace.go:171","msg":"trace[822468429] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"237.86779ms","start":"2026-10-15T11:13:48.384788Z","end":"2026-10-15T11:13:48.622656Z","steps":["trace[822468429] 'process raft request' (duration: 237.640018ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.622723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.996381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:13:48.622887Z","caller":"traceutil/trace.go:171","msg":"trace[558402132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2217; }","duration":"103.183112ms","start":"2026-10-15T11:13:48.519686Z","end":"2026-10-15T11:13:48.622869Z","steps":["trace[558402132] 'agreement among raft nodes before linearized reading' (duration: 102.983451ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:13:48.623268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.518657ms","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-10-15T11:13:48.623316Z","caller":"traceutil/trace.go:171","msg":"trace[802417846] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2217; }","duration":"147.628838ms","start":"2026-10-15T11:13:48.475677Z","end":"2026-10-15T11:13:48.623306Z","steps":["trace[802417846] 'agreement among raft nodes before linearized reading' (duration: 146.928412ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:41.120302Z","caller":"traceutil/trace.go:171","msg":"trace[352653553] transaction","detail":"{read_only:false; response_revision:2922; number_of_response:1; }","duration":"191.706254ms","start":"2026-10-15T11:15:40.928555Z","end":"2026-10-15T11:15:41.120261Z","steps":["trace[352653553] 'process raft request' (duration: 172.743216ms)","trace[352653553] 'compare' (duration: 18.466907ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:41.129856Z","caller":"traceutil/trace.go:171","msg":"trace[1793920639] transaction","detail":"{read_only:false; response_revision:2923; number_of_response:1; }","duration":"149.3658ms","start":"2026-10-15T11:15:40.98042Z","end":"2026-10-15T11:15:41.129786Z","steps":["trace[1793920639] 'process raft request' (duration: 149.152745ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:19:40.4771Z","caller":"traceutil/trace.go:171","msg":"trace[858371986] transaction","detail":"{read_only:false; response_revision:4323; number_of_response:1; }","duration":"117.573778ms","start":"2026-10-15T11:19:40.359477Z","end":"2026-10-15T11:19:40.477051Z","steps":["trace[858371986] 'process raft request' (duration: 117.294959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:26.471341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.275969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:20:26.471599Z","caller":"traceutil/trace.go:171","msg":"trace[2006503741] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"180.128603ms","start":"2026-10-15T11:20:26.291433Z","end":"2026-10-15T11:20:26.471562Z","steps":["trace[2006503741] 'process raft request' (duration: 39.561574ms)","trace[2006503741] 'compare' (duration: 139.484473ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:20:31.914311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-10-15T11:20:31.983199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"67.653946ms","hash":3640859149,"current-db-size-bytes":51642368,"current-db-size":"52 MB","current-db-size-in-use-bytes":26402816,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-15T11:20:31.983248Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3640859149,"revision":2873,"compact-revision":-1} {"level":"info","ts":"2026-10-15T11:20:32.824672Z","caller":"traceutil/trace.go:171","msg":"trace[762337920] linearizableReadLoop","detail":"{readStateIndex:5355; appliedIndex:5354; }","duration":"305.667136ms","start":"2026-10-15T11:20:32.518977Z","end":"2026-10-15T11:20:32.824644Z","steps":["trace[762337920] 'read index received' (duration: 305.501401ms)","trace[762337920] 'applied index is now lower than readState.Index' (duration: 164.545µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:20:32.824788Z","caller":"traceutil/trace.go:171","msg":"trace[1495337099] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"312.069137ms","start":"2026-10-15T11:20:32.512708Z","end":"2026-10-15T11:20:32.824777Z","steps":["trace[1495337099] 'process raft request' (duration: 311.777747ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:32.824899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:32.51268Z","time spent":"312.132489ms","remote":"127.0.0.1:57356","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-10-15T11:20:32.824959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.960516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:20:32.825072Z","caller":"traceutil/trace.go:171","msg":"trace[569395936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5155; }","duration":"306.120452ms","start":"2026-10-15T11:20:32.518928Z","end":"2026-10-15T11:20:32.825049Z","steps":["trace[569395936] 'agreement among raft nodes before linearized reading' (duration: 305.969557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:32.825116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:32.51891Z","time spent":"306.195863ms","remote":"127.0.0.1:57096","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-10-15T11:20:32.836698Z","caller":"traceutil/trace.go:171","msg":"trace[1620933433] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"315.611772ms","start":"2026-10-15T11:20:32.521056Z","end":"2026-10-15T11:20:32.836668Z","steps":["trace[1620933433] 'process raft request' (duration: 315.384405ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:32.83702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.561778ms","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-10-15T11:20:32.837096Z","caller":"traceutil/trace.go:171","msg":"trace[28630128] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5157; }","duration":"307.653732ms","start":"2026-10-15T11:20:32.529423Z","end":"2026-10-15T11:20:32.837076Z","steps":["trace[28630128] 'agreement among raft nodes before linearized reading' (duration: 307.459385ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:32.837137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:32.529418Z","time spent":"307.710403ms","remote":"127.0.0.1:57180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3528,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-10-15T11:20:32.837137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:32.521046Z","time spent":"315.733836ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:20:32.837318Z","caller":"traceutil/trace.go:171","msg":"trace[841948649] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"315.088615ms","start":"2026-10-15T11:20:32.522215Z","end":"2026-10-15T11:20:32.837304Z","steps":["trace[841948649] 'process raft request' (duration: 314.346461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:32.837411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:32.522207Z","time spent":"315.143127ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:20:32.837636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.207454ms","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-10-15T11:20:32.837691Z","caller":"traceutil/trace.go:171","msg":"trace[486076447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5157; }","duration":"295.275065ms","start":"2026-10-15T11:20:32.542402Z","end":"2026-10-15T11:20:32.837677Z","steps":["trace[486076447] 'agreement among raft nodes before linearized reading' (duration: 295.067699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:37.573868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.20092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c6075e2a-3fc3-4125-809a-473ccf157521\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-15T11:20:37.573943Z","caller":"traceutil/trace.go:171","msg":"trace[1492747183] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c6075e2a-3fc3-4125-809a-473ccf157521; range_end:; response_count:1; response_revision:5245; }","duration":"286.285033ms","start":"2026-10-15T11:20:37.287629Z","end":"2026-10-15T11:20:37.573914Z","steps":["trace[1492747183] 'range keys from in-memory index tree' (duration: 286.047636ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:20:37.573952Z","caller":"traceutil/trace.go:171","msg":"trace[516500226] linearizableReadLoop","detail":"{readStateIndex:5448; appliedIndex:5447; }","duration":"203.60847ms","start":"2026-10-15T11:20:37.370319Z","end":"2026-10-15T11:20:37.573928Z","steps":["trace[516500226] 'read index received' (duration: 124.120872ms)","trace[516500226] 'applied index is now lower than readState.Index' (duration: 79.485978ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:20:37.574095Z","caller":"traceutil/trace.go:171","msg":"trace[1549888982] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"207.535019ms","start":"2026-10-15T11:20:37.366547Z","end":"2026-10-15T11:20:37.574082Z","steps":["trace[1549888982] 'process raft request' (duration: 127.785833ms)","trace[1549888982] 'compare' (duration: 79.275611ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:20:37.574241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.762839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-15T11:20:37.574286Z","caller":"traceutil/trace.go:171","msg":"trace[1850975047] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5246; }","duration":"190.854072ms","start":"2026-10-15T11:20:37.383419Z","end":"2026-10-15T11:20:37.574273Z","steps":["trace[1850975047] 'agreement among raft nodes before linearized reading' (duration: 190.731228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:37.57429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.925201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:20:37.574407Z","caller":"traceutil/trace.go:171","msg":"trace[1731706306] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:5246; }","duration":"204.084776ms","start":"2026-10-15T11:20:37.370292Z","end":"2026-10-15T11:20:37.574377Z","steps":["trace[1731706306] 'agreement among raft nodes before linearized reading' (duration: 203.864929ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:37.574898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.833244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c6075e2a-3fc3-4125-809a-473ccf157521\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-15T11:20:37.574938Z","caller":"traceutil/trace.go:171","msg":"trace[938546891] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c6075e2a-3fc3-4125-809a-473ccf157521; range_end:; response_count:1; response_revision:5245; }","duration":"237.872675ms","start":"2026-10-15T11:20:37.337051Z","end":"2026-10-15T11:20:37.574924Z","steps":["trace[938546891] 'range keys from in-memory index tree' (duration: 236.559782ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:20:37.858908Z","caller":"traceutil/trace.go:171","msg":"trace[669856878] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"113.09347ms","start":"2026-10-15T11:20:37.745778Z","end":"2026-10-15T11:20:37.858871Z","steps":["trace[669856878] 'process raft request' (duration: 112.879903ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.585396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.469892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:20:53.586352Z","caller":"traceutil/trace.go:171","msg":"trace[1175831267] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5459; }","duration":"470.409493ms","start":"2026-10-15T11:20:53.115891Z","end":"2026-10-15T11:20:53.586301Z","steps":["trace[1175831267] 'count revisions from in-memory index tree' (duration: 469.37921ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.58644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:53.115809Z","time spent":"470.60922ms","remote":"127.0.0.1:56756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:20:53.586106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.356988ms","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-10-15T11:20:53.586997Z","caller":"traceutil/trace.go:171","msg":"trace[532827289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5459; }","duration":"387.902176ms","start":"2026-10-15T11:20:53.198679Z","end":"2026-10-15T11:20:53.586581Z","steps":["trace[532827289] 'range keys from in-memory index tree' (duration: 387.14236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.586147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.195549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-15T11:20:53.587209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:53.198657Z","time spent":"388.397652ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-15T11:20:53.587285Z","caller":"traceutil/trace.go:171","msg":"trace[1970761814] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:5459; }","duration":"448.370567ms","start":"2026-10-15T11:20:53.138863Z","end":"2026-10-15T11:20:53.587233Z","steps":["trace[1970761814] 'count revisions from in-memory index tree' (duration: 447.135947ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.58778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:53.138853Z","time spent":"448.696818ms","remote":"127.0.0.1:46838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true "} {"level":"info","ts":"2026-10-15T11:20:53.688688Z","caller":"traceutil/trace.go:171","msg":"trace[659361014] linearizableReadLoop","detail":"{readStateIndex:5667; appliedIndex:5666; }","duration":"322.625096ms","start":"2026-10-15T11:20:53.366042Z","end":"2026-10-15T11:20:53.688667Z","steps":["trace[659361014] 'read index received' (duration: 322.523552ms)","trace[659361014] 'applied index is now lower than readState.Index' (duration: 100.384µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:20:53.688756Z","caller":"traceutil/trace.go:171","msg":"trace[740354260] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"456.241827ms","start":"2026-10-15T11:20:53.232484Z","end":"2026-10-15T11:20:53.688726Z","steps":["trace[740354260] 'process raft request' (duration: 456.05077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.688872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.816562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-10-15T11:20:53.688904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:53.232463Z","time spent":"456.359881ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:20:53.688914Z","caller":"traceutil/trace.go:171","msg":"trace[597756661] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5460; }","duration":"322.906835ms","start":"2026-10-15T11:20:53.365995Z","end":"2026-10-15T11:20:53.688901Z","steps":["trace[597756661] 'agreement among raft nodes before linearized reading' (duration: 322.767571ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.688955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:20:53.365962Z","time spent":"322.985538ms","remote":"127.0.0.1:57024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-10-15T11:20:53.696934Z","caller":"traceutil/trace.go:171","msg":"trace[1839971079] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"105.742263ms","start":"2026-10-15T11:20:53.591166Z","end":"2026-10-15T11:20:53.696908Z","steps":["trace[1839971079] 'process raft request' (duration: 105.275668ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.69767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.349423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:20:53.697722Z","caller":"traceutil/trace.go:171","msg":"trace[1449654921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5462; }","duration":"178.430366ms","start":"2026-10-15T11:20:53.51928Z","end":"2026-10-15T11:20:53.69771Z","steps":["trace[1449654921] 'agreement among raft nodes before linearized reading' (duration: 178.345854ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:20:53.69814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.271786ms","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":"warn","ts":"2026-10-15T11:20:53.69817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.620638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16552"} {"level":"info","ts":"2026-10-15T11:20:53.698232Z","caller":"traceutil/trace.go:171","msg":"trace[1321970958] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5462; }","duration":"207.397951ms","start":"2026-10-15T11:20:53.490812Z","end":"2026-10-15T11:20:53.69821Z","steps":["trace[1321970958] 'agreement among raft nodes before linearized reading' (duration: 207.218165ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:20:53.698419Z","caller":"traceutil/trace.go:171","msg":"trace[886968541] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5462; }","duration":"224.802284ms","start":"2026-10-15T11:20:53.473499Z","end":"2026-10-15T11:20:53.698301Z","steps":["trace[886968541] 'agreement among raft nodes before linearized reading' (duration: 224.560626ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:20:53.823414Z","caller":"traceutil/trace.go:171","msg":"trace[764733982] transaction","detail":"{read_only:false; response_revision:5464; number_of_response:1; }","duration":"107.183669ms","start":"2026-10-15T11:20:53.716206Z","end":"2026-10-15T11:20:53.82339Z","steps":["trace[764733982] 'process raft request' (duration: 106.945151ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:40.099787Z","caller":"traceutil/trace.go:171","msg":"trace[1874487992] transaction","detail":"{read_only:false; response_revision:5831; number_of_response:1; }","duration":"120.521144ms","start":"2026-10-15T11:21:39.979232Z","end":"2026-10-15T11:21:40.099753Z","steps":["trace[1874487992] 'process raft request' (duration: 120.293386ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:25:31.922726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5119} {"level":"info","ts":"2026-10-15T11:25:32.005218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5119,"took":"80.972899ms","hash":3594544089,"current-db-size-bytes":51642368,"current-db-size":"52 MB","current-db-size-in-use-bytes":19804160,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-10-15T11:25:32.005281Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3594544089,"revision":5119,"compact-revision":2873}