{"level":"warn","ts":"2026-06-23T05:50:08.594963Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T05:50:08.595121Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-23T05:50:08.595222Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T05:50:08.59524Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-23T05:50:08.595268Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T05:50:08.596317Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-06-23T05:50:08.596457Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-23T05:50:08.619148Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"22.264839ms"} {"level":"info","ts":"2026-06-23T05:50:08.653484Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-06-23T05:50:08.653617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T05:50:08.653641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-06-23T05:50:08.653664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T05:50:08.653675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-06-23T05:50:08.653715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-06-23T05:50:08.684881Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T05:50:08.688975Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T05:50:08.690768Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-23T05:50:08.694939Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T05:50:08.695298Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T05:50:08.695298Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T05:50:08.695469Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T05:50:08.695531Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T05:50:08.697238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-06-23T05:50:08.69799Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-23T05:50:08.700542Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T05:50:08.700752Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-23T05:50:08.700795Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-23T05:50:08.702622Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T05:50:08.702564Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T05:50:08.954645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T05:50:08.954704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T05:50:08.954742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-06-23T05:50:08.954763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-06-23T05:50:08.954775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-23T05:50:08.954802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-06-23T05:50:08.954816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-23T05:50:08.956253Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T05:50:08.962485Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T05:50:08.962546Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T05:50:08.962569Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T05:50:08.962955Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T05:50:08.963075Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T05:50:08.965074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-06-23T05:50:08.966643Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T05:50:08.970984Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T05:50:08.971085Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T05:50:08.971124Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T05:50:12.216483Z","caller":"traceutil/trace.go:171","msg":"trace[1907662397] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"147.365091ms","start":"2026-06-23T05:50:12.069089Z","end":"2026-06-23T05:50:12.216454Z","steps":["trace[1907662397] 'process raft request' (duration: 144.982879ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:50:47.858849Z","caller":"traceutil/trace.go:171","msg":"trace[1809755236] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"161.438248ms","start":"2026-06-23T05:50:47.697376Z","end":"2026-06-23T05:50:47.858814Z","steps":["trace[1809755236] 'process raft request' (duration: 64.280915ms)","trace[1809755236] 'compare' (duration: 96.823136ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:50:47.858958Z","caller":"traceutil/trace.go:171","msg":"trace[1109335754] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"134.418177ms","start":"2026-06-23T05:50:47.724515Z","end":"2026-06-23T05:50:47.858934Z","steps":["trace[1109335754] 'process raft request' (duration: 134.201033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:50:48.251139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.24079ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-23T05:50:48.251306Z","caller":"traceutil/trace.go:171","msg":"trace[1389596411] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"380.028176ms","start":"2026-06-23T05:50:47.87126Z","end":"2026-06-23T05:50:48.251288Z","steps":["trace[1389596411] 'read index received' (duration: 31.731µs)","trace[1389596411] 'applied index is now lower than readState.Index' (duration: 379.995045ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T05:50:48.25143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.147499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T05:50:48.251468Z","caller":"traceutil/trace.go:171","msg":"trace[1999556152] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:625; }","duration":"380.21915ms","start":"2026-06-23T05:50:47.871237Z","end":"2026-06-23T05:50:48.251456Z","steps":["trace[1999556152] 'agreement among raft nodes before linearized reading' (duration: 380.139618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:50:48.251509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T05:50:47.871223Z","time spent":"380.276211ms","remote":"127.0.0.1:45492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-23T05:50:48.25156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.614614ms","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-06-23T05:50:48.251678Z","caller":"traceutil/trace.go:171","msg":"trace[1816262615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"153.777597ms","start":"2026-06-23T05:50:48.097885Z","end":"2026-06-23T05:50:48.251662Z","steps":["trace[1816262615] 'agreement among raft nodes before linearized reading' (duration: 153.521062ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:51:04.450642Z","caller":"traceutil/trace.go:171","msg":"trace[1344794118] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"112.867241ms","start":"2026-06-23T05:51:04.337743Z","end":"2026-06-23T05:51:04.45061Z","steps":["trace[1344794118] 'process raft request' (duration: 112.647807ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:51:33.881331Z","caller":"traceutil/trace.go:171","msg":"trace[518723173] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"212.121296ms","start":"2026-06-23T05:51:33.669177Z","end":"2026-06-23T05:51:33.881298Z","steps":["trace[518723173] 'process raft request' (duration: 211.911962ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:52:27.205517Z","caller":"traceutil/trace.go:171","msg":"trace[693895553] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"150.28108ms","start":"2026-06-23T05:52:27.055212Z","end":"2026-06-23T05:52:27.205493Z","steps":["trace[693895553] 'read index received' (duration: 149.899564ms)","trace[693895553] 'applied index is now lower than readState.Index' (duration: 380.656µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:52:27.205653Z","caller":"traceutil/trace.go:171","msg":"trace[1377638036] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"165.616251ms","start":"2026-06-23T05:52:27.040003Z","end":"2026-06-23T05:52:27.205619Z","steps":["trace[1377638036] 'process raft request' (duration: 165.118033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:52:27.205764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.268169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T05:52:27.205799Z","caller":"traceutil/trace.go:171","msg":"trace[497122216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1887; }","duration":"126.353222ms","start":"2026-06-23T05:52:27.079438Z","end":"2026-06-23T05:52:27.205791Z","steps":["trace[497122216] 'agreement among raft nodes before linearized reading' (duration: 126.223079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:52:27.20584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.570605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T05:52:27.20591Z","caller":"traceutil/trace.go:171","msg":"trace[1335320219] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1887; }","duration":"150.718548ms","start":"2026-06-23T05:52:27.055175Z","end":"2026-06-23T05:52:27.205894Z","steps":["trace[1335320219] 'agreement among raft nodes before linearized reading' (duration: 150.450663ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:53:26.452284Z","caller":"traceutil/trace.go:171","msg":"trace[2099582285] linearizableReadLoop","detail":"{readStateIndex:2339; appliedIndex:2338; }","duration":"113.827976ms","start":"2026-06-23T05:53:26.338422Z","end":"2026-06-23T05:53:26.45225Z","steps":["trace[2099582285] 'read index received' (duration: 113.399499ms)","trace[2099582285] 'applied index is now lower than readState.Index' (duration: 427.057µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:53:26.452385Z","caller":"traceutil/trace.go:171","msg":"trace[613707318] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"251.314271ms","start":"2026-06-23T05:53:26.201009Z","end":"2026-06-23T05:53:26.452323Z","steps":["trace[613707318] 'process raft request' (duration: 250.870484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:53:26.452848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.378755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-23T05:53:26.452991Z","caller":"traceutil/trace.go:171","msg":"trace[1626272030] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2255; }","duration":"114.592057ms","start":"2026-06-23T05:53:26.338365Z","end":"2026-06-23T05:53:26.452957Z","steps":["trace[1626272030] 'agreement among raft nodes before linearized reading' (duration: 114.12895ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:53:26.456403Z","caller":"traceutil/trace.go:171","msg":"trace[284638425] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"112.042549ms","start":"2026-06-23T05:53:26.344344Z","end":"2026-06-23T05:53:26.456386Z","steps":["trace[284638425] 'process raft request' (duration: 111.835516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:53:26.707892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.062223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T05:53:26.708188Z","caller":"traceutil/trace.go:171","msg":"trace[2051471774] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"145.500976ms","start":"2026-06-23T05:53:26.562657Z","end":"2026-06-23T05:53:26.708158Z","steps":["trace[2051471774] 'process raft request' (duration: 145.360494ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:53:26.70831Z","caller":"traceutil/trace.go:171","msg":"trace[1214913309] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"162.181429ms","start":"2026-06-23T05:53:26.546091Z","end":"2026-06-23T05:53:26.708272Z","steps":["trace[1214913309] 'process raft request' (duration: 28.725005ms)","trace[1214913309] 'compare' (duration: 131.87389ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:53:26.836209Z","caller":"traceutil/trace.go:171","msg":"trace[1185564142] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"122.264474ms","start":"2026-06-23T05:53:26.713922Z","end":"2026-06-23T05:53:26.836187Z","steps":["trace[1185564142] 'process raft request' (duration: 117.029465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:54:18.908235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.686691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-23T05:54:18.910387Z","caller":"traceutil/trace.go:171","msg":"trace[679948728] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2706; }","duration":"102.878143ms","start":"2026-06-23T05:54:18.807473Z","end":"2026-06-23T05:54:18.910351Z","steps":["trace[679948728] 'range keys from in-memory index tree' (duration: 100.402007ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:54:52.46668Z","caller":"traceutil/trace.go:171","msg":"trace[1824565791] transaction","detail":"{read_only:false; response_revision:2910; number_of_response:1; }","duration":"116.91188ms","start":"2026-06-23T05:54:52.34973Z","end":"2026-06-23T05:54:52.466642Z","steps":["trace[1824565791] 'process raft request' (duration: 116.659096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:59:07.398746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.963249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T05:59:07.398856Z","caller":"traceutil/trace.go:171","msg":"trace[687061322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5131; }","duration":"158.112035ms","start":"2026-06-23T05:59:07.240722Z","end":"2026-06-23T05:59:07.398834Z","steps":["trace[687061322] 'range keys from in-memory index tree' (duration: 157.769064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:59:08.721543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.118055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T05:59:08.72178Z","caller":"traceutil/trace.go:171","msg":"trace[805335641] linearizableReadLoop","detail":"{readStateIndex:5363; appliedIndex:5361; }","duration":"116.998636ms","start":"2026-06-23T05:59:08.604761Z","end":"2026-06-23T05:59:08.721759Z","steps":["trace[805335641] 'read index received' (duration: 7.589773ms)","trace[805335641] 'applied index is now lower than readState.Index' (duration: 109.407763ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:59:08.722104Z","caller":"traceutil/trace.go:171","msg":"trace[1218432795] transaction","detail":"{read_only:false; response_revision:5167; number_of_response:1; }","duration":"181.567654ms","start":"2026-06-23T05:59:08.540515Z","end":"2026-06-23T05:59:08.722083Z","steps":["trace[1218432795] 'process raft request' (duration: 71.826792ms)","trace[1218432795] 'compare' (duration: 109.001011ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T05:59:08.722515Z","caller":"traceutil/trace.go:171","msg":"trace[2081059046] transaction","detail":"{read_only:false; response_revision:5168; number_of_response:1; }","duration":"131.514342ms","start":"2026-06-23T05:59:08.590986Z","end":"2026-06-23T05:59:08.7225Z","steps":["trace[2081059046] 'process raft request' (duration: 130.70144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T05:59:08.722809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.042584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T05:59:08.722878Z","caller":"traceutil/trace.go:171","msg":"trace[1613370527] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5168; }","duration":"118.144167ms","start":"2026-06-23T05:59:08.604717Z","end":"2026-06-23T05:59:08.722861Z","steps":["trace[1613370527] 'agreement among raft nodes before linearized reading' (duration: 118.028974ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T05:59:10.646666Z","caller":"traceutil/trace.go:171","msg":"trace[1950921768] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"113.554299ms","start":"2026-06-23T05:59:10.533085Z","end":"2026-06-23T05:59:10.646639Z","steps":["trace[1950921768] 'process raft request' (duration: 113.376924ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:00:09.509864Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006} {"level":"info","ts":"2026-06-23T06:00:09.595322Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"84.198646ms","hash":3850128018,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":30494720,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T06:00:09.595413Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3850128018,"revision":3006,"compact-revision":-1} {"level":"info","ts":"2026-06-23T06:05:09.518318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5947} {"level":"info","ts":"2026-06-23T06:05:09.605175Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5947,"took":"84.46546ms","hash":2573970871,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":26562560,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-23T06:05:09.605282Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2573970871,"revision":5947,"compact-revision":3006} {"level":"info","ts":"2026-06-23T06:06:03.236776Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022b7.wal"} {"level":"info","ts":"2026-06-23T06:06:07.133641Z","caller":"traceutil/trace.go:171","msg":"trace[1996269623] linearizableReadLoop","detail":"{readStateIndex:8908; appliedIndex:8907; }","duration":"186.485934ms","start":"2026-06-23T06:06:06.947124Z","end":"2026-06-23T06:06:07.13361Z","steps":["trace[1996269623] 'read index received' (duration: 186.28941ms)","trace[1996269623] 'applied index is now lower than readState.Index' (duration: 195.694µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:06:07.133747Z","caller":"traceutil/trace.go:171","msg":"trace[477373091] transaction","detail":"{read_only:false; response_revision:8603; number_of_response:1; }","duration":"218.953835ms","start":"2026-06-23T06:06:06.914767Z","end":"2026-06-23T06:06:07.133721Z","steps":["trace[477373091] 'process raft request' (duration: 218.69396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:06:07.13388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.735059ms","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-06-23T06:06:07.133915Z","caller":"traceutil/trace.go:171","msg":"trace[2031096999] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8603; }","duration":"186.830901ms","start":"2026-06-23T06:06:06.947075Z","end":"2026-06-23T06:06:07.133906Z","steps":["trace[2031096999] 'agreement among raft nodes before linearized reading' (duration: 186.683848ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:06:19.943301Z","caller":"traceutil/trace.go:171","msg":"trace[1610196736] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"189.517541ms","start":"2026-06-23T06:06:19.753747Z","end":"2026-06-23T06:06:19.943265Z","steps":["trace[1610196736] 'process raft request' (duration: 176.633513ms)","trace[1610196736] 'compare' (duration: 12.577662ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:06:19.94366Z","caller":"traceutil/trace.go:171","msg":"trace[1420547024] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"141.675191ms","start":"2026-06-23T06:06:19.801948Z","end":"2026-06-23T06:06:19.943623Z","steps":["trace[1420547024] 'process raft request' (duration: 141.266724ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:06:19.943738Z","caller":"traceutil/trace.go:171","msg":"trace[965173781] linearizableReadLoop","detail":"{readStateIndex:8982; appliedIndex:8979; }","duration":"108.243687ms","start":"2026-06-23T06:06:19.835481Z","end":"2026-06-23T06:06:19.943725Z","steps":["trace[965173781] 'read index received' (duration: 94.893871ms)","trace[965173781] 'applied index is now lower than readState.Index' (duration: 13.348876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:06:19.944101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.607744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-23T06:06:19.944201Z","caller":"traceutil/trace.go:171","msg":"trace[2089982684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8674; }","duration":"108.746256ms","start":"2026-06-23T06:06:19.835426Z","end":"2026-06-23T06:06:19.944172Z","steps":["trace[2089982684] 'agreement among raft nodes before linearized reading' (duration: 108.503561ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:06:19.944282Z","caller":"traceutil/trace.go:171","msg":"trace[438798863] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"130.431075ms","start":"2026-06-23T06:06:19.813834Z","end":"2026-06-23T06:06:19.944265Z","steps":["trace[438798863] 'process raft request' (duration: 129.65206ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:06:49.510517Z","caller":"traceutil/trace.go:171","msg":"trace[321324444] transaction","detail":"{read_only:false; response_revision:8883; number_of_response:1; }","duration":"141.356713ms","start":"2026-06-23T06:06:49.369127Z","end":"2026-06-23T06:06:49.510484Z","steps":["trace[321324444] 'process raft request' (duration: 141.123318ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:06:55.38882Z","caller":"traceutil/trace.go:171","msg":"trace[394080241] transaction","detail":"{read_only:false; response_revision:8914; number_of_response:1; }","duration":"173.185231ms","start":"2026-06-23T06:06:55.215607Z","end":"2026-06-23T06:06:55.388792Z","steps":["trace[394080241] 'process raft request' (duration: 173.006018ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:07:04.55786Z","caller":"traceutil/trace.go:171","msg":"trace[1435649006] transaction","detail":"{read_only:false; response_revision:9009; number_of_response:1; }","duration":"103.303801ms","start":"2026-06-23T06:07:04.454521Z","end":"2026-06-23T06:07:04.557825Z","steps":["trace[1435649006] 'process raft request' (duration: 93.280041ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:07:04.589034Z","caller":"traceutil/trace.go:171","msg":"trace[546817133] transaction","detail":"{read_only:false; response_revision:9010; number_of_response:1; }","duration":"123.939222ms","start":"2026-06-23T06:07:04.465061Z","end":"2026-06-23T06:07:04.589001Z","steps":["trace[546817133] 'process raft request' (duration: 123.81991ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:07:05.224066Z","caller":"traceutil/trace.go:171","msg":"trace[811461859] transaction","detail":"{read_only:false; response_revision:9011; number_of_response:1; }","duration":"112.069008ms","start":"2026-06-23T06:07:05.111971Z","end":"2026-06-23T06:07:05.22404Z","steps":["trace[811461859] 'process raft request' (duration: 111.925716ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:08:08.122965Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T06:08:08.128821Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-23T06:08:08.128945Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-23T06:10:09.525819Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8100} {"level":"info","ts":"2026-06-23T06:10:09.589802Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8100,"took":"61.349457ms","hash":2329684901,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":28282880,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T06:10:09.58987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2329684901,"revision":8100,"compact-revision":5947} {"level":"info","ts":"2026-06-23T06:13:47.310828Z","caller":"traceutil/trace.go:171","msg":"trace[234111652] transaction","detail":"{read_only:false; response_revision:12116; number_of_response:1; }","duration":"125.456561ms","start":"2026-06-23T06:13:47.18533Z","end":"2026-06-23T06:13:47.310787Z","steps":["trace[234111652] 'process raft request' (duration: 125.217322ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:14:14.383879Z","caller":"traceutil/trace.go:171","msg":"trace[714418799] transaction","detail":"{read_only:false; response_revision:12267; number_of_response:1; }","duration":"185.354475ms","start":"2026-06-23T06:14:14.198493Z","end":"2026-06-23T06:14:14.383847Z","steps":["trace[714418799] 'process raft request' (duration: 185.183309ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:15:09.531963Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10495} {"level":"info","ts":"2026-06-23T06:15:09.613852Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10495,"took":"79.762602ms","hash":1247173436,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":26578944,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-23T06:15:09.613918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1247173436,"revision":10495,"compact-revision":8100} {"level":"info","ts":"2026-06-23T06:20:09.53895Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12635} {"level":"info","ts":"2026-06-23T06:20:09.614624Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12635,"took":"72.880827ms","hash":926097872,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":28246016,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T06:20:09.614693Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":926097872,"revision":12635,"compact-revision":10495} {"level":"info","ts":"2026-06-23T06:20:43.049774Z","caller":"traceutil/trace.go:171","msg":"trace[939663399] transaction","detail":"{read_only:false; response_revision:14877; number_of_response:1; }","duration":"199.631122ms","start":"2026-06-23T06:20:42.850121Z","end":"2026-06-23T06:20:43.049752Z","steps":["trace[939663399] 'process raft request' (duration: 199.512089ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:20:43.050813Z","caller":"traceutil/trace.go:171","msg":"trace[1017722950] linearizableReadLoop","detail":"{readStateIndex:15396; appliedIndex:15394; }","duration":"119.728539ms","start":"2026-06-23T06:20:42.931044Z","end":"2026-06-23T06:20:43.050772Z","steps":["trace[1017722950] 'read index received' (duration: 118.503617ms)","trace[1017722950] 'applied index is now lower than readState.Index' (duration: 1.223402ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:20:43.051212Z","caller":"traceutil/trace.go:171","msg":"trace[1945260716] transaction","detail":"{read_only:false; response_revision:14878; number_of_response:1; }","duration":"147.882656ms","start":"2026-06-23T06:20:42.903288Z","end":"2026-06-23T06:20:43.051171Z","steps":["trace[1945260716] 'process raft request' (duration: 147.27105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:20:43.052257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.173587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:20:43.052326Z","caller":"traceutil/trace.go:171","msg":"trace[1255196722] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:14878; }","duration":"121.26926ms","start":"2026-06-23T06:20:42.931036Z","end":"2026-06-23T06:20:43.052305Z","steps":["trace[1255196722] 'agreement among raft nodes before linearized reading' (duration: 119.924664ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:20:53.205549Z","caller":"traceutil/trace.go:171","msg":"trace[2086105372] transaction","detail":"{read_only:false; response_revision:15048; number_of_response:1; }","duration":"104.587182ms","start":"2026-06-23T06:20:53.100931Z","end":"2026-06-23T06:20:53.205518Z","steps":["trace[2086105372] 'process raft request' (duration: 104.374537ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:20:53.207208Z","caller":"traceutil/trace.go:171","msg":"trace[1377818312] transaction","detail":"{read_only:false; response_revision:15049; number_of_response:1; }","duration":"103.887265ms","start":"2026-06-23T06:20:53.103301Z","end":"2026-06-23T06:20:53.207189Z","steps":["trace[1377818312] 'process raft request' (duration: 103.179197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:20:53.435083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.125953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-23T06:20:53.435195Z","caller":"traceutil/trace.go:171","msg":"trace[741366288] transaction","detail":"{read_only:false; response_revision:15050; number_of_response:1; }","duration":"205.264435ms","start":"2026-06-23T06:20:53.229916Z","end":"2026-06-23T06:20:53.43518Z","steps":["trace[741366288] 'process raft request' (duration: 13.954818ms)","trace[741366288] 'compare' (duration: 190.969589ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:20:53.450968Z","caller":"traceutil/trace.go:171","msg":"trace[1717027695] transaction","detail":"{read_only:false; response_revision:15051; number_of_response:1; }","duration":"160.169009ms","start":"2026-06-23T06:20:53.290771Z","end":"2026-06-23T06:20:53.45094Z","steps":["trace[1717027695] 'process raft request' (duration: 159.984924ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:20:53.483861Z","caller":"traceutil/trace.go:171","msg":"trace[262321641] transaction","detail":"{read_only:false; response_revision:15052; number_of_response:1; }","duration":"173.731307ms","start":"2026-06-23T06:20:53.310095Z","end":"2026-06-23T06:20:53.483826Z","steps":["trace[262321641] 'process raft request' (duration: 173.360527ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:22:37.130983Z","caller":"traceutil/trace.go:171","msg":"trace[1641144349] transaction","detail":"{read_only:false; response_revision:16157; number_of_response:1; }","duration":"137.476413ms","start":"2026-06-23T06:22:36.993466Z","end":"2026-06-23T06:22:37.130943Z","steps":["trace[1641144349] 'process raft request' (duration: 98.183427ms)","trace[1641144349] 'compare' (duration: 39.105612ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:25:09.546619Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14683} {"level":"info","ts":"2026-06-23T06:25:09.622192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14683,"took":"71.771436ms","hash":3641783030,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":32894976,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-23T06:25:09.62225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3641783030,"revision":14683,"compact-revision":12635} {"level":"info","ts":"2026-06-23T06:28:10.766612Z","caller":"traceutil/trace.go:171","msg":"trace[70014209] linearizableReadLoop","detail":"{readStateIndex:19254; appliedIndex:19253; }","duration":"185.120478ms","start":"2026-06-23T06:28:10.581424Z","end":"2026-06-23T06:28:10.766545Z","steps":["trace[70014209] 'read index received' (duration: 118.321202ms)","trace[70014209] 'applied index is now lower than readState.Index' (duration: 66.797586ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:28:10.766773Z","caller":"traceutil/trace.go:171","msg":"trace[1901727529] transaction","detail":"{read_only:false; response_revision:18615; number_of_response:1; }","duration":"208.03618ms","start":"2026-06-23T06:28:10.558701Z","end":"2026-06-23T06:28:10.766738Z","steps":["trace[1901727529] 'process raft request' (duration: 141.069332ms)","trace[1901727529] 'compare' (duration: 66.14372ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:28:10.766924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.479495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bf7dg\" ","response":"range_response_count:1 size:6675"} {"level":"info","ts":"2026-06-23T06:28:10.766971Z","caller":"traceutil/trace.go:171","msg":"trace[105193581] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bf7dg; range_end:; response_count:1; response_revision:18615; }","duration":"185.570098ms","start":"2026-06-23T06:28:10.581389Z","end":"2026-06-23T06:28:10.766959Z","steps":["trace[105193581] 'agreement among raft nodes before linearized reading' (duration: 185.369553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:28:10.766953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.646125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T06:28:10.767027Z","caller":"traceutil/trace.go:171","msg":"trace[1488438849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18615; }","duration":"115.767299ms","start":"2026-06-23T06:28:10.651244Z","end":"2026-06-23T06:28:10.767011Z","steps":["trace[1488438849] 'agreement among raft nodes before linearized reading' (duration: 115.535803ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:28:17.77419Z","caller":"traceutil/trace.go:171","msg":"trace[669087113] transaction","detail":"{read_only:false; response_revision:18665; number_of_response:1; }","duration":"106.717538ms","start":"2026-06-23T06:28:17.667449Z","end":"2026-06-23T06:28:17.774167Z","steps":["trace[669087113] 'process raft request' (duration: 106.564175ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:28:17.834781Z","caller":"traceutil/trace.go:171","msg":"trace[1711663012] linearizableReadLoop","detail":"{readStateIndex:19306; appliedIndex:19305; }","duration":"137.13794ms","start":"2026-06-23T06:28:17.697617Z","end":"2026-06-23T06:28:17.834755Z","steps":["trace[1711663012] 'read index received' (duration: 76.774956ms)","trace[1711663012] 'applied index is now lower than readState.Index' (duration: 60.361844ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:28:17.834835Z","caller":"traceutil/trace.go:171","msg":"trace[712987217] transaction","detail":"{read_only:false; response_revision:18666; number_of_response:1; }","duration":"146.730546ms","start":"2026-06-23T06:28:17.688072Z","end":"2026-06-23T06:28:17.834802Z","steps":["trace[712987217] 'process raft request' (duration: 130.07125ms)","trace[712987217] 'compare' (duration: 16.426681ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:28:17.834963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.316975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:28:17.835003Z","caller":"traceutil/trace.go:171","msg":"trace[250759867] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:18666; }","duration":"137.389426ms","start":"2026-06-23T06:28:17.697599Z","end":"2026-06-23T06:28:17.834989Z","steps":["trace[250759867] 'agreement among raft nodes before linearized reading' (duration: 137.285434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:28:17.851855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.301927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:28:17.851925Z","caller":"traceutil/trace.go:171","msg":"trace[1949774019] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:18667; }","duration":"111.42028ms","start":"2026-06-23T06:28:17.740488Z","end":"2026-06-23T06:28:17.851908Z","steps":["trace[1949774019] 'agreement among raft nodes before linearized reading' (duration: 111.292157ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:28:18.188605Z","caller":"traceutil/trace.go:171","msg":"trace[2033977570] transaction","detail":"{read_only:false; response_revision:18668; number_of_response:1; }","duration":"309.931576ms","start":"2026-06-23T06:28:17.878616Z","end":"2026-06-23T06:28:18.188548Z","steps":["trace[2033977570] 'process raft request' (duration: 309.61558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:28:18.18884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:28:17.878594Z","time spent":"310.11979ms","remote":"127.0.0.1:45446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20774,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:28:18.276523Z","caller":"traceutil/trace.go:171","msg":"trace[1111126325] linearizableReadLoop","detail":"{readStateIndex:19309; appliedIndex:19307; }","duration":"246.411443ms","start":"2026-06-23T06:28:18.030042Z","end":"2026-06-23T06:28:18.276454Z","steps":["trace[1111126325] 'read index received' (duration: 158.211953ms)","trace[1111126325] 'applied index is now lower than readState.Index' (duration: 88.1969ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:28:18.276721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.667068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:28:18.276822Z","caller":"traceutil/trace.go:171","msg":"trace[764076561] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:18668; }","duration":"246.818952ms","start":"2026-06-23T06:28:18.029977Z","end":"2026-06-23T06:28:18.276796Z","steps":["trace[764076561] 'agreement among raft nodes before linearized reading' (duration: 246.662508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:28:18.276913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.20936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-qpxc9\" ","response":"range_response_count:1 size:9712"} {"level":"info","ts":"2026-06-23T06:28:18.276996Z","caller":"traceutil/trace.go:171","msg":"trace[1297265610] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-qpxc9; range_end:; response_count:1; response_revision:18668; }","duration":"191.356042ms","start":"2026-06-23T06:28:18.085619Z","end":"2026-06-23T06:28:18.276975Z","steps":["trace[1297265610] 'agreement among raft nodes before linearized reading' (duration: 191.117727ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:28:18.423009Z","caller":"traceutil/trace.go:171","msg":"trace[891444462] linearizableReadLoop","detail":"{readStateIndex:19310; appliedIndex:19309; }","duration":"140.036553ms","start":"2026-06-23T06:28:18.282948Z","end":"2026-06-23T06:28:18.422984Z","steps":["trace[891444462] 'read index received' (duration: 139.90866ms)","trace[891444462] 'applied index is now lower than readState.Index' (duration: 126.963µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:28:18.423104Z","caller":"traceutil/trace.go:171","msg":"trace[1308211583] transaction","detail":"{read_only:false; response_revision:18669; number_of_response:1; }","duration":"141.213818ms","start":"2026-06-23T06:28:18.281852Z","end":"2026-06-23T06:28:18.423066Z","steps":["trace[1308211583] 'process raft request' (duration: 140.959472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:28:18.424625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.638877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:934391"} {"level":"info","ts":"2026-06-23T06:28:18.424734Z","caller":"traceutil/trace.go:171","msg":"trace[283240554] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:18669; }","duration":"141.849512ms","start":"2026-06-23T06:28:18.282859Z","end":"2026-06-23T06:28:18.424709Z","steps":["trace[283240554] 'agreement among raft nodes before linearized reading' (duration: 140.257268ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:29:12.818325Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T06:29:12.826458Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-23T06:29:12.826613Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-23T06:30:09.553319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17252} {"level":"info","ts":"2026-06-23T06:30:09.656024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17252,"took":"99.735518ms","hash":153392009,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":34590720,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-23T06:30:09.656095Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":153392009,"revision":17252,"compact-revision":14683} {"level":"info","ts":"2026-06-23T06:34:36.571184Z","caller":"traceutil/trace.go:171","msg":"trace[878772735] transaction","detail":"{read_only:false; response_revision:21546; number_of_response:1; }","duration":"215.716292ms","start":"2026-06-23T06:34:36.35544Z","end":"2026-06-23T06:34:36.571156Z","steps":["trace[878772735] 'process raft request' (duration: 215.569469ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:34:36.571199Z","caller":"traceutil/trace.go:171","msg":"trace[177309749] linearizableReadLoop","detail":"{readStateIndex:22282; appliedIndex:22282; }","duration":"202.089062ms","start":"2026-06-23T06:34:36.369077Z","end":"2026-06-23T06:34:36.571166Z","steps":["trace[177309749] 'read index received' (duration: 202.077992ms)","trace[177309749] 'applied index is now lower than readState.Index' (duration: 9.02µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:34:36.571443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.276887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:34:36.571494Z","caller":"traceutil/trace.go:171","msg":"trace[159803085] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:21546; }","duration":"202.434109ms","start":"2026-06-23T06:34:36.369046Z","end":"2026-06-23T06:34:36.571481Z","steps":["trace[159803085] 'agreement among raft nodes before linearized reading' (duration: 202.210445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:36.636943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.567292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T06:34:36.637027Z","caller":"traceutil/trace.go:171","msg":"trace[341088303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21547; }","duration":"267.675525ms","start":"2026-06-23T06:34:36.369332Z","end":"2026-06-23T06:34:36.637008Z","steps":["trace[341088303] 'agreement among raft nodes before linearized reading' (duration: 267.469731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:36.637188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.034629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T06:34:36.637269Z","caller":"traceutil/trace.go:171","msg":"trace[2091559892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21547; }","duration":"144.153452ms","start":"2026-06-23T06:34:36.493092Z","end":"2026-06-23T06:34:36.637245Z","steps":["trace[2091559892] 'agreement among raft nodes before linearized reading' (duration: 143.941767ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:34:36.832636Z","caller":"traceutil/trace.go:171","msg":"trace[1156411436] transaction","detail":"{read_only:false; response_revision:21549; number_of_response:1; }","duration":"190.121265ms","start":"2026-06-23T06:34:36.642451Z","end":"2026-06-23T06:34:36.832572Z","steps":["trace[1156411436] 'process raft request' (duration: 154.906285ms)","trace[1156411436] 'compare' (duration: 34.756401ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:34:37.167567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.911972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:34:37.167822Z","caller":"traceutil/trace.go:171","msg":"trace[370328549] linearizableReadLoop","detail":"{readStateIndex:22287; appliedIndex:22284; }","duration":"459.242466ms","start":"2026-06-23T06:34:36.708564Z","end":"2026-06-23T06:34:37.167806Z","steps":["trace[370328549] 'read index received' (duration: 88.824083ms)","trace[370328549] 'applied index is now lower than readState.Index' (duration: 370.417223ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:34:37.167903Z","caller":"traceutil/trace.go:171","msg":"trace[7611091] transaction","detail":"{read_only:false; response_revision:21551; number_of_response:1; }","duration":"462.067162ms","start":"2026-06-23T06:34:36.705802Z","end":"2026-06-23T06:34:37.16787Z","steps":["trace[7611091] 'process raft request' (duration: 461.874858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:37.168008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.865533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T06:34:37.168035Z","caller":"traceutil/trace.go:171","msg":"trace[446054325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21551; }","duration":"432.894044ms","start":"2026-06-23T06:34:36.735133Z","end":"2026-06-23T06:34:37.168027Z","steps":["trace[446054325] 'agreement among raft nodes before linearized reading' (duration: 432.776461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:37.168062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:34:36.735073Z","time spent":"432.982435ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T06:34:37.168076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.549159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-23T06:34:37.168103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.997272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T06:34:37.168123Z","caller":"traceutil/trace.go:171","msg":"trace[520438965] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:21551; }","duration":"350.653082ms","start":"2026-06-23T06:34:36.81746Z","end":"2026-06-23T06:34:37.168114Z","steps":["trace[520438965] 'agreement among raft nodes before linearized reading' (duration: 350.535449ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:34:37.167919Z","caller":"traceutil/trace.go:171","msg":"trace[208201011] transaction","detail":"{read_only:false; response_revision:21550; number_of_response:1; }","duration":"462.617813ms","start":"2026-06-23T06:34:36.705211Z","end":"2026-06-23T06:34:37.167829Z","steps":["trace[208201011] 'process raft request' (duration: 293.403955ms)","trace[208201011] 'compare' (duration: 168.393262ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:34:37.168166Z","caller":"traceutil/trace.go:171","msg":"trace[1934236200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21551; }","duration":"252.107954ms","start":"2026-06-23T06:34:36.916043Z","end":"2026-06-23T06:34:37.168151Z","steps":["trace[1934236200] 'agreement among raft nodes before linearized reading' (duration: 251.921541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:37.168173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:34:36.817442Z","time spent":"350.721173ms","remote":"127.0.0.1:45658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":32,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:34:37.168115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:34:36.705789Z","time spent":"462.212345ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:34:37.168334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:34:36.705182Z","time spent":"463.018352ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:34:37.169082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.505241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T06:34:37.169138Z","caller":"traceutil/trace.go:171","msg":"trace[508999497] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:21551; }","duration":"460.588623ms","start":"2026-06-23T06:34:36.708535Z","end":"2026-06-23T06:34:37.169124Z","steps":["trace[508999497] 'agreement among raft nodes before linearized reading' (duration: 459.360068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:37.169488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:34:36.708527Z","time spent":"460.639934ms","remote":"127.0.0.1:45332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":2190,"response size":33,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:34:37.370208Z","caller":"traceutil/trace.go:171","msg":"trace[357522760] linearizableReadLoop","detail":"{readStateIndex:22290; appliedIndex:22288; }","duration":"162.170309ms","start":"2026-06-23T06:34:37.208011Z","end":"2026-06-23T06:34:37.370181Z","steps":["trace[357522760] 'read index received' (duration: 124.229406ms)","trace[357522760] 'applied index is now lower than readState.Index' (duration: 37.939713ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:34:37.370302Z","caller":"traceutil/trace.go:171","msg":"trace[1959696887] transaction","detail":"{read_only:false; response_revision:21553; number_of_response:1; }","duration":"197.058432ms","start":"2026-06-23T06:34:37.173206Z","end":"2026-06-23T06:34:37.370264Z","steps":["trace[1959696887] 'process raft request' (duration: 159.027057ms)","trace[1959696887] 'compare' (duration: 37.78634ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:34:37.370373Z","caller":"traceutil/trace.go:171","msg":"trace[1465965288] transaction","detail":"{read_only:false; response_revision:21554; number_of_response:1; }","duration":"197.113093ms","start":"2026-06-23T06:34:37.173214Z","end":"2026-06-23T06:34:37.370327Z","steps":["trace[1465965288] 'process raft request' (duration: 196.92996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:37.370834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.807862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:34:37.370916Z","caller":"traceutil/trace.go:171","msg":"trace[11197188] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:21554; }","duration":"162.948375ms","start":"2026-06-23T06:34:37.207956Z","end":"2026-06-23T06:34:37.370904Z","steps":["trace[11197188] 'agreement among raft nodes before linearized reading' (duration: 162.377603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:34:37.371095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.063825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:34:37.371178Z","caller":"traceutil/trace.go:171","msg":"trace[1694870724] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:21554; }","duration":"109.200787ms","start":"2026-06-23T06:34:37.261959Z","end":"2026-06-23T06:34:37.37116Z","steps":["trace[1694870724] 'agreement among raft nodes before linearized reading' (duration: 108.706458ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:35:09.563063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19790} {"level":"info","ts":"2026-06-23T06:35:09.688303Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19790,"took":"118.94516ms","hash":4157492269,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":29671424,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T06:35:09.688382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4157492269,"revision":19790,"compact-revision":17252} {"level":"info","ts":"2026-06-23T06:39:01.778569Z","caller":"traceutil/trace.go:171","msg":"trace[1006379630] transaction","detail":"{read_only:false; response_revision:24172; number_of_response:1; }","duration":"108.395718ms","start":"2026-06-23T06:39:01.670131Z","end":"2026-06-23T06:39:01.778527Z","steps":["trace[1006379630] 'process raft request' (duration: 108.174213ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:40:09.57095Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21742} {"level":"info","ts":"2026-06-23T06:40:09.676046Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21742,"took":"101.623998ms","hash":1532771003,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":43315200,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-06-23T06:40:09.676129Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1532771003,"revision":21742,"compact-revision":19790} {"level":"info","ts":"2026-06-23T06:40:11.436945Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000064e2.wal"} {"level":"info","ts":"2026-06-23T06:42:31.819637Z","caller":"traceutil/trace.go:171","msg":"trace[481754739] transaction","detail":"{read_only:false; response_revision:26288; number_of_response:1; }","duration":"120.299802ms","start":"2026-06-23T06:42:31.699267Z","end":"2026-06-23T06:42:31.819566Z","steps":["trace[481754739] 'process raft request' (duration: 120.101299ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:32.947539Z","caller":"traceutil/trace.go:171","msg":"trace[1249491719] transaction","detail":"{read_only:false; response_revision:26292; number_of_response:1; }","duration":"291.833307ms","start":"2026-06-23T06:42:32.655674Z","end":"2026-06-23T06:42:32.947507Z","steps":["trace[1249491719] 'process raft request' (duration: 291.642343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.146515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.248717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:42:33.146863Z","caller":"traceutil/trace.go:171","msg":"trace[1079028913] transaction","detail":"{read_only:false; response_revision:26295; number_of_response:1; }","duration":"103.126157ms","start":"2026-06-23T06:42:33.043711Z","end":"2026-06-23T06:42:33.146837Z","steps":["trace[1079028913] 'process raft request' (duration: 103.060045ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:33.147092Z","caller":"traceutil/trace.go:171","msg":"trace[1419046083] transaction","detail":"{read_only:false; response_revision:26294; number_of_response:1; }","duration":"471.635059ms","start":"2026-06-23T06:42:32.675414Z","end":"2026-06-23T06:42:33.147049Z","steps":["trace[1419046083] 'process raft request' (duration: 471.252391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.147328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:32.675405Z","time spent":"471.797601ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:33.147092Z","caller":"traceutil/trace.go:171","msg":"trace[1874984956] linearizableReadLoop","detail":"{readStateIndex:27167; appliedIndex:27164; }","duration":"393.758941ms","start":"2026-06-23T06:42:32.753297Z","end":"2026-06-23T06:42:33.147056Z","steps":["trace[1874984956] 'read index received' (duration: 194.059672ms)","trace[1874984956] 'applied index is now lower than readState.Index' (duration: 199.697319ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:33.147339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.039896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-06-23T06:42:33.147409Z","caller":"traceutil/trace.go:171","msg":"trace[1479692639] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:26295; }","duration":"394.149808ms","start":"2026-06-23T06:42:32.753245Z","end":"2026-06-23T06:42:33.147395Z","steps":["trace[1479692639] 'agreement among raft nodes before linearized reading' (duration: 393.919754ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:33.147122Z","caller":"traceutil/trace.go:171","msg":"trace[1837221403] transaction","detail":"{read_only:false; response_revision:26293; number_of_response:1; }","duration":"479.383365ms","start":"2026-06-23T06:42:32.667707Z","end":"2026-06-23T06:42:33.14709Z","steps":["trace[1837221403] 'process raft request' (duration: 306.384064ms)","trace[1837221403] 'compare' (duration: 171.919991ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:33.147452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:32.753225Z","time spent":"394.215749ms","remote":"127.0.0.1:45272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"warn","ts":"2026-06-23T06:42:33.147536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:32.667686Z","time spent":"479.782112ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:33.639946Z","caller":"traceutil/trace.go:171","msg":"trace[1452101422] transaction","detail":"{read_only:false; response_revision:26298; number_of_response:1; }","duration":"452.078526ms","start":"2026-06-23T06:42:33.187821Z","end":"2026-06-23T06:42:33.639899Z","steps":["trace[1452101422] 'process raft request' (duration: 431.604408ms)","trace[1452101422] 'compare' (duration: 19.669093ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:33.640156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:33.187793Z","time spent":"452.24471ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:33.640474Z","caller":"traceutil/trace.go:171","msg":"trace[464513211] linearizableReadLoop","detail":"{readStateIndex:27173; appliedIndex:27171; }","duration":"433.985593ms","start":"2026-06-23T06:42:33.20645Z","end":"2026-06-23T06:42:33.640436Z","steps":["trace[464513211] 'read index received' (duration: 412.987815ms)","trace[464513211] 'applied index is now lower than readState.Index' (duration: 20.996238ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:33.640642Z","caller":"traceutil/trace.go:171","msg":"trace[1032736261] transaction","detail":"{read_only:false; response_revision:26299; number_of_response:1; }","duration":"451.625589ms","start":"2026-06-23T06:42:33.188991Z","end":"2026-06-23T06:42:33.640617Z","steps":["trace[1032736261] 'process raft request' (duration: 450.857564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.640719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:33.18897Z","time spent":"451.707721ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:33.640781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.32676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-23T06:42:33.640831Z","caller":"traceutil/trace.go:171","msg":"trace[465892610] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26299; }","duration":"434.424033ms","start":"2026-06-23T06:42:33.206397Z","end":"2026-06-23T06:42:33.640821Z","steps":["trace[465892610] 'agreement among raft nodes before linearized reading' (duration: 434.24791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.640861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:33.206374Z","time spent":"434.479444ms","remote":"127.0.0.1:45424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-06-23T06:42:33.647443Z","caller":"traceutil/trace.go:171","msg":"trace[1372779911] transaction","detail":"{read_only:false; response_revision:26300; number_of_response:1; }","duration":"233.303386ms","start":"2026-06-23T06:42:33.414107Z","end":"2026-06-23T06:42:33.64741Z","steps":["trace[1372779911] 'process raft request' (duration: 233.064852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.647732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.669703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T06:42:33.647768Z","caller":"traceutil/trace.go:171","msg":"trace[48900006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26301; }","duration":"165.762124ms","start":"2026-06-23T06:42:33.481996Z","end":"2026-06-23T06:42:33.647758Z","steps":["trace[48900006] 'agreement among raft nodes before linearized reading' (duration: 165.645622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.647773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.947143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-23T06:42:33.647842Z","caller":"traceutil/trace.go:171","msg":"trace[1357692023] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26301; }","duration":"404.071056ms","start":"2026-06-23T06:42:33.243756Z","end":"2026-06-23T06:42:33.647827Z","steps":["trace[1357692023] 'agreement among raft nodes before linearized reading' (duration: 403.884332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:33.647872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:33.24374Z","time spent":"404.126146ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T06:42:33.799988Z","caller":"traceutil/trace.go:171","msg":"trace[1266452869] transaction","detail":"{read_only:false; response_revision:26302; number_of_response:1; }","duration":"145.843957ms","start":"2026-06-23T06:42:33.65411Z","end":"2026-06-23T06:42:33.799954Z","steps":["trace[1266452869] 'process raft request' (duration: 98.794015ms)","trace[1266452869] 'compare' (duration: 46.919539ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:33.809145Z","caller":"traceutil/trace.go:171","msg":"trace[564792908] transaction","detail":"{read_only:false; response_revision:26303; number_of_response:1; }","duration":"154.886009ms","start":"2026-06-23T06:42:33.654233Z","end":"2026-06-23T06:42:33.809119Z","steps":["trace[564792908] 'process raft request' (duration: 154.768507ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:37.319795Z","caller":"traceutil/trace.go:171","msg":"trace[803455034] transaction","detail":"{read_only:false; response_revision:26324; number_of_response:1; }","duration":"154.755385ms","start":"2026-06-23T06:42:37.165003Z","end":"2026-06-23T06:42:37.319758Z","steps":["trace[803455034] 'process raft request' (duration: 131.093105ms)","trace[803455034] 'compare' (duration: 23.547158ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:37.530526Z","caller":"traceutil/trace.go:171","msg":"trace[719925405] transaction","detail":"{read_only:false; response_revision:26325; number_of_response:1; }","duration":"341.10372ms","start":"2026-06-23T06:42:37.189381Z","end":"2026-06-23T06:42:37.530485Z","steps":["trace[719925405] 'process raft request' (duration: 312.652871ms)","trace[719925405] 'compare' (duration: 28.281196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:37.530743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:37.189343Z","time spent":"341.308244ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:37.806057Z","caller":"traceutil/trace.go:171","msg":"trace[1508499931] transaction","detail":"{read_only:false; response_revision:26327; number_of_response:1; }","duration":"145.969898ms","start":"2026-06-23T06:42:37.66005Z","end":"2026-06-23T06:42:37.80602Z","steps":["trace[1508499931] 'process raft request' (duration: 145.318396ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:37.806083Z","caller":"traceutil/trace.go:171","msg":"trace[1880069501] transaction","detail":"{read_only:false; response_revision:26326; number_of_response:1; }","duration":"152.632445ms","start":"2026-06-23T06:42:37.653394Z","end":"2026-06-23T06:42:37.806026Z","steps":["trace[1880069501] 'process raft request' (duration: 82.379012ms)","trace[1880069501] 'compare' (duration: 69.138792ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:37.806079Z","caller":"traceutil/trace.go:171","msg":"trace[1222253835] transaction","detail":"{read_only:false; response_revision:26329; number_of_response:1; }","duration":"139.974365ms","start":"2026-06-23T06:42:37.66605Z","end":"2026-06-23T06:42:37.806025Z","steps":["trace[1222253835] 'process raft request' (duration: 139.521826ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:37.806058Z","caller":"traceutil/trace.go:171","msg":"trace[521216781] transaction","detail":"{read_only:false; response_revision:26328; number_of_response:1; }","duration":"140.269891ms","start":"2026-06-23T06:42:37.665754Z","end":"2026-06-23T06:42:37.806024Z","steps":["trace[521216781] 'process raft request' (duration: 139.7139ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:38.03641Z","caller":"traceutil/trace.go:171","msg":"trace[442572799] linearizableReadLoop","detail":"{readStateIndex:27204; appliedIndex:27203; }","duration":"210.108616ms","start":"2026-06-23T06:42:37.826272Z","end":"2026-06-23T06:42:38.03638Z","steps":["trace[442572799] 'read index received' (duration: 209.873441ms)","trace[442572799] 'applied index is now lower than readState.Index' (duration: 233.585µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:38.036519Z","caller":"traceutil/trace.go:171","msg":"trace[2026998928] transaction","detail":"{read_only:false; response_revision:26330; number_of_response:1; }","duration":"218.761459ms","start":"2026-06-23T06:42:37.817708Z","end":"2026-06-23T06:42:38.03647Z","steps":["trace[2026998928] 'process raft request' (duration: 218.456814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:38.036709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.418091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T06:42:38.036759Z","caller":"traceutil/trace.go:171","msg":"trace[1726852905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26330; }","duration":"210.541673ms","start":"2026-06-23T06:42:37.826203Z","end":"2026-06-23T06:42:38.036745Z","steps":["trace[1726852905] 'agreement among raft nodes before linearized reading' (duration: 210.327349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:38.132727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.182019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T06:42:38.132825Z","caller":"traceutil/trace.go:171","msg":"trace[1749962200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26330; }","duration":"285.289501ms","start":"2026-06-23T06:42:37.847513Z","end":"2026-06-23T06:42:38.132803Z","steps":["trace[1749962200] 'agreement among raft nodes before linearized reading' (duration: 285.031966ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:38.260702Z","caller":"traceutil/trace.go:171","msg":"trace[1847735882] transaction","detail":"{read_only:false; response_revision:26332; number_of_response:1; }","duration":"123.323359ms","start":"2026-06-23T06:42:38.137337Z","end":"2026-06-23T06:42:38.26066Z","steps":["trace[1847735882] 'process raft request' (duration: 100.554318ms)","trace[1847735882] 'compare' (duration: 22.508017ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:38.260754Z","caller":"traceutil/trace.go:171","msg":"trace[1258793213] transaction","detail":"{read_only:false; response_revision:26334; number_of_response:1; }","duration":"122.747708ms","start":"2026-06-23T06:42:38.137884Z","end":"2026-06-23T06:42:38.260631Z","steps":["trace[1258793213] 'process raft request' (duration: 122.713467ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:38.260762Z","caller":"traceutil/trace.go:171","msg":"trace[446914399] transaction","detail":"{read_only:false; response_revision:26333; number_of_response:1; }","duration":"122.84674ms","start":"2026-06-23T06:42:38.13787Z","end":"2026-06-23T06:42:38.260717Z","steps":["trace[446914399] 'process raft request' (duration: 122.678937ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:39.421176Z","caller":"traceutil/trace.go:171","msg":"trace[825247595] linearizableReadLoop","detail":"{readStateIndex:27211; appliedIndex:27210; }","duration":"135.601111ms","start":"2026-06-23T06:42:39.285552Z","end":"2026-06-23T06:42:39.421153Z","steps":["trace[825247595] 'read index received' (duration: 135.49945ms)","trace[825247595] 'applied index is now lower than readState.Index' (duration: 100.981µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:39.421293Z","caller":"traceutil/trace.go:171","msg":"trace[1732567906] transaction","detail":"{read_only:false; response_revision:26336; number_of_response:1; }","duration":"240.928079ms","start":"2026-06-23T06:42:39.180335Z","end":"2026-06-23T06:42:39.421263Z","steps":["trace[1732567906] 'process raft request' (duration: 240.685555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:39.421523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.937848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-23T06:42:39.422189Z","caller":"traceutil/trace.go:171","msg":"trace[1719132492] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26336; }","duration":"136.680151ms","start":"2026-06-23T06:42:39.285497Z","end":"2026-06-23T06:42:39.422177Z","steps":["trace[1719132492] 'agreement among raft nodes before linearized reading' (duration: 135.794225ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:39.522518Z","caller":"traceutil/trace.go:171","msg":"trace[1047044688] linearizableReadLoop","detail":"{readStateIndex:27212; appliedIndex:27211; }","duration":"100.416715ms","start":"2026-06-23T06:42:39.422069Z","end":"2026-06-23T06:42:39.522485Z","steps":["trace[1047044688] 'read index received' (duration: 97.604272ms)","trace[1047044688] 'applied index is now lower than readState.Index' (duration: 2.811063ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:39.522717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.701269ms","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:8"} {"level":"info","ts":"2026-06-23T06:42:39.522757Z","caller":"traceutil/trace.go:171","msg":"trace[1617290965] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26337; }","duration":"100.792232ms","start":"2026-06-23T06:42:39.421956Z","end":"2026-06-23T06:42:39.522748Z","steps":["trace[1617290965] 'agreement among raft nodes before linearized reading' (duration: 100.67107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:39.522774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.917569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:39.522834Z","caller":"traceutil/trace.go:171","msg":"trace[1418010769] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:26337; }","duration":"192.060012ms","start":"2026-06-23T06:42:39.330761Z","end":"2026-06-23T06:42:39.522821Z","steps":["trace[1418010769] 'agreement among raft nodes before linearized reading' (duration: 191.92012ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:39.522542Z","caller":"traceutil/trace.go:171","msg":"trace[1963842101] transaction","detail":"{read_only:false; response_revision:26337; number_of_response:1; }","duration":"195.579759ms","start":"2026-06-23T06:42:39.326924Z","end":"2026-06-23T06:42:39.522504Z","steps":["trace[1963842101] 'process raft request' (duration: 192.820627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:39.86239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.779399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:42:39.862774Z","caller":"traceutil/trace.go:171","msg":"trace[1796635374] transaction","detail":"{read_only:false; response_revision:26338; number_of_response:1; }","duration":"325.431003ms","start":"2026-06-23T06:42:39.53731Z","end":"2026-06-23T06:42:39.862741Z","steps":["trace[1796635374] 'process raft request' (duration: 145.198944ms)","trace[1796635374] 'compare' (duration: 179.637147ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:39.862889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:39.537284Z","time spent":"325.551685ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:39.863908Z","caller":"traceutil/trace.go:171","msg":"trace[325923054] linearizableReadLoop","detail":"{readStateIndex:27213; appliedIndex:27212; }","duration":"271.995029ms","start":"2026-06-23T06:42:39.591874Z","end":"2026-06-23T06:42:39.863869Z","steps":["trace[325923054] 'read index received' (duration: 90.542977ms)","trace[325923054] 'applied index is now lower than readState.Index' (duration: 181.448552ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:39.864151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.245423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:39.864231Z","caller":"traceutil/trace.go:171","msg":"trace[33563523] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26339; }","duration":"272.360416ms","start":"2026-06-23T06:42:39.59182Z","end":"2026-06-23T06:42:39.86418Z","steps":["trace[33563523] 'agreement among raft nodes before linearized reading' (duration: 272.162822ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:40.208751Z","caller":"traceutil/trace.go:171","msg":"trace[942773807] transaction","detail":"{read_only:false; response_revision:26340; number_of_response:1; }","duration":"396.710764ms","start":"2026-06-23T06:42:39.81201Z","end":"2026-06-23T06:42:40.208721Z","steps":["trace[942773807] 'process raft request' (duration: 396.49003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.208935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:39.811976Z","time spent":"396.865987ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:40.209138Z","caller":"traceutil/trace.go:171","msg":"trace[1497546534] transaction","detail":"{read_only:false; response_revision:26341; number_of_response:1; }","duration":"396.780164ms","start":"2026-06-23T06:42:39.812326Z","end":"2026-06-23T06:42:40.209106Z","steps":["trace[1497546534] 'process raft request' (duration: 396.354596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.209345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.636819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:40.209387Z","caller":"traceutil/trace.go:171","msg":"trace[760609531] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26342; }","duration":"341.734971ms","start":"2026-06-23T06:42:39.867645Z","end":"2026-06-23T06:42:40.20938Z","steps":["trace[760609531] 'agreement among raft nodes before linearized reading' (duration: 341.644459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.209415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:39.867623Z","time spent":"341.784741ms","remote":"127.0.0.1:45458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-23T06:42:40.209436Z","caller":"traceutil/trace.go:171","msg":"trace[1608920003] transaction","detail":"{read_only:false; response_revision:26342; number_of_response:1; }","duration":"396.731394ms","start":"2026-06-23T06:42:39.812694Z","end":"2026-06-23T06:42:40.209425Z","steps":["trace[1608920003] 'process raft request' (duration: 396.255765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.209522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:39.81266Z","time spent":"396.809595ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:40.209599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:39.812315Z","time spent":"396.990449ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:40.209236Z","caller":"traceutil/trace.go:171","msg":"trace[1654099086] linearizableReadLoop","detail":"{readStateIndex:27217; appliedIndex:27214; }","duration":"341.519477ms","start":"2026-06-23T06:42:39.867688Z","end":"2026-06-23T06:42:40.209207Z","steps":["trace[1654099086] 'read index received' (duration: 340.742672ms)","trace[1654099086] 'applied index is now lower than readState.Index' (duration: 775.815µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:40.209789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.288381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:40.209819Z","caller":"traceutil/trace.go:171","msg":"trace[864329354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26342; }","duration":"100.355162ms","start":"2026-06-23T06:42:40.109457Z","end":"2026-06-23T06:42:40.209812Z","steps":["trace[864329354] 'agreement among raft nodes before linearized reading' (duration: 100.302761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.209827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.525385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:40.209881Z","caller":"traceutil/trace.go:171","msg":"trace[1049351743] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:26342; }","duration":"314.657948ms","start":"2026-06-23T06:42:39.895209Z","end":"2026-06-23T06:42:40.209867Z","steps":["trace[1049351743] 'agreement among raft nodes before linearized reading' (duration: 314.550045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.209919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:39.895189Z","time spent":"314.722459ms","remote":"127.0.0.1:45390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":30,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:42:40.210048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.957315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T06:42:40.210101Z","caller":"traceutil/trace.go:171","msg":"trace[430028793] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26342; }","duration":"168.055687ms","start":"2026-06-23T06:42:40.042028Z","end":"2026-06-23T06:42:40.210083Z","steps":["trace[430028793] 'agreement among raft nodes before linearized reading' (duration: 167.956555ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:40.356658Z","caller":"traceutil/trace.go:171","msg":"trace[1860268649] transaction","detail":"{read_only:false; response_revision:26344; number_of_response:1; }","duration":"140.127547ms","start":"2026-06-23T06:42:40.2165Z","end":"2026-06-23T06:42:40.356628Z","steps":["trace[1860268649] 'process raft request' (duration: 140.044645ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:40.356794Z","caller":"traceutil/trace.go:171","msg":"trace[432643564] transaction","detail":"{read_only:false; response_revision:26343; number_of_response:1; }","duration":"142.594064ms","start":"2026-06-23T06:42:40.214155Z","end":"2026-06-23T06:42:40.356749Z","steps":["trace[432643564] 'process raft request' (duration: 99.103349ms)","trace[432643564] 'compare' (duration: 43.124458ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:40.356955Z","caller":"traceutil/trace.go:171","msg":"trace[1651128386] linearizableReadLoop","detail":"{readStateIndex:27218; appliedIndex:27217; }","duration":"141.559215ms","start":"2026-06-23T06:42:40.215385Z","end":"2026-06-23T06:42:40.356944Z","steps":["trace[1651128386] 'read index received' (duration: 97.928637ms)","trace[1651128386] 'applied index is now lower than readState.Index' (duration: 43.629448ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:40.357122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.724408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18596"} {"level":"info","ts":"2026-06-23T06:42:40.357151Z","caller":"traceutil/trace.go:171","msg":"trace[1814324253] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26344; }","duration":"141.81161ms","start":"2026-06-23T06:42:40.215331Z","end":"2026-06-23T06:42:40.357143Z","steps":["trace[1814324253] 'agreement among raft nodes before linearized reading' (duration: 141.673997ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:40.508293Z","caller":"traceutil/trace.go:171","msg":"trace[1619912980] transaction","detail":"{read_only:false; response_revision:26345; number_of_response:1; }","duration":"146.501418ms","start":"2026-06-23T06:42:40.361758Z","end":"2026-06-23T06:42:40.508259Z","steps":["trace[1619912980] 'process raft request' (duration: 134.026012ms)","trace[1619912980] 'compare' (duration: 11.871175ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:40.562187Z","caller":"traceutil/trace.go:171","msg":"trace[89141822] linearizableReadLoop","detail":"{readStateIndex:27222; appliedIndex:27219; }","duration":"193.00718ms","start":"2026-06-23T06:42:40.369152Z","end":"2026-06-23T06:42:40.562159Z","steps":["trace[89141822] 'read index received' (duration: 126.648523ms)","trace[89141822] 'applied index is now lower than readState.Index' (duration: 66.357327ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:40.562308Z","caller":"traceutil/trace.go:171","msg":"trace[985571091] transaction","detail":"{read_only:false; response_revision:26346; number_of_response:1; }","duration":"199.376981ms","start":"2026-06-23T06:42:40.362877Z","end":"2026-06-23T06:42:40.562254Z","steps":["trace[985571091] 'process raft request' (duration: 199.033445ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:40.562359Z","caller":"traceutil/trace.go:171","msg":"trace[19376856] transaction","detail":"{read_only:false; response_revision:26347; number_of_response:1; }","duration":"196.103309ms","start":"2026-06-23T06:42:40.366187Z","end":"2026-06-23T06:42:40.56229Z","steps":["trace[19376856] 'process raft request' (duration: 195.904485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:40.562466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.285065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-23T06:42:40.56251Z","caller":"traceutil/trace.go:171","msg":"trace[44951595] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26347; }","duration":"193.387828ms","start":"2026-06-23T06:42:40.369111Z","end":"2026-06-23T06:42:40.562499Z","steps":["trace[44951595] 'agreement among raft nodes before linearized reading' (duration: 193.199324ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:40.770239Z","caller":"traceutil/trace.go:171","msg":"trace[1716905708] transaction","detail":"{read_only:false; response_revision:26348; number_of_response:1; }","duration":"115.228176ms","start":"2026-06-23T06:42:40.654974Z","end":"2026-06-23T06:42:40.770202Z","steps":["trace[1716905708] 'process raft request' (duration: 101.876433ms)","trace[1716905708] 'compare' (duration: 13.160549ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:40.970376Z","caller":"traceutil/trace.go:171","msg":"trace[352160049] transaction","detail":"{read_only:false; response_revision:26349; number_of_response:1; }","duration":"113.995743ms","start":"2026-06-23T06:42:40.856343Z","end":"2026-06-23T06:42:40.970339Z","steps":["trace[352160049] 'process raft request' (duration: 98.957568ms)","trace[352160049] 'compare' (duration: 14.902022ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:41.26089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.026709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:41.261016Z","caller":"traceutil/trace.go:171","msg":"trace[1627925378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26349; }","duration":"147.230832ms","start":"2026-06-23T06:42:41.113757Z","end":"2026-06-23T06:42:41.260987Z","steps":["trace[1627925378] 'range keys from in-memory index tree' (duration: 146.911106ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:41.261375Z","caller":"traceutil/trace.go:171","msg":"trace[1580303984] transaction","detail":"{read_only:false; response_revision:26350; number_of_response:1; }","duration":"144.405379ms","start":"2026-06-23T06:42:41.116936Z","end":"2026-06-23T06:42:41.261342Z","steps":["trace[1580303984] 'process raft request' (duration: 133.91888ms)","trace[1580303984] 'compare' (duration: 10.184243ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:41.759679Z","caller":"traceutil/trace.go:171","msg":"trace[1786413113] transaction","detail":"{read_only:false; response_revision:26352; number_of_response:1; }","duration":"231.728475ms","start":"2026-06-23T06:42:41.527916Z","end":"2026-06-23T06:42:41.759644Z","steps":["trace[1786413113] 'process raft request' (duration: 173.363648ms)","trace[1786413113] 'compare' (duration: 57.621092ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:42.04008Z","caller":"traceutil/trace.go:171","msg":"trace[1723118322] transaction","detail":"{read_only:false; response_revision:26353; number_of_response:1; }","duration":"172.643904ms","start":"2026-06-23T06:42:41.8674Z","end":"2026-06-23T06:42:42.040044Z","steps":["trace[1723118322] 'process raft request' (duration: 149.025016ms)","trace[1723118322] 'compare' (duration: 23.421154ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:42.071953Z","caller":"traceutil/trace.go:171","msg":"trace[1913084896] transaction","detail":"{read_only:false; response_revision:26354; number_of_response:1; }","duration":"203.904227ms","start":"2026-06-23T06:42:41.868003Z","end":"2026-06-23T06:42:42.071907Z","steps":["trace[1913084896] 'process raft request' (duration: 203.664212ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:42.288058Z","caller":"traceutil/trace.go:171","msg":"trace[791497516] transaction","detail":"{read_only:false; response_revision:26355; number_of_response:1; }","duration":"194.490628ms","start":"2026-06-23T06:42:42.093527Z","end":"2026-06-23T06:42:42.288018Z","steps":["trace[791497516] 'process raft request' (duration: 113.977222ms)","trace[791497516] 'compare' (duration: 80.031187ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:42.370796Z","caller":"traceutil/trace.go:171","msg":"trace[1754401626] transaction","detail":"{read_only:false; response_revision:26357; number_of_response:1; }","duration":"154.319986ms","start":"2026-06-23T06:42:42.21645Z","end":"2026-06-23T06:42:42.37077Z","steps":["trace[1754401626] 'process raft request' (duration: 154.053951ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:42.370936Z","caller":"traceutil/trace.go:171","msg":"trace[2121478140] transaction","detail":"{read_only:false; response_revision:26358; number_of_response:1; }","duration":"154.017181ms","start":"2026-06-23T06:42:42.216897Z","end":"2026-06-23T06:42:42.370914Z","steps":["trace[2121478140] 'process raft request' (duration: 153.833087ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:42.631493Z","caller":"traceutil/trace.go:171","msg":"trace[1476950791] transaction","detail":"{read_only:false; response_revision:26362; number_of_response:1; }","duration":"111.322381ms","start":"2026-06-23T06:42:42.520133Z","end":"2026-06-23T06:42:42.631456Z","steps":["trace[1476950791] 'process raft request' (duration: 111.014895ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:44.297499Z","caller":"traceutil/trace.go:171","msg":"trace[2093475335] transaction","detail":"{read_only:false; response_revision:26370; number_of_response:1; }","duration":"219.793038ms","start":"2026-06-23T06:42:44.077676Z","end":"2026-06-23T06:42:44.297469Z","steps":["trace[2093475335] 'process raft request' (duration: 181.095644ms)","trace[2093475335] 'compare' (duration: 37.794676ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:53.980744Z","caller":"traceutil/trace.go:171","msg":"trace[419208977] transaction","detail":"{read_only:false; response_revision:26439; number_of_response:1; }","duration":"566.308372ms","start":"2026-06-23T06:42:53.414403Z","end":"2026-06-23T06:42:53.980711Z","steps":["trace[419208977] 'process raft request' (duration: 566.061737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:53.981156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:53.414379Z","time spent":"566.663188ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:54.861407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.866741ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:42:54.861697Z","caller":"traceutil/trace.go:171","msg":"trace[1841384808] linearizableReadLoop","detail":"{readStateIndex:27318; appliedIndex:27316; }","duration":"1.054687096s","start":"2026-06-23T06:42:53.806988Z","end":"2026-06-23T06:42:54.861675Z","steps":["trace[1841384808] 'read index received' (duration: 173.390606ms)","trace[1841384808] 'applied index is now lower than readState.Index' (duration: 881.29513ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:54.861806Z","caller":"traceutil/trace.go:171","msg":"trace[1294832631] transaction","detail":"{read_only:false; response_revision:26440; number_of_response:1; }","duration":"1.238231374s","start":"2026-06-23T06:42:53.623531Z","end":"2026-06-23T06:42:54.861762Z","steps":["trace[1294832631] 'process raft request' (duration: 736.909244ms)","trace[1294832631] 'compare' (duration: 499.426694ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:54.86183Z","caller":"traceutil/trace.go:171","msg":"trace[1065279958] transaction","detail":"{read_only:false; response_revision:26441; number_of_response:1; }","duration":"1.004629277s","start":"2026-06-23T06:42:53.857149Z","end":"2026-06-23T06:42:54.861779Z","steps":["trace[1065279958] 'process raft request' (duration: 1.004391323s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:54.86188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054855539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:54.861994Z","caller":"traceutil/trace.go:171","msg":"trace[831558102] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:26441; }","duration":"1.055036503s","start":"2026-06-23T06:42:53.806934Z","end":"2026-06-23T06:42:54.861971Z","steps":["trace[831558102] 'agreement among raft nodes before linearized reading' (duration: 1.054838189s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:54.862016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:53.623496Z","time spent":"1.238414108s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:54.862037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:53.857123Z","time spent":"1.004801911s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:54.862048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:53.806908Z","time spent":"1.055126325s","remote":"127.0.0.1:45308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:42:54.950194Z","caller":"traceutil/trace.go:171","msg":"trace[760454884] transaction","detail":"{read_only:false; response_revision:26444; number_of_response:1; }","duration":"605.428992ms","start":"2026-06-23T06:42:54.344731Z","end":"2026-06-23T06:42:54.95016Z","steps":["trace[760454884] 'process raft request' (duration: 605.375241ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:54.950227Z","caller":"traceutil/trace.go:171","msg":"trace[1026851366] transaction","detail":"{read_only:false; response_revision:26442; number_of_response:1; }","duration":"849.346014ms","start":"2026-06-23T06:42:54.100841Z","end":"2026-06-23T06:42:54.950187Z","steps":["trace[1026851366] 'process raft request' (duration: 848.939526ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:54.950373Z","caller":"traceutil/trace.go:171","msg":"trace[2098510654] transaction","detail":"{read_only:false; response_revision:26443; number_of_response:1; }","duration":"605.637846ms","start":"2026-06-23T06:42:54.344664Z","end":"2026-06-23T06:42:54.950302Z","steps":["trace[2098510654] 'process raft request' (duration: 605.390691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:54.950423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.3447Z","time spent":"605.592906ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:54.950437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.100812Z","time spent":"849.498707ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:54.95063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.344569Z","time spent":"605.907141ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:55.791122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.921543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:42:55.791421Z","caller":"traceutil/trace.go:171","msg":"trace[1911904583] linearizableReadLoop","detail":"{readStateIndex:27324; appliedIndex:27319; }","duration":"929.661026ms","start":"2026-06-23T06:42:54.861739Z","end":"2026-06-23T06:42:55.7914Z","steps":["trace[1911904583] 'read index received' (duration: 88.12978ms)","trace[1911904583] 'applied index is now lower than readState.Index' (duration: 841.529986ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:42:55.791512Z","caller":"traceutil/trace.go:171","msg":"trace[1348751589] transaction","detail":"{read_only:false; response_revision:26446; number_of_response:1; }","duration":"1.354901424s","start":"2026-06-23T06:42:54.4366Z","end":"2026-06-23T06:42:55.791501Z","steps":["trace[1348751589] 'process raft request' (duration: 1.354638709s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.79161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.436545Z","time spent":"1.354999036s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:55.791626Z","caller":"traceutil/trace.go:171","msg":"trace[2098731568] transaction","detail":"{read_only:false; response_revision:26445; number_of_response:1; }","duration":"1.373895764s","start":"2026-06-23T06:42:54.417657Z","end":"2026-06-23T06:42:55.791553Z","steps":["trace[2098731568] 'process raft request' (duration: 892.427281ms)","trace[2098731568] 'compare' (duration: 480.673997ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:55.791822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.417625Z","time spent":"1.374099098s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:55.792203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.634177826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:55.792255Z","caller":"traceutil/trace.go:171","msg":"trace[1530139170] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:26447; }","duration":"1.634277837s","start":"2026-06-23T06:42:54.157961Z","end":"2026-06-23T06:42:55.792239Z","steps":["trace[1530139170] 'agreement among raft nodes before linearized reading' (duration: 1.633984751s)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:55.792228Z","caller":"traceutil/trace.go:171","msg":"trace[1838182094] transaction","detail":"{read_only:false; response_revision:26447; number_of_response:1; }","duration":"485.189493ms","start":"2026-06-23T06:42:55.307009Z","end":"2026-06-23T06:42:55.792198Z","steps":["trace[1838182094] 'process raft request' (duration: 484.347317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.792293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.157935Z","time spent":"1.634348529s","remote":"127.0.0.1:35120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:42:55.792382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077983177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-23T06:42:55.79241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.306981Z","time spent":"485.326226ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:55.792456Z","caller":"traceutil/trace.go:171","msg":"trace[1135319443] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26447; }","duration":"1.078100899s","start":"2026-06-23T06:42:54.714337Z","end":"2026-06-23T06:42:55.792438Z","steps":["trace[1135319443] 'agreement among raft nodes before linearized reading' (duration: 1.077357045s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.792486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.893010201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:42:55.792498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.714323Z","time spent":"1.078162949s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-23T06:42:55.792524Z","caller":"traceutil/trace.go:171","msg":"trace[1009305803] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:26447; }","duration":"1.893095793s","start":"2026-06-23T06:42:53.899418Z","end":"2026-06-23T06:42:55.792513Z","steps":["trace[1009305803] 'agreement among raft nodes before linearized reading' (duration: 1.893036992s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.792541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096930426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-23T06:42:55.79253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.340322467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-23T06:42:55.792626Z","caller":"traceutil/trace.go:171","msg":"trace[177139850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26447; }","duration":"1.097011898s","start":"2026-06-23T06:42:54.695599Z","end":"2026-06-23T06:42:55.792611Z","steps":["trace[177139850] 'agreement among raft nodes before linearized reading' (duration: 1.096130641s)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:55.792633Z","caller":"traceutil/trace.go:171","msg":"trace[1967975960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26447; }","duration":"1.340479s","start":"2026-06-23T06:42:54.452137Z","end":"2026-06-23T06:42:55.792616Z","steps":["trace[1967975960] 'agreement among raft nodes before linearized reading' (duration: 1.339767107s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.792628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342498999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-23T06:42:55.792659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.695507Z","time spent":"1.097143939s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T06:42:55.792643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092257787s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-23T06:42:55.792672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.452122Z","time spent":"1.340540051s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-23T06:42:55.792658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.574571766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:42:55.792755Z","caller":"traceutil/trace.go:171","msg":"trace[1650652497] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:26447; }","duration":"1.574700978s","start":"2026-06-23T06:42:54.218037Z","end":"2026-06-23T06:42:55.792738Z","steps":["trace[1650652497] 'agreement among raft nodes before linearized reading' (duration: 1.573898413s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.792761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052184727s","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:8"} {"level":"warn","ts":"2026-06-23T06:42:55.792777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041902443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:55.792803Z","caller":"traceutil/trace.go:171","msg":"trace[661741548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:26447; }","duration":"1.042023465s","start":"2026-06-23T06:42:54.75077Z","end":"2026-06-23T06:42:55.792794Z","steps":["trace[661741548] 'agreement among raft nodes before linearized reading' (duration: 1.040891904s)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:55.792798Z","caller":"traceutil/trace.go:171","msg":"trace[2093538609] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26447; }","duration":"1.052224148s","start":"2026-06-23T06:42:54.740564Z","end":"2026-06-23T06:42:55.792788Z","steps":["trace[2093538609] 'agreement among raft nodes before linearized reading' (duration: 1.051115257s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.792927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176739377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:55.793039Z","caller":"traceutil/trace.go:171","msg":"trace[1981886346] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:26447; }","duration":"1.177005032s","start":"2026-06-23T06:42:54.616007Z","end":"2026-06-23T06:42:55.793012Z","steps":["trace[1981886346] 'agreement among raft nodes before linearized reading' (duration: 1.175607886s)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:55.792682Z","caller":"traceutil/trace.go:171","msg":"trace[1694040628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26447; }","duration":"1.34258073s","start":"2026-06-23T06:42:54.450087Z","end":"2026-06-23T06:42:55.792668Z","steps":["trace[1694040628] 'agreement among raft nodes before linearized reading' (duration: 1.341837656s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.793107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.61598Z","time spent":"1.177112295s","remote":"127.0.0.1:57764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:42:55.793091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.740518Z","time spent":"1.052500362s","remote":"127.0.0.1:50806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:42:55.793135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.450075Z","time spent":"1.343035278s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T06:42:55.792799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.21801Z","time spent":"1.57477543s","remote":"127.0.0.1:51318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":32,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:42:55.792709Z","caller":"traceutil/trace.go:171","msg":"trace[1452935159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26447; }","duration":"1.092377029s","start":"2026-06-23T06:42:54.700315Z","end":"2026-06-23T06:42:55.792692Z","steps":["trace[1452935159] 'agreement among raft nodes before linearized reading' (duration: 1.091391811s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.793293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.700287Z","time spent":"1.09298631s","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T06:42:55.792558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:53.899398Z","time spent":"1.893150044s","remote":"127.0.0.1:45270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:42:55.792907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:54.75074Z","time spent":"1.042157527s","remote":"127.0.0.1:57772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:42:55.842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.924186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:55.842108Z","caller":"traceutil/trace.go:171","msg":"trace[1661712231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26448; }","duration":"734.07294ms","start":"2026-06-23T06:42:55.108012Z","end":"2026-06-23T06:42:55.842085Z","steps":["trace[1661712231] 'agreement among raft nodes before linearized reading' (duration: 733.892056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.842155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.107992Z","time spent":"734.151721ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T06:42:55.842125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.138119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:42:55.842224Z","caller":"traceutil/trace.go:171","msg":"trace[923941823] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:26448; }","duration":"412.311573ms","start":"2026-06-23T06:42:55.429888Z","end":"2026-06-23T06:42:55.842199Z","steps":["trace[923941823] 'agreement among raft nodes before linearized reading' (duration: 412.075858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.8422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.902175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:42:55.842289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.429865Z","time spent":"412.409794ms","remote":"127.0.0.1:38196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":10,"response size":32,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:42:55.842318Z","caller":"traceutil/trace.go:171","msg":"trace[831961574] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:26448; }","duration":"679.047947ms","start":"2026-06-23T06:42:55.163223Z","end":"2026-06-23T06:42:55.842271Z","steps":["trace[831961574] 'agreement among raft nodes before linearized reading' (duration: 678.905414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.842318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.269534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:42:55.842374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.163195Z","time spent":"679.16699ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-06-23T06:42:55.842397Z","caller":"traceutil/trace.go:171","msg":"trace[1225301118] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26448; }","duration":"714.377046ms","start":"2026-06-23T06:42:55.128Z","end":"2026-06-23T06:42:55.842377Z","steps":["trace[1225301118] 'agreement among raft nodes before linearized reading' (duration: 714.237673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:55.842454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.127986Z","time spent":"714.457708ms","remote":"127.0.0.1:35120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T06:42:56.345069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620627403378927748,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T06:42:56.460712Z","caller":"traceutil/trace.go:171","msg":"trace[388818498] transaction","detail":"{read_only:false; response_revision:26449; number_of_response:1; }","duration":"662.579544ms","start":"2026-06-23T06:42:55.798096Z","end":"2026-06-23T06:42:56.460676Z","steps":["trace[388818498] 'process raft request' (duration: 662.064644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.46085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.798074Z","time spent":"662.708947ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:56.460988Z","caller":"traceutil/trace.go:171","msg":"trace[314240411] transaction","detail":"{read_only:false; response_revision:26450; number_of_response:1; }","duration":"662.004004ms","start":"2026-06-23T06:42:55.798926Z","end":"2026-06-23T06:42:56.46093Z","steps":["trace[314240411] 'process raft request' (duration: 661.602847ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:42:56.461022Z","caller":"traceutil/trace.go:171","msg":"trace[513680212] transaction","detail":"{read_only:false; response_revision:26451; number_of_response:1; }","duration":"661.903642ms","start":"2026-06-23T06:42:55.799094Z","end":"2026-06-23T06:42:56.460998Z","steps":["trace[513680212] 'process raft request' (duration: 661.470074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.461298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.798919Z","time spent":"662.213438ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:56.461313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.799071Z","time spent":"662.093475ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:56.461327Z","caller":"traceutil/trace.go:171","msg":"trace[1631428699] transaction","detail":"{read_only:false; response_revision:26453; number_of_response:1; }","duration":"661.651216ms","start":"2026-06-23T06:42:55.799667Z","end":"2026-06-23T06:42:56.461318Z","steps":["trace[1631428699] 'process raft request' (duration: 661.540844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.461522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.799645Z","time spent":"661.82932ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:56.461352Z","caller":"traceutil/trace.go:171","msg":"trace[1223547044] transaction","detail":"{read_only:false; response_revision:26452; number_of_response:1; }","duration":"662.237369ms","start":"2026-06-23T06:42:55.79911Z","end":"2026-06-23T06:42:56.461347Z","steps":["trace[1223547044] 'process raft request' (duration: 661.793281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.461728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.799086Z","time spent":"662.574175ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:42:56.467559Z","caller":"traceutil/trace.go:171","msg":"trace[891978513] linearizableReadLoop","detail":"{readStateIndex:27332; appliedIndex:27326; }","duration":"623.743629ms","start":"2026-06-23T06:42:55.843804Z","end":"2026-06-23T06:42:56.467547Z","steps":["trace[891978513] 'read index received' (duration: 616.094814ms)","trace[891978513] 'applied index is now lower than readState.Index' (duration: 7.648145ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:42:56.467671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.862841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:56.467706Z","caller":"traceutil/trace.go:171","msg":"trace[1038057151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26454; }","duration":"623.935112ms","start":"2026-06-23T06:42:55.843763Z","end":"2026-06-23T06:42:56.467698Z","steps":["trace[1038057151] 'agreement among raft nodes before linearized reading' (duration: 623.874111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.46773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.843745Z","time spent":"623.980753ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T06:42:56.467719Z","caller":"traceutil/trace.go:171","msg":"trace[780034354] transaction","detail":"{read_only:false; response_revision:26454; number_of_response:1; }","duration":"480.385211ms","start":"2026-06-23T06:42:55.987274Z","end":"2026-06-23T06:42:56.467659Z","steps":["trace[780034354] 'process raft request' (duration: 480.207928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.467773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.233041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:56.467841Z","caller":"traceutil/trace.go:171","msg":"trace[1379434997] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:26454; }","duration":"241.339353ms","start":"2026-06-23T06:42:56.226468Z","end":"2026-06-23T06:42:56.467807Z","steps":["trace[1379434997] 'agreement among raft nodes before linearized reading' (duration: 241.239031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.467836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.006387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-23T06:42:56.467856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.362236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:42:56.467885Z","caller":"traceutil/trace.go:171","msg":"trace[1332071937] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26454; }","duration":"620.054908ms","start":"2026-06-23T06:42:55.847818Z","end":"2026-06-23T06:42:56.467873Z","steps":["trace[1332071937] 'agreement among raft nodes before linearized reading' (duration: 619.874695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.467895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.987245Z","time spent":"480.558955ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:42:56.467915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.847781Z","time spent":"620.12901ms","remote":"127.0.0.1:45446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-23T06:42:56.467923Z","caller":"traceutil/trace.go:171","msg":"trace[1139212743] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26454; }","duration":"619.457087ms","start":"2026-06-23T06:42:55.848445Z","end":"2026-06-23T06:42:56.467903Z","steps":["trace[1139212743] 'agreement among raft nodes before linearized reading' (duration: 619.360005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:42:56.467963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:42:55.848426Z","time spent":"619.527909ms","remote":"127.0.0.1:45458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T06:42:56.467871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.782341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:42:56.468035Z","caller":"traceutil/trace.go:171","msg":"trace[567700462] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:26454; }","duration":"204.035756ms","start":"2026-06-23T06:42:56.263985Z","end":"2026-06-23T06:42:56.46802Z","steps":["trace[567700462] 'agreement among raft nodes before linearized reading' (duration: 203.776421ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:06.096724Z","caller":"traceutil/trace.go:171","msg":"trace[1192651089] transaction","detail":"{read_only:false; response_revision:26603; number_of_response:1; }","duration":"297.659767ms","start":"2026-06-23T06:43:05.799032Z","end":"2026-06-23T06:43:06.096692Z","steps":["trace[1192651089] 'process raft request' (duration: 297.448403ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:06.311023Z","caller":"traceutil/trace.go:171","msg":"trace[1668202184] transaction","detail":"{read_only:false; response_revision:26604; number_of_response:1; }","duration":"472.791323ms","start":"2026-06-23T06:43:05.838205Z","end":"2026-06-23T06:43:06.310996Z","steps":["trace[1668202184] 'process raft request' (duration: 472.62439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.311175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:05.838175Z","time spent":"472.926626ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:06.311244Z","caller":"traceutil/trace.go:171","msg":"trace[543421489] linearizableReadLoop","detail":"{readStateIndex:27487; appliedIndex:27485; }","duration":"201.550306ms","start":"2026-06-23T06:43:06.109656Z","end":"2026-06-23T06:43:06.311206Z","steps":["trace[543421489] 'read index received' (duration: 201.119958ms)","trace[543421489] 'applied index is now lower than readState.Index' (duration: 428.108µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:06.311374Z","caller":"traceutil/trace.go:171","msg":"trace[368283837] transaction","detail":"{read_only:false; response_revision:26605; number_of_response:1; }","duration":"460.858257ms","start":"2026-06-23T06:43:05.850507Z","end":"2026-06-23T06:43:06.311365Z","steps":["trace[368283837] 'process raft request' (duration: 460.45616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.311404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.7324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:43:06.311415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:05.850485Z","time spent":"460.907709ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:06.311443Z","caller":"traceutil/trace.go:171","msg":"trace[444120658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26605; }","duration":"201.861393ms","start":"2026-06-23T06:43:06.10957Z","end":"2026-06-23T06:43:06.311432Z","steps":["trace[444120658] 'agreement among raft nodes before linearized reading' (duration: 201.757131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.605036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.517781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:06.605177Z","caller":"traceutil/trace.go:171","msg":"trace[1357355086] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26605; }","duration":"112.720495ms","start":"2026-06-23T06:43:06.492425Z","end":"2026-06-23T06:43:06.605146Z","steps":["trace[1357355086] 'range keys from in-memory index tree' (duration: 112.277676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.998757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.666958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:43:06.999038Z","caller":"traceutil/trace.go:171","msg":"trace[1558585498] linearizableReadLoop","detail":"{readStateIndex:27493; appliedIndex:27488; }","duration":"384.95225ms","start":"2026-06-23T06:43:06.614067Z","end":"2026-06-23T06:43:06.99902Z","steps":["trace[1558585498] 'read index received' (duration: 11.806744ms)","trace[1558585498] 'applied index is now lower than readState.Index' (duration: 373.144466ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:06.999023Z","caller":"traceutil/trace.go:171","msg":"trace[1569759355] transaction","detail":"{read_only:false; response_revision:26608; number_of_response:1; }","duration":"387.153061ms","start":"2026-06-23T06:43:06.611814Z","end":"2026-06-23T06:43:06.998967Z","steps":["trace[1569759355] 'process raft request' (duration: 269.093235ms)","trace[1569759355] 'compare' (duration: 117.348672ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:06.999107Z","caller":"traceutil/trace.go:171","msg":"trace[2139040145] transaction","detail":"{read_only:false; response_revision:26611; number_of_response:1; }","duration":"386.427377ms","start":"2026-06-23T06:43:06.612634Z","end":"2026-06-23T06:43:06.999062Z","steps":["trace[2139040145] 'process raft request' (duration: 386.340466ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:06.99912Z","caller":"traceutil/trace.go:171","msg":"trace[1103013220] transaction","detail":"{read_only:false; response_revision:26610; number_of_response:1; }","duration":"387.175901ms","start":"2026-06-23T06:43:06.611879Z","end":"2026-06-23T06:43:06.999055Z","steps":["trace[1103013220] 'process raft request' (duration: 387.056009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.999205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.146433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:43:06.999228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:06.611785Z","time spent":"387.347845ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:06.999243Z","caller":"traceutil/trace.go:171","msg":"trace[2126295656] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26611; }","duration":"385.213865ms","start":"2026-06-23T06:43:06.614017Z","end":"2026-06-23T06:43:06.999231Z","steps":["trace[2126295656] 'agreement among raft nodes before linearized reading' (duration: 385.118453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.999299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:06.613997Z","time spent":"385.293457ms","remote":"127.0.0.1:45458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-06-23T06:43:06.99934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:06.611872Z","time spent":"387.364625ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:43:06.999366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:06.612625Z","time spent":"386.58186ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:43:06.999408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.402776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-23T06:43:06.999486Z","caller":"traceutil/trace.go:171","msg":"trace[1619864365] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26611; }","duration":"331.541169ms","start":"2026-06-23T06:43:06.667926Z","end":"2026-06-23T06:43:06.999467Z","steps":["trace[1619864365] 'agreement among raft nodes before linearized reading' (duration: 331.293483ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:06.999506Z","caller":"traceutil/trace.go:171","msg":"trace[377862893] transaction","detail":"{read_only:false; response_revision:26609; number_of_response:1; }","duration":"387.642551ms","start":"2026-06-23T06:43:06.611848Z","end":"2026-06-23T06:43:06.99949Z","steps":["trace[377862893] 'process raft request' (duration: 387.024659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.999533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:06.667899Z","time spent":"331.62149ms","remote":"127.0.0.1:45446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-23T06:43:06.999624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:06.611835Z","time spent":"387.705062ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:43:06.99969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.517631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:07.000189Z","caller":"traceutil/trace.go:171","msg":"trace[737307495] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:26611; }","duration":"189.075021ms","start":"2026-06-23T06:43:06.8111Z","end":"2026-06-23T06:43:07.000175Z","steps":["trace[737307495] 'agreement among raft nodes before linearized reading' (duration: 188.538711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:06.999822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.112428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:07.000505Z","caller":"traceutil/trace.go:171","msg":"trace[29585730] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26611; }","duration":"258.667398ms","start":"2026-06-23T06:43:06.741625Z","end":"2026-06-23T06:43:07.000292Z","steps":["trace[29585730] 'agreement among raft nodes before linearized reading' (duration: 258.125248ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:32.835166Z","caller":"traceutil/trace.go:171","msg":"trace[927562158] linearizableReadLoop","detail":"{readStateIndex:27706; appliedIndex:27705; }","duration":"128.450199ms","start":"2026-06-23T06:43:32.706681Z","end":"2026-06-23T06:43:32.835131Z","steps":["trace[927562158] 'read index received' (duration: 128.207655ms)","trace[927562158] 'applied index is now lower than readState.Index' (duration: 241.224µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:32.835294Z","caller":"traceutil/trace.go:171","msg":"trace[1036466183] transaction","detail":"{read_only:false; response_revision:26819; number_of_response:1; }","duration":"130.835055ms","start":"2026-06-23T06:43:32.70441Z","end":"2026-06-23T06:43:32.835245Z","steps":["trace[1036466183] 'process raft request' (duration: 130.457508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:32.835498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.790255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-23T06:43:32.835554Z","caller":"traceutil/trace.go:171","msg":"trace[41273572] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26819; }","duration":"128.993879ms","start":"2026-06-23T06:43:32.706544Z","end":"2026-06-23T06:43:32.835538Z","steps":["trace[41273572] 'agreement among raft nodes before linearized reading' (duration: 128.766575ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:36.567428Z","caller":"traceutil/trace.go:171","msg":"trace[1095678742] transaction","detail":"{read_only:false; response_revision:26845; number_of_response:1; }","duration":"132.289931ms","start":"2026-06-23T06:43:36.435105Z","end":"2026-06-23T06:43:36.567395Z","steps":["trace[1095678742] 'process raft request' (duration: 132.094448ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:36.586167Z","caller":"traceutil/trace.go:171","msg":"trace[69705217] transaction","detail":"{read_only:false; response_revision:26846; number_of_response:1; }","duration":"143.732697ms","start":"2026-06-23T06:43:36.442417Z","end":"2026-06-23T06:43:36.58615Z","steps":["trace[69705217] 'process raft request' (duration: 143.630885ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:37.081778Z","caller":"traceutil/trace.go:171","msg":"trace[1401878607] transaction","detail":"{read_only:false; response_revision:26849; number_of_response:1; }","duration":"188.105756ms","start":"2026-06-23T06:43:36.893601Z","end":"2026-06-23T06:43:37.081706Z","steps":["trace[1401878607] 'process raft request' (duration: 153.101435ms)","trace[1401878607] 'compare' (duration: 34.616584ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:38.458257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.232257ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-23T06:43:38.680638Z","caller":"traceutil/trace.go:171","msg":"trace[1820447172] transaction","detail":"{read_only:false; response_revision:26860; number_of_response:1; }","duration":"103.170881ms","start":"2026-06-23T06:43:38.577434Z","end":"2026-06-23T06:43:38.680605Z","steps":["trace[1820447172] 'process raft request' (duration: 102.686382ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.041559Z","caller":"traceutil/trace.go:171","msg":"trace[1735320485] transaction","detail":"{read_only:false; response_revision:26861; number_of_response:1; }","duration":"449.811183ms","start":"2026-06-23T06:43:38.591684Z","end":"2026-06-23T06:43:39.041495Z","steps":["trace[1735320485] 'process raft request' (duration: 358.543468ms)","trace[1735320485] 'compare' (duration: 90.895347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:39.041804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:38.591667Z","time spent":"450.029318ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:39.054727Z","caller":"traceutil/trace.go:171","msg":"trace[1025621003] linearizableReadLoop","detail":"{readStateIndex:27751; appliedIndex:27750; }","duration":"102.515818ms","start":"2026-06-23T06:43:38.952199Z","end":"2026-06-23T06:43:39.054715Z","steps":["trace[1025621003] 'read index received' (duration: 102.455836ms)","trace[1025621003] 'applied index is now lower than readState.Index' (duration: 59.361µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:39.054936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.726481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:43:39.054975Z","caller":"traceutil/trace.go:171","msg":"trace[1819817202] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:26862; }","duration":"102.802452ms","start":"2026-06-23T06:43:38.95216Z","end":"2026-06-23T06:43:39.054963Z","steps":["trace[1819817202] 'agreement among raft nodes before linearized reading' (duration: 102.609049ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.055281Z","caller":"traceutil/trace.go:171","msg":"trace[1255548340] transaction","detail":"{read_only:false; response_revision:26862; number_of_response:1; }","duration":"181.178376ms","start":"2026-06-23T06:43:38.874086Z","end":"2026-06-23T06:43:39.055264Z","steps":["trace[1255548340] 'process raft request' (duration: 180.564463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:39.438897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.77847ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:43:39.439349Z","caller":"traceutil/trace.go:171","msg":"trace[462298636] transaction","detail":"{read_only:false; response_revision:26863; number_of_response:1; }","duration":"346.397068ms","start":"2026-06-23T06:43:39.092894Z","end":"2026-06-23T06:43:39.439291Z","steps":["trace[462298636] 'process raft request' (duration: 113.081197ms)","trace[462298636] 'compare' (duration: 232.572596ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:39.439467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.835875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:43:39.439523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:39.092859Z","time spent":"346.628873ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:39.439545Z","caller":"traceutil/trace.go:171","msg":"trace[47952711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26864; }","duration":"330.002288ms","start":"2026-06-23T06:43:39.109528Z","end":"2026-06-23T06:43:39.43953Z","steps":["trace[47952711] 'agreement among raft nodes before linearized reading' (duration: 329.856096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:39.439596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:39.109503Z","time spent":"330.087599ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T06:43:39.43934Z","caller":"traceutil/trace.go:171","msg":"trace[1345110204] linearizableReadLoop","detail":"{readStateIndex:27752; appliedIndex:27751; }","duration":"329.672582ms","start":"2026-06-23T06:43:39.109625Z","end":"2026-06-23T06:43:39.439297Z","steps":["trace[1345110204] 'read index received' (duration: 96.31824ms)","trace[1345110204] 'applied index is now lower than readState.Index' (duration: 233.352192ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:39.439111Z","caller":"traceutil/trace.go:171","msg":"trace[1895960098] transaction","detail":"{read_only:false; response_revision:26864; number_of_response:1; }","duration":"226.608593ms","start":"2026-06-23T06:43:39.212483Z","end":"2026-06-23T06:43:39.439092Z","steps":["trace[1895960098] 'process raft request' (duration: 226.550742ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.486548Z","caller":"traceutil/trace.go:171","msg":"trace[2057186985] transaction","detail":"{read_only:false; response_revision:26868; number_of_response:1; }","duration":"268.283271ms","start":"2026-06-23T06:43:39.218236Z","end":"2026-06-23T06:43:39.486519Z","steps":["trace[2057186985] 'process raft request' (duration: 268.24608ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.487027Z","caller":"traceutil/trace.go:171","msg":"trace[1701146176] transaction","detail":"{read_only:false; response_revision:26865; number_of_response:1; }","duration":"271.443171ms","start":"2026-06-23T06:43:39.215571Z","end":"2026-06-23T06:43:39.487014Z","steps":["trace[1701146176] 'process raft request' (duration: 270.705696ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.487185Z","caller":"traceutil/trace.go:171","msg":"trace[1791818037] transaction","detail":"{read_only:false; response_revision:26866; number_of_response:1; }","duration":"271.417161ms","start":"2026-06-23T06:43:39.21576Z","end":"2026-06-23T06:43:39.487177Z","steps":["trace[1791818037] 'process raft request' (duration: 270.644396ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.487367Z","caller":"traceutil/trace.go:171","msg":"trace[365918936] transaction","detail":"{read_only:false; response_revision:26867; number_of_response:1; }","duration":"271.456951ms","start":"2026-06-23T06:43:39.215891Z","end":"2026-06-23T06:43:39.487348Z","steps":["trace[365918936] 'process raft request' (duration: 270.557543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:39.487551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.265523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-06-23T06:43:39.487543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.922806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:43:39.48764Z","caller":"traceutil/trace.go:171","msg":"trace[116458802] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:26868; }","duration":"221.052828ms","start":"2026-06-23T06:43:39.266568Z","end":"2026-06-23T06:43:39.487621Z","steps":["trace[116458802] 'agreement among raft nodes before linearized reading' (duration: 220.820144ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.487594Z","caller":"traceutil/trace.go:171","msg":"trace[1852908000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26868; }","duration":"266.293553ms","start":"2026-06-23T06:43:39.221277Z","end":"2026-06-23T06:43:39.487571Z","steps":["trace[1852908000] 'agreement among raft nodes before linearized reading' (duration: 266.175101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:39.487626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.484418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-23T06:43:39.487765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.724532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-23T06:43:39.487827Z","caller":"traceutil/trace.go:171","msg":"trace[986243850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26868; }","duration":"266.807293ms","start":"2026-06-23T06:43:39.221005Z","end":"2026-06-23T06:43:39.487813Z","steps":["trace[986243850] 'agreement among raft nodes before linearized reading' (duration: 266.584379ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.487712Z","caller":"traceutil/trace.go:171","msg":"trace[1147303941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26868; }","duration":"266.62745ms","start":"2026-06-23T06:43:39.221066Z","end":"2026-06-23T06:43:39.487694Z","steps":["trace[1147303941] 'agreement among raft nodes before linearized reading' (duration: 266.355115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:39.488295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.876502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-23T06:43:39.488464Z","caller":"traceutil/trace.go:171","msg":"trace[49251786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26868; }","duration":"269.078416ms","start":"2026-06-23T06:43:39.219364Z","end":"2026-06-23T06:43:39.488442Z","steps":["trace[49251786] 'agreement among raft nodes before linearized reading' (duration: 268.16993ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.635192Z","caller":"traceutil/trace.go:171","msg":"trace[706431233] transaction","detail":"{read_only:false; response_revision:26872; number_of_response:1; }","duration":"140.822783ms","start":"2026-06-23T06:43:39.494338Z","end":"2026-06-23T06:43:39.63516Z","steps":["trace[706431233] 'process raft request' (duration: 140.768861ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:39.635427Z","caller":"traceutil/trace.go:171","msg":"trace[1224796341] transaction","detail":"{read_only:false; response_revision:26870; number_of_response:1; }","duration":"141.382683ms","start":"2026-06-23T06:43:39.494009Z","end":"2026-06-23T06:43:39.635391Z","steps":["trace[1224796341] 'process raft request' (duration: 94.393704ms)","trace[1224796341] 'compare' (duration: 46.505139ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:39.635548Z","caller":"traceutil/trace.go:171","msg":"trace[729698791] transaction","detail":"{read_only:false; response_revision:26871; number_of_response:1; }","duration":"141.388003ms","start":"2026-06-23T06:43:39.494112Z","end":"2026-06-23T06:43:39.6355Z","steps":["trace[729698791] 'process raft request' (duration: 140.944994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:40.991643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.195741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:40.991732Z","caller":"traceutil/trace.go:171","msg":"trace[1739749803] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:26873; }","duration":"167.379714ms","start":"2026-06-23T06:43:40.824327Z","end":"2026-06-23T06:43:40.991707Z","steps":["trace[1739749803] 'count revisions from in-memory index tree' (duration: 167.078508ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:40.991894Z","caller":"traceutil/trace.go:171","msg":"trace[490578258] transaction","detail":"{read_only:false; response_revision:26874; number_of_response:1; }","duration":"103.13642ms","start":"2026-06-23T06:43:40.888724Z","end":"2026-06-23T06:43:40.99186Z","steps":["trace[490578258] 'process raft request' (duration: 84.570419ms)","trace[490578258] 'compare' (duration: 18.414308ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:41.290845Z","caller":"traceutil/trace.go:171","msg":"trace[2094070506] transaction","detail":"{read_only:false; response_revision:26875; number_of_response:1; }","duration":"241.654878ms","start":"2026-06-23T06:43:41.049157Z","end":"2026-06-23T06:43:41.290812Z","steps":["trace[2094070506] 'process raft request' (duration: 154.50299ms)","trace[2094070506] 'compare' (duration: 86.827911ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:41.319606Z","caller":"traceutil/trace.go:171","msg":"trace[317828565] transaction","detail":"{read_only:false; response_revision:26876; number_of_response:1; }","duration":"258.866304ms","start":"2026-06-23T06:43:41.060677Z","end":"2026-06-23T06:43:41.319543Z","steps":["trace[317828565] 'process raft request' (duration: 258.464636ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:41.319339Z","caller":"traceutil/trace.go:171","msg":"trace[713018322] linearizableReadLoop","detail":"{readStateIndex:27765; appliedIndex:27763; }","duration":"229.362305ms","start":"2026-06-23T06:43:41.089949Z","end":"2026-06-23T06:43:41.319311Z","steps":["trace[713018322] 'read index received' (duration: 113.734419ms)","trace[713018322] 'applied index is now lower than readState.Index' (duration: 115.626216ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:41.319943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.931436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:41.320353Z","caller":"traceutil/trace.go:171","msg":"trace[642774520] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:26876; }","duration":"230.396305ms","start":"2026-06-23T06:43:41.089904Z","end":"2026-06-23T06:43:41.3203Z","steps":["trace[642774520] 'agreement among raft nodes before linearized reading' (duration: 229.846955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:41.320411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.450539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:41.320492Z","caller":"traceutil/trace.go:171","msg":"trace[1456360246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26876; }","duration":"210.06598ms","start":"2026-06-23T06:43:41.110408Z","end":"2026-06-23T06:43:41.320474Z","steps":["trace[1456360246] 'agreement among raft nodes before linearized reading' (duration: 209.483569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:41.320875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.737151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:43:41.320937Z","caller":"traceutil/trace.go:171","msg":"trace[2135583433] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:26876; }","duration":"175.856613ms","start":"2026-06-23T06:43:41.145066Z","end":"2026-06-23T06:43:41.320923Z","steps":["trace[2135583433] 'agreement among raft nodes before linearized reading' (duration: 174.943986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:41.632353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.988164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-23T06:43:41.632465Z","caller":"traceutil/trace.go:171","msg":"trace[1854895188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26876; }","duration":"187.163087ms","start":"2026-06-23T06:43:41.445272Z","end":"2026-06-23T06:43:41.632435Z","steps":["trace[1854895188] 'range keys from in-memory index tree' (duration: 186.761379ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:41.711051Z","caller":"traceutil/trace.go:171","msg":"trace[1676413002] transaction","detail":"{read_only:false; response_revision:26877; number_of_response:1; }","duration":"263.147174ms","start":"2026-06-23T06:43:41.447872Z","end":"2026-06-23T06:43:41.711019Z","steps":["trace[1676413002] 'process raft request' (duration: 262.885948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.055509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.149357ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:42.055743Z","caller":"traceutil/trace.go:171","msg":"trace[1426833636] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26877; }","duration":"306.403272ms","start":"2026-06-23T06:43:41.749312Z","end":"2026-06-23T06:43:42.055715Z","steps":["trace[1426833636] 'range keys from in-memory index tree' (duration: 306.122255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.056642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.020634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:43:42.056868Z","caller":"traceutil/trace.go:171","msg":"trace[520350667] transaction","detail":"{read_only:false; response_revision:26878; number_of_response:1; }","duration":"560.208018ms","start":"2026-06-23T06:43:41.496637Z","end":"2026-06-23T06:43:42.056845Z","steps":["trace[520350667] 'process raft request' (duration: 389.858708ms)","trace[520350667] 'compare' (duration: 169.679558ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:42.056947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.496606Z","time spent":"560.311011ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:42.05778Z","caller":"traceutil/trace.go:171","msg":"trace[189054246] linearizableReadLoop","detail":"{readStateIndex:27770; appliedIndex:27765; }","duration":"534.095264ms","start":"2026-06-23T06:43:41.523671Z","end":"2026-06-23T06:43:42.057766Z","steps":["trace[189054246] 'read index received' (duration: 187.123466ms)","trace[189054246] 'applied index is now lower than readState.Index' (duration: 346.970158ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:42.057984Z","caller":"traceutil/trace.go:171","msg":"trace[1994007285] transaction","detail":"{read_only:false; response_revision:26881; number_of_response:1; }","duration":"557.144881ms","start":"2026-06-23T06:43:41.500798Z","end":"2026-06-23T06:43:42.057943Z","steps":["trace[1994007285] 'process raft request' (duration: 556.885006ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:42.05806Z","caller":"traceutil/trace.go:171","msg":"trace[537403169] transaction","detail":"{read_only:false; response_revision:26882; number_of_response:1; }","duration":"419.933927ms","start":"2026-06-23T06:43:41.638114Z","end":"2026-06-23T06:43:42.058048Z","steps":["trace[537403169] 'process raft request' (duration: 419.607851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.05814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.638083Z","time spent":"420.014349ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:43:42.058193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.500782Z","time spent":"557.285413ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:43:42.058194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.514222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-23T06:43:42.058262Z","caller":"traceutil/trace.go:171","msg":"trace[1406703112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26882; }","duration":"534.621594ms","start":"2026-06-23T06:43:41.523622Z","end":"2026-06-23T06:43:42.058243Z","steps":["trace[1406703112] 'agreement among raft nodes before linearized reading' (duration: 534.431811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.058318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.523605Z","time spent":"534.700676ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-23T06:43:42.058356Z","caller":"traceutil/trace.go:171","msg":"trace[2104699765] transaction","detail":"{read_only:false; response_revision:26879; number_of_response:1; }","duration":"561.526394ms","start":"2026-06-23T06:43:41.496817Z","end":"2026-06-23T06:43:42.058344Z","steps":["trace[2104699765] 'process raft request' (duration: 559.951954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.058414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.496773Z","time spent":"561.607706ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:42.058502Z","caller":"traceutil/trace.go:171","msg":"trace[129019551] transaction","detail":"{read_only:false; response_revision:26880; number_of_response:1; }","duration":"561.519764ms","start":"2026-06-23T06:43:41.496968Z","end":"2026-06-23T06:43:42.058488Z","steps":["trace[129019551] 'process raft request' (duration: 560.654167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.05861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.496936Z","time spent":"561.602846ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:42.078134Z","caller":"traceutil/trace.go:171","msg":"trace[863853447] transaction","detail":"{read_only:false; response_revision:26883; number_of_response:1; }","duration":"168.831002ms","start":"2026-06-23T06:43:41.909273Z","end":"2026-06-23T06:43:42.078104Z","steps":["trace[863853447] 'process raft request' (duration: 168.609736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.078272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.776974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-23T06:43:42.078303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.332216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-23T06:43:42.078356Z","caller":"traceutil/trace.go:171","msg":"trace[634663687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26883; }","duration":"438.897696ms","start":"2026-06-23T06:43:41.639439Z","end":"2026-06-23T06:43:42.078337Z","steps":["trace[634663687] 'agreement among raft nodes before linearized reading' (duration: 438.631311ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:42.078398Z","caller":"traceutil/trace.go:171","msg":"trace[506857130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26883; }","duration":"438.457508ms","start":"2026-06-23T06:43:41.639918Z","end":"2026-06-23T06:43:42.078376Z","steps":["trace[506857130] 'agreement among raft nodes before linearized reading' (duration: 438.206193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.078422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.639427Z","time spent":"438.982557ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T06:43:42.078449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.63989Z","time spent":"438.54959ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T06:43:42.078419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.768834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-23T06:43:42.078517Z","caller":"traceutil/trace.go:171","msg":"trace[156969361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26883; }","duration":"438.884426ms","start":"2026-06-23T06:43:41.639613Z","end":"2026-06-23T06:43:42.078497Z","steps":["trace[156969361] 'agreement among raft nodes before linearized reading' (duration: 438.597941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.07857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:41.639572Z","time spent":"438.989318ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-23T06:43:42.545725Z","caller":"traceutil/trace.go:171","msg":"trace[1295815087] linearizableReadLoop","detail":"{readStateIndex:27777; appliedIndex:27776; }","duration":"113.186679ms","start":"2026-06-23T06:43:42.432509Z","end":"2026-06-23T06:43:42.545696Z","steps":["trace[1295815087] 'read index received' (duration: 112.937075ms)","trace[1295815087] 'applied index is now lower than readState.Index' (duration: 248.324µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:42.546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.460035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-api-6d9fd966cf-v6z8w.18bba146aa3b27f7\" ","response":"range_response_count:1 size:1180"} {"level":"info","ts":"2026-06-23T06:43:42.546038Z","caller":"traceutil/trace.go:171","msg":"trace[1783248256] range","detail":"{range_begin:/registry/events/openstack/cinder-api-6d9fd966cf-v6z8w.18bba146aa3b27f7; range_end:; response_count:1; response_revision:26888; }","duration":"113.570417ms","start":"2026-06-23T06:43:42.432456Z","end":"2026-06-23T06:43:42.546026Z","steps":["trace[1783248256] 'agreement among raft nodes before linearized reading' (duration: 113.342233ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:42.546422Z","caller":"traceutil/trace.go:171","msg":"trace[1871486067] transaction","detail":"{read_only:false; response_revision:26888; number_of_response:1; }","duration":"154.934629ms","start":"2026-06-23T06:43:42.391477Z","end":"2026-06-23T06:43:42.546411Z","steps":["trace[1871486067] 'process raft request' (duration: 154.005621ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:42.596711Z","caller":"traceutil/trace.go:171","msg":"trace[916085976] transaction","detail":"{read_only:false; response_revision:26889; number_of_response:1; }","duration":"152.185327ms","start":"2026-06-23T06:43:42.444488Z","end":"2026-06-23T06:43:42.596673Z","steps":["trace[916085976] 'process raft request' (duration: 151.967433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:42.849519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.648857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:42.849652Z","caller":"traceutil/trace.go:171","msg":"trace[100740747] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:26890; }","duration":"150.80823ms","start":"2026-06-23T06:43:42.69882Z","end":"2026-06-23T06:43:42.849628Z","steps":["trace[100740747] 'count revisions from in-memory index tree' (duration: 150.360742ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:42.913762Z","caller":"traceutil/trace.go:171","msg":"trace[129857818] transaction","detail":"{read_only:false; response_revision:26891; number_of_response:1; }","duration":"140.048817ms","start":"2026-06-23T06:43:42.773682Z","end":"2026-06-23T06:43:42.913731Z","steps":["trace[129857818] 'process raft request' (duration: 139.762491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:43.406105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.236385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:43:43.40615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.783021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:43.406178Z","caller":"traceutil/trace.go:171","msg":"trace[1030148683] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:26892; }","duration":"218.362047ms","start":"2026-06-23T06:43:43.1878Z","end":"2026-06-23T06:43:43.406162Z","steps":["trace[1030148683] 'count revisions from in-memory index tree' (duration: 218.081012ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:43.406198Z","caller":"traceutil/trace.go:171","msg":"trace[1951876336] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26892; }","duration":"203.850693ms","start":"2026-06-23T06:43:43.202337Z","end":"2026-06-23T06:43:43.406188Z","steps":["trace[1951876336] 'range keys from in-memory index tree' (duration: 203.744181ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:43.596814Z","caller":"traceutil/trace.go:171","msg":"trace[97010117] transaction","detail":"{read_only:false; response_revision:26893; number_of_response:1; }","duration":"299.856707ms","start":"2026-06-23T06:43:43.296904Z","end":"2026-06-23T06:43:43.596761Z","steps":["trace[97010117] 'process raft request' (duration: 299.370598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:43.596985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:43.29687Z","time spent":"300.02935ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:43.848809Z","caller":"traceutil/trace.go:171","msg":"trace[1895626945] transaction","detail":"{read_only:false; response_revision:26894; number_of_response:1; }","duration":"520.842913ms","start":"2026-06-23T06:43:43.327923Z","end":"2026-06-23T06:43:43.848765Z","steps":["trace[1895626945] 'process raft request' (duration: 432.062035ms)","trace[1895626945] 'compare' (duration: 88.398341ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:43.849053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:43.327877Z","time spent":"521.056288ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:43:43.849272Z","caller":"traceutil/trace.go:171","msg":"trace[1516798915] linearizableReadLoop","detail":"{readStateIndex:27784; appliedIndex:27782; }","duration":"438.297804ms","start":"2026-06-23T06:43:43.410943Z","end":"2026-06-23T06:43:43.849241Z","steps":["trace[1516798915] 'read index received' (duration: 185.373915ms)","trace[1516798915] 'applied index is now lower than readState.Index' (duration: 252.920139ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:43.849529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.877524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:43.849518Z","caller":"traceutil/trace.go:171","msg":"trace[466544744] transaction","detail":"{read_only:false; response_revision:26895; number_of_response:1; }","duration":"128.55036ms","start":"2026-06-23T06:43:43.72094Z","end":"2026-06-23T06:43:43.84949Z","steps":["trace[466544744] 'process raft request' (duration: 128.140532ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:43.849592Z","caller":"traceutil/trace.go:171","msg":"trace[610985955] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26895; }","duration":"311.991936ms","start":"2026-06-23T06:43:43.537568Z","end":"2026-06-23T06:43:43.84956Z","steps":["trace[610985955] 'agreement among raft nodes before linearized reading' (duration: 311.873404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:43.849561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.568399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:43.849693Z","caller":"traceutil/trace.go:171","msg":"trace[2146441585] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26895; }","duration":"438.750192ms","start":"2026-06-23T06:43:43.410913Z","end":"2026-06-23T06:43:43.849664Z","steps":["trace[2146441585] 'agreement among raft nodes before linearized reading' (duration: 438.449717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:43.849624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:43.537555Z","time spent":"312.061867ms","remote":"127.0.0.1:34980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:43:43.849763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:43.410902Z","time spent":"438.852085ms","remote":"127.0.0.1:45458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-23T06:43:44.13651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.363377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:44.136603Z","caller":"traceutil/trace.go:171","msg":"trace[972065779] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:26895; }","duration":"118.53333ms","start":"2026-06-23T06:43:44.018052Z","end":"2026-06-23T06:43:44.136586Z","steps":["trace[972065779] 'count revisions from in-memory index tree' (duration: 118.175124ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.288944Z","caller":"traceutil/trace.go:171","msg":"trace[658659465] transaction","detail":"{read_only:false; response_revision:26897; number_of_response:1; }","duration":"222.469145ms","start":"2026-06-23T06:43:44.066445Z","end":"2026-06-23T06:43:44.288914Z","steps":["trace[658659465] 'process raft request' (duration: 222.195659ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.289249Z","caller":"traceutil/trace.go:171","msg":"trace[2120009673] transaction","detail":"{read_only:false; response_revision:26898; number_of_response:1; }","duration":"222.75651ms","start":"2026-06-23T06:43:44.066461Z","end":"2026-06-23T06:43:44.289217Z","steps":["trace[2120009673] 'process raft request' (duration: 222.405004ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.289377Z","caller":"traceutil/trace.go:171","msg":"trace[281217894] linearizableReadLoop","detail":"{readStateIndex:27789; appliedIndex:27785; }","duration":"178.234359ms","start":"2026-06-23T06:43:44.111118Z","end":"2026-06-23T06:43:44.289352Z","steps":["trace[281217894] 'read index received' (duration: 32.347712ms)","trace[281217894] 'applied index is now lower than readState.Index' (duration: 145.885327ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:44.289436Z","caller":"traceutil/trace.go:171","msg":"trace[1843153401] transaction","detail":"{read_only:false; response_revision:26900; number_of_response:1; }","duration":"147.395176ms","start":"2026-06-23T06:43:44.142029Z","end":"2026-06-23T06:43:44.289424Z","steps":["trace[1843153401] 'process raft request' (duration: 147.275694ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.289427Z","caller":"traceutil/trace.go:171","msg":"trace[579733858] transaction","detail":"{read_only:false; response_revision:26899; number_of_response:1; }","duration":"222.906093ms","start":"2026-06-23T06:43:44.066479Z","end":"2026-06-23T06:43:44.289385Z","steps":["trace[579733858] 'process raft request' (duration: 222.656469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:44.289628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.484233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:43:44.289691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.477708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T06:43:44.289712Z","caller":"traceutil/trace.go:171","msg":"trace[1026495393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26900; }","duration":"178.632166ms","start":"2026-06-23T06:43:44.111061Z","end":"2026-06-23T06:43:44.289693Z","steps":["trace[1026495393] 'agreement among raft nodes before linearized reading' (duration: 178.390591ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.289731Z","caller":"traceutil/trace.go:171","msg":"trace[1106090720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26900; }","duration":"137.58443ms","start":"2026-06-23T06:43:44.152135Z","end":"2026-06-23T06:43:44.289719Z","steps":["trace[1106090720] 'agreement among raft nodes before linearized reading' (duration: 137.378247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:44.289686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.626423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-23T06:43:44.289884Z","caller":"traceutil/trace.go:171","msg":"trace[1350891107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26900; }","duration":"117.859907ms","start":"2026-06-23T06:43:44.172015Z","end":"2026-06-23T06:43:44.289875Z","steps":["trace[1350891107] 'agreement among raft nodes before linearized reading' (duration: 117.500251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:44.290002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.683552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-23T06:43:44.290044Z","caller":"traceutil/trace.go:171","msg":"trace[51462313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26900; }","duration":"119.778404ms","start":"2026-06-23T06:43:44.170252Z","end":"2026-06-23T06:43:44.290031Z","steps":["trace[51462313] 'agreement among raft nodes before linearized reading' (duration: 119.585321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:44.290141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.937637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-23T06:43:44.290207Z","caller":"traceutil/trace.go:171","msg":"trace[65843046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26900; }","duration":"119.12348ms","start":"2026-06-23T06:43:44.171067Z","end":"2026-06-23T06:43:44.290191Z","steps":["trace[65843046] 'agreement among raft nodes before linearized reading' (duration: 118.835435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:44.559071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.363359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:43:44.559173Z","caller":"traceutil/trace.go:171","msg":"trace[1160765832] transaction","detail":"{read_only:false; response_revision:26901; number_of_response:1; }","duration":"264.739332ms","start":"2026-06-23T06:43:44.294415Z","end":"2026-06-23T06:43:44.559154Z","steps":["trace[1160765832] 'process raft request' (duration: 103.22271ms)","trace[1160765832] 'compare' (duration: 161.203406ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:44.579113Z","caller":"traceutil/trace.go:171","msg":"trace[375720406] transaction","detail":"{read_only:false; response_revision:26902; number_of_response:1; }","duration":"283.799413ms","start":"2026-06-23T06:43:44.295275Z","end":"2026-06-23T06:43:44.579075Z","steps":["trace[375720406] 'process raft request' (duration: 283.507858ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.579404Z","caller":"traceutil/trace.go:171","msg":"trace[1638110692] transaction","detail":"{read_only:false; response_revision:26903; number_of_response:1; }","duration":"282.912067ms","start":"2026-06-23T06:43:44.296443Z","end":"2026-06-23T06:43:44.579355Z","steps":["trace[1638110692] 'process raft request' (duration: 282.5796ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.579739Z","caller":"traceutil/trace.go:171","msg":"trace[1184144956] transaction","detail":"{read_only:false; response_revision:26904; number_of_response:1; }","duration":"280.132624ms","start":"2026-06-23T06:43:44.299592Z","end":"2026-06-23T06:43:44.579725Z","steps":["trace[1184144956] 'process raft request' (duration: 279.714416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:44.832899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.668011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:43:44.832996Z","caller":"traceutil/trace.go:171","msg":"trace[1252707929] linearizableReadLoop","detail":"{readStateIndex:27795; appliedIndex:27794; }","duration":"205.435492ms","start":"2026-06-23T06:43:44.627547Z","end":"2026-06-23T06:43:44.832982Z","steps":["trace[1252707929] 'read index received' (duration: 67.555407ms)","trace[1252707929] 'applied index is now lower than readState.Index' (duration: 137.879175ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:44.833129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.594625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-06-23T06:43:44.83315Z","caller":"traceutil/trace.go:171","msg":"trace[72363787] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:26905; }","duration":"205.657876ms","start":"2026-06-23T06:43:44.627484Z","end":"2026-06-23T06:43:44.833142Z","steps":["trace[72363787] 'agreement among raft nodes before linearized reading' (duration: 205.533804ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:44.83327Z","caller":"traceutil/trace.go:171","msg":"trace[801740639] transaction","detail":"{read_only:false; response_revision:26905; number_of_response:1; }","duration":"213.507085ms","start":"2026-06-23T06:43:44.619525Z","end":"2026-06-23T06:43:44.833032Z","steps":["trace[801740639] 'process raft request' (duration: 75.63004ms)","trace[801740639] 'compare' (duration: 137.521819ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:45.128013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.208285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:43:45.128174Z","caller":"traceutil/trace.go:171","msg":"trace[1726400821] transaction","detail":"{read_only:false; response_revision:26906; number_of_response:1; }","duration":"206.274268ms","start":"2026-06-23T06:43:44.921857Z","end":"2026-06-23T06:43:45.128131Z","steps":["trace[1726400821] 'process raft request' (duration: 19.134232ms)","trace[1726400821] 'compare' (duration: 179.754527ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:45.724645Z","caller":"traceutil/trace.go:171","msg":"trace[2143106708] transaction","detail":"{read_only:false; response_revision:26907; number_of_response:1; }","duration":"121.825521ms","start":"2026-06-23T06:43:45.602788Z","end":"2026-06-23T06:43:45.724614Z","steps":["trace[2143106708] 'process raft request' (duration: 121.633248ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.215715Z","caller":"traceutil/trace.go:171","msg":"trace[60612171] linearizableReadLoop","detail":"{readStateIndex:27799; appliedIndex:27798; }","duration":"157.896054ms","start":"2026-06-23T06:43:46.057794Z","end":"2026-06-23T06:43:46.21569Z","steps":["trace[60612171] 'read index received' (duration: 157.836193ms)","trace[60612171] 'applied index is now lower than readState.Index' (duration: 58.691µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:46.215934Z","caller":"traceutil/trace.go:171","msg":"trace[1724244874] transaction","detail":"{read_only:false; response_revision:26909; number_of_response:1; }","duration":"358.190688ms","start":"2026-06-23T06:43:45.857692Z","end":"2026-06-23T06:43:46.215882Z","steps":["trace[1724244874] 'process raft request' (duration: 357.852002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:46.216121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:43:45.857659Z","time spent":"358.375632ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:43:46.216345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.487556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T06:43:46.216482Z","caller":"traceutil/trace.go:171","msg":"trace[1853565621] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:26909; }","duration":"158.700879ms","start":"2026-06-23T06:43:46.057744Z","end":"2026-06-23T06:43:46.216445Z","steps":["trace[1853565621] 'agreement among raft nodes before linearized reading' (duration: 158.186879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:46.236833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.280656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:43:46.236919Z","caller":"traceutil/trace.go:171","msg":"trace[962340319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26910; }","duration":"126.425469ms","start":"2026-06-23T06:43:46.110472Z","end":"2026-06-23T06:43:46.236897Z","steps":["trace[962340319] 'agreement among raft nodes before linearized reading' (duration: 126.271896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:43:46.236944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.998745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-23T06:43:46.237065Z","caller":"traceutil/trace.go:171","msg":"trace[2037230412] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26910; }","duration":"140.186709ms","start":"2026-06-23T06:43:46.096852Z","end":"2026-06-23T06:43:46.237039Z","steps":["trace[2037230412] 'agreement among raft nodes before linearized reading' (duration: 139.840282ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.456119Z","caller":"traceutil/trace.go:171","msg":"trace[481487820] transaction","detail":"{read_only:false; response_revision:26911; number_of_response:1; }","duration":"159.666647ms","start":"2026-06-23T06:43:46.296418Z","end":"2026-06-23T06:43:46.456085Z","steps":["trace[481487820] 'process raft request' (duration: 105.768658ms)","trace[481487820] 'compare' (duration: 53.753206ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:46.504774Z","caller":"traceutil/trace.go:171","msg":"trace[663756193] linearizableReadLoop","detail":"{readStateIndex:27803; appliedIndex:27800; }","duration":"205.751479ms","start":"2026-06-23T06:43:46.298998Z","end":"2026-06-23T06:43:46.50475Z","steps":["trace[663756193] 'read index received' (duration: 103.290922ms)","trace[663756193] 'applied index is now lower than readState.Index' (duration: 102.459207ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:46.504987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.936352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-23T06:43:46.505019Z","caller":"traceutil/trace.go:171","msg":"trace[715764094] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26913; }","duration":"206.136216ms","start":"2026-06-23T06:43:46.29887Z","end":"2026-06-23T06:43:46.505006Z","steps":["trace[715764094] 'agreement among raft nodes before linearized reading' (duration: 205.976393ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.505206Z","caller":"traceutil/trace.go:171","msg":"trace[785926353] transaction","detail":"{read_only:false; response_revision:26913; number_of_response:1; }","duration":"208.384097ms","start":"2026-06-23T06:43:46.296813Z","end":"2026-06-23T06:43:46.505197Z","steps":["trace[785926353] 'process raft request' (duration: 207.892138ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.50714Z","caller":"traceutil/trace.go:171","msg":"trace[385525307] transaction","detail":"{read_only:false; response_revision:26912; number_of_response:1; }","duration":"210.587541ms","start":"2026-06-23T06:43:46.296517Z","end":"2026-06-23T06:43:46.507105Z","steps":["trace[385525307] 'process raft request' (duration: 208.031692ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.679738Z","caller":"traceutil/trace.go:171","msg":"trace[2181029] linearizableReadLoop","detail":"{readStateIndex:27804; appliedIndex:27803; }","duration":"115.639094ms","start":"2026-06-23T06:43:46.564068Z","end":"2026-06-23T06:43:46.679707Z","steps":["trace[2181029] 'read index received' (duration: 50.353621ms)","trace[2181029] 'applied index is now lower than readState.Index' (duration: 65.283903ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:46.679886Z","caller":"traceutil/trace.go:171","msg":"trace[1333505690] transaction","detail":"{read_only:false; response_revision:26914; number_of_response:1; }","duration":"168.746029ms","start":"2026-06-23T06:43:46.511128Z","end":"2026-06-23T06:43:46.679874Z","steps":["trace[1333505690] 'process raft request' (duration: 103.321693ms)","trace[1333505690] 'compare' (duration: 64.767363ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:43:46.680733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.654335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-23T06:43:46.680771Z","caller":"traceutil/trace.go:171","msg":"trace[368564564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26914; }","duration":"116.755577ms","start":"2026-06-23T06:43:46.564006Z","end":"2026-06-23T06:43:46.680762Z","steps":["trace[368564564] 'agreement among raft nodes before linearized reading' (duration: 116.558993ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.83298Z","caller":"traceutil/trace.go:171","msg":"trace[1464401294] transaction","detail":"{read_only:false; response_revision:26916; number_of_response:1; }","duration":"145.942327ms","start":"2026-06-23T06:43:46.687002Z","end":"2026-06-23T06:43:46.832944Z","steps":["trace[1464401294] 'process raft request' (duration: 101.739292ms)","trace[1464401294] 'compare' (duration: 43.90665ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:43:46.833299Z","caller":"traceutil/trace.go:171","msg":"trace[2089084036] transaction","detail":"{read_only:false; response_revision:26917; number_of_response:1; }","duration":"146.237213ms","start":"2026-06-23T06:43:46.687028Z","end":"2026-06-23T06:43:46.833265Z","steps":["trace[2089084036] 'process raft request' (duration: 145.848506ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:46.833323Z","caller":"traceutil/trace.go:171","msg":"trace[231294945] transaction","detail":"{read_only:false; response_revision:26918; number_of_response:1; }","duration":"145.123123ms","start":"2026-06-23T06:43:46.688169Z","end":"2026-06-23T06:43:46.833292Z","steps":["trace[231294945] 'process raft request' (duration: 144.97501ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:43:47.236009Z","caller":"traceutil/trace.go:171","msg":"trace[2055624777] transaction","detail":"{read_only:false; response_revision:26920; number_of_response:1; }","duration":"101.864465ms","start":"2026-06-23T06:43:47.134115Z","end":"2026-06-23T06:43:47.23598Z","steps":["trace[2055624777] 'process raft request' (duration: 101.567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:04.627697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.680351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:44:04.628367Z","caller":"traceutil/trace.go:171","msg":"trace[1945597020] transaction","detail":"{read_only:false; response_revision:27052; number_of_response:1; }","duration":"615.856387ms","start":"2026-06-23T06:44:04.012416Z","end":"2026-06-23T06:44:04.628272Z","steps":["trace[1945597020] 'process raft request' (duration: 283.511543ms)","trace[1945597020] 'compare' (duration: 331.443157ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:04.628623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.56394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:44:04.628679Z","caller":"traceutil/trace.go:171","msg":"trace[1351220033] transaction","detail":"{read_only:false; response_revision:27053; number_of_response:1; }","duration":"322.241744ms","start":"2026-06-23T06:44:04.306415Z","end":"2026-06-23T06:44:04.628657Z","steps":["trace[1351220033] 'process raft request' (duration: 322.075121ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:04.628707Z","caller":"traceutil/trace.go:171","msg":"trace[241093250] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27052; }","duration":"518.726663ms","start":"2026-06-23T06:44:04.109959Z","end":"2026-06-23T06:44:04.628686Z","steps":["trace[241093250] 'agreement among raft nodes before linearized reading' (duration: 518.53178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:04.628713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.012387Z","time spent":"616.180763ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:04.628445Z","caller":"traceutil/trace.go:171","msg":"trace[1112038201] linearizableReadLoop","detail":"{readStateIndex:27946; appliedIndex:27945; }","duration":"518.394237ms","start":"2026-06-23T06:44:04.110003Z","end":"2026-06-23T06:44:04.628398Z","steps":["trace[1112038201] 'read index received' (duration: 185.822079ms)","trace[1112038201] 'applied index is now lower than readState.Index' (duration: 332.567808ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:04.628781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.109939Z","time spent":"518.828915ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T06:44:04.628774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.306388Z","time spent":"322.343695ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.040041Z","caller":"traceutil/trace.go:171","msg":"trace[122509146] transaction","detail":"{read_only:false; response_revision:27054; number_of_response:1; }","duration":"660.784545ms","start":"2026-06-23T06:44:04.379197Z","end":"2026-06-23T06:44:05.039982Z","steps":["trace[122509146] 'process raft request' (duration: 570.308147ms)","trace[122509146] 'compare' (duration: 90.227734ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:05.040243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.379172Z","time spent":"660.971198ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.040499Z","caller":"traceutil/trace.go:171","msg":"trace[1790532218] transaction","detail":"{read_only:false; response_revision:27055; number_of_response:1; }","duration":"486.247789ms","start":"2026-06-23T06:44:04.554212Z","end":"2026-06-23T06:44:05.040459Z","steps":["trace[1790532218] 'process raft request' (duration: 485.717879ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:05.040538Z","caller":"traceutil/trace.go:171","msg":"trace[1522587858] linearizableReadLoop","detail":"{readStateIndex:27951; appliedIndex:27947; }","duration":"411.708773ms","start":"2026-06-23T06:44:04.62879Z","end":"2026-06-23T06:44:05.040499Z","steps":["trace[1522587858] 'read index received' (duration: 320.615434ms)","trace[1522587858] 'applied index is now lower than readState.Index' (duration: 91.091529ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:05.04071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.554185Z","time spent":"486.423483ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.040894Z","caller":"traceutil/trace.go:171","msg":"trace[352408886] transaction","detail":"{read_only:false; response_revision:27056; number_of_response:1; }","duration":"468.098818ms","start":"2026-06-23T06:44:04.572775Z","end":"2026-06-23T06:44:05.040874Z","steps":["trace[352408886] 'process raft request' (duration: 467.482635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.041018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.461747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:44:05.041055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.177774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:44:05.041072Z","caller":"traceutil/trace.go:171","msg":"trace[279572706] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:27057; }","duration":"760.576449ms","start":"2026-06-23T06:44:04.280482Z","end":"2026-06-23T06:44:05.041058Z","steps":["trace[279572706] 'agreement among raft nodes before linearized reading' (duration: 760.479797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.041075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.572733Z","time spent":"468.22984ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.041105Z","caller":"traceutil/trace.go:171","msg":"trace[923455865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27057; }","duration":"410.271596ms","start":"2026-06-23T06:44:04.630821Z","end":"2026-06-23T06:44:05.041093Z","steps":["trace[923455865] 'agreement among raft nodes before linearized reading' (duration: 410.179564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.041128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.280448Z","time spent":"760.662531ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:44:05.041145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.630796Z","time spent":"410.341158ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T06:44:05.041315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.113576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-23T06:44:05.041382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.877346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:44:05.041417Z","caller":"traceutil/trace.go:171","msg":"trace[1428458808] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:27057; }","duration":"224.914477ms","start":"2026-06-23T06:44:04.816493Z","end":"2026-06-23T06:44:05.041407Z","steps":["trace[1428458808] 'agreement among raft nodes before linearized reading' (duration: 224.802345ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:05.041422Z","caller":"traceutil/trace.go:171","msg":"trace[471908985] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27057; }","duration":"184.251949ms","start":"2026-06-23T06:44:04.857128Z","end":"2026-06-23T06:44:05.04138Z","steps":["trace[471908985] 'agreement among raft nodes before linearized reading' (duration: 183.992584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.041427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.096939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-23T06:44:05.0415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.322595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T06:44:05.041525Z","caller":"traceutil/trace.go:171","msg":"trace[606421873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27057; }","duration":"181.238681ms","start":"2026-06-23T06:44:04.860265Z","end":"2026-06-23T06:44:05.041504Z","steps":["trace[606421873] 'agreement among raft nodes before linearized reading' (duration: 180.907185ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:05.04155Z","caller":"traceutil/trace.go:171","msg":"trace[1278738311] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:27057; }","duration":"715.412977ms","start":"2026-06-23T06:44:04.326126Z","end":"2026-06-23T06:44:05.041539Z","steps":["trace[1278738311] 'agreement among raft nodes before linearized reading' (duration: 715.200273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.04162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.350175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-23T06:44:05.041677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.326101Z","time spent":"715.567099ms","remote":"127.0.0.1:45622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":99,"response size":32,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:44:05.041695Z","caller":"traceutil/trace.go:171","msg":"trace[622671740] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27057; }","duration":"805.541569ms","start":"2026-06-23T06:44:04.236136Z","end":"2026-06-23T06:44:05.041677Z","steps":["trace[622671740] 'agreement among raft nodes before linearized reading' (duration: 805.338425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.041771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.236104Z","time spent":"805.63242ms","remote":"127.0.0.1:45446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-23T06:44:05.041919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.387189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:44:05.042033Z","caller":"traceutil/trace.go:171","msg":"trace[1214550746] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:27057; }","duration":"596.582053ms","start":"2026-06-23T06:44:04.445422Z","end":"2026-06-23T06:44:05.042004Z","steps":["trace[1214550746] 'agreement among raft nodes before linearized reading' (duration: 595.724167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.042101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.445386Z","time spent":"596.702325ms","remote":"127.0.0.1:45308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:44:05.041236Z","caller":"traceutil/trace.go:171","msg":"trace[184293402] transaction","detail":"{read_only:false; response_revision:27057; number_of_response:1; }","duration":"466.490537ms","start":"2026-06-23T06:44:04.574693Z","end":"2026-06-23T06:44:05.041183Z","steps":["trace[184293402] 'process raft request' (duration: 465.724802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.042684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:04.57468Z","time spent":"467.855113ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:44:05.504852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.250947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:44:05.505082Z","caller":"traceutil/trace.go:171","msg":"trace[29356860] transaction","detail":"{read_only:false; response_revision:27058; number_of_response:1; }","duration":"459.124588ms","start":"2026-06-23T06:44:05.045911Z","end":"2026-06-23T06:44:05.505035Z","steps":["trace[29356860] 'process raft request' (duration: 237.537754ms)","trace[29356860] 'compare' (duration: 220.715917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:05.505298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.045883Z","time spent":"459.30126ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.799801Z","caller":"traceutil/trace.go:171","msg":"trace[739381409] transaction","detail":"{read_only:false; response_revision:27059; number_of_response:1; }","duration":"752.804141ms","start":"2026-06-23T06:44:05.046951Z","end":"2026-06-23T06:44:05.799755Z","steps":["trace[739381409] 'process raft request' (duration: 734.909984ms)","trace[739381409] 'compare' (duration: 17.613342ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:05.800004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.046928Z","time spent":"752.981915ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.800104Z","caller":"traceutil/trace.go:171","msg":"trace[210622464] linearizableReadLoop","detail":"{readStateIndex:27956; appliedIndex:27951; }","duration":"750.765623ms","start":"2026-06-23T06:44:05.049314Z","end":"2026-06-23T06:44:05.80008Z","steps":["trace[210622464] 'read index received' (duration: 234.216421ms)","trace[210622464] 'applied index is now lower than readState.Index' (duration: 516.548152ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:44:05.800146Z","caller":"traceutil/trace.go:171","msg":"trace[628660769] transaction","detail":"{read_only:false; response_revision:27062; number_of_response:1; }","duration":"750.979607ms","start":"2026-06-23T06:44:05.049137Z","end":"2026-06-23T06:44:05.800116Z","steps":["trace[628660769] 'process raft request' (duration: 750.905216ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:05.800185Z","caller":"traceutil/trace.go:171","msg":"trace[1593481339] transaction","detail":"{read_only:false; response_revision:27060; number_of_response:1; }","duration":"752.914124ms","start":"2026-06-23T06:44:05.047226Z","end":"2026-06-23T06:44:05.80014Z","steps":["trace[1593481339] 'process raft request' (duration: 752.718621ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:05.800217Z","caller":"traceutil/trace.go:171","msg":"trace[1329339892] transaction","detail":"{read_only:false; response_revision:27061; number_of_response:1; }","duration":"752.404604ms","start":"2026-06-23T06:44:05.047739Z","end":"2026-06-23T06:44:05.800144Z","steps":["trace[1329339892] 'process raft request' (duration: 752.270692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.800282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.977637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-23T06:44:05.800288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.049125Z","time spent":"751.092639ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T06:44:05.800327Z","caller":"traceutil/trace.go:171","msg":"trace[1198168604] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27062; }","duration":"751.060329ms","start":"2026-06-23T06:44:05.049253Z","end":"2026-06-23T06:44:05.800314Z","steps":["trace[1198168604] 'agreement among raft nodes before linearized reading' (duration: 750.922916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:05.800376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.049241Z","time spent":"751.105679ms","remote":"127.0.0.1:45446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-23T06:44:05.800424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.047214Z","time spent":"753.066137ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:44:05.800502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.047715Z","time spent":"752.613989ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:44:06.088289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.141159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T06:44:06.088686Z","caller":"traceutil/trace.go:171","msg":"trace[679485573] transaction","detail":"{read_only:false; response_revision:27064; number_of_response:1; }","duration":"212.346999ms","start":"2026-06-23T06:44:05.876309Z","end":"2026-06-23T06:44:06.088656Z","steps":["trace[679485573] 'process raft request' (duration: 212.152355ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:06.088718Z","caller":"traceutil/trace.go:171","msg":"trace[1280620890] linearizableReadLoop","detail":"{readStateIndex:27957; appliedIndex:27956; }","duration":"288.511436ms","start":"2026-06-23T06:44:05.80017Z","end":"2026-06-23T06:44:06.088681Z","steps":["trace[1280620890] 'read index received' (duration: 142.673753ms)","trace[1280620890] 'applied index is now lower than readState.Index' (duration: 145.833423ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T06:44:06.088961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.74203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:44:06.089014Z","caller":"traceutil/trace.go:171","msg":"trace[1086250463] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:27064; }","duration":"940.878322ms","start":"2026-06-23T06:44:05.148116Z","end":"2026-06-23T06:44:06.088995Z","steps":["trace[1086250463] 'agreement among raft nodes before linearized reading' (duration: 940.74172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:06.089086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.148042Z","time spent":"941.022214ms","remote":"127.0.0.1:52052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":30,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:44:06.08909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.764437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:44:06.089141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.377504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T06:44:06.089135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.635312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T06:44:06.08918Z","caller":"traceutil/trace.go:171","msg":"trace[1632149585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27064; }","duration":"978.91231ms","start":"2026-06-23T06:44:05.110246Z","end":"2026-06-23T06:44:06.089159Z","steps":["trace[1632149585] 'agreement among raft nodes before linearized reading' (duration: 978.773398ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:44:06.089191Z","caller":"traceutil/trace.go:171","msg":"trace[541750877] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:27064; }","duration":"975.422514ms","start":"2026-06-23T06:44:05.113748Z","end":"2026-06-23T06:44:06.08917Z","steps":["trace[541750877] 'agreement among raft nodes before linearized reading' (duration: 975.344573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:06.089225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.110221Z","time spent":"978.995992ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T06:44:06.089238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.113732Z","time spent":"975.494165ms","remote":"127.0.0.1:34740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true "} {"level":"info","ts":"2026-06-23T06:44:06.089274Z","caller":"traceutil/trace.go:171","msg":"trace[1872919000] transaction","detail":"{read_only:false; response_revision:27063; number_of_response:1; }","duration":"688.704092ms","start":"2026-06-23T06:44:05.400554Z","end":"2026-06-23T06:44:06.089258Z","steps":["trace[1872919000] 'process raft request' (duration: 542.265928ms)","trace[1872919000] 'compare' (duration: 144.372835ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T06:44:06.089218Z","caller":"traceutil/trace.go:171","msg":"trace[2048507912] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:27064; }","duration":"811.727494ms","start":"2026-06-23T06:44:05.277471Z","end":"2026-06-23T06:44:06.089199Z","steps":["trace[2048507912] 'agreement among raft nodes before linearized reading' (duration: 811.346357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:06.089314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.124239ms","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:8"} {"level":"info","ts":"2026-06-23T06:44:06.08937Z","caller":"traceutil/trace.go:171","msg":"trace[656871069] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:27064; }","duration":"298.230781ms","start":"2026-06-23T06:44:05.791124Z","end":"2026-06-23T06:44:06.089355Z","steps":["trace[656871069] 'agreement among raft nodes before linearized reading' (duration: 298.132169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:06.089377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.400516Z","time spent":"688.794113ms","remote":"127.0.0.1:45518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T06:44:06.089474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T06:44:05.277405Z","time spent":"811.989418ms","remote":"127.0.0.1:45446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":177,"response size":33,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-06-23T06:44:06.08953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.768712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18596"} {"level":"info","ts":"2026-06-23T06:44:06.089667Z","caller":"traceutil/trace.go:171","msg":"trace[58900407] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27064; }","duration":"287.969376ms","start":"2026-06-23T06:44:05.801673Z","end":"2026-06-23T06:44:06.089642Z","steps":["trace[58900407] 'agreement among raft nodes before linearized reading' (duration: 287.62988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:06.089757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.917498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T06:44:06.089832Z","caller":"traceutil/trace.go:171","msg":"trace[393745003] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:27064; }","duration":"116.04662ms","start":"2026-06-23T06:44:05.973766Z","end":"2026-06-23T06:44:06.089813Z","steps":["trace[393745003] 'agreement among raft nodes before linearized reading' (duration: 115.922448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T06:44:06.290738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.619346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-23T06:44:06.290852Z","caller":"traceutil/trace.go:171","msg":"trace[288030050] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:27064; }","duration":"103.767399ms","start":"2026-06-23T06:44:06.187044Z","end":"2026-06-23T06:44:06.290811Z","steps":["trace[288030050] 'range keys from in-memory index tree' (duration: 103.409202ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T06:45:09.57829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24971} {"level":"info","ts":"2026-06-23T06:45:10.270507Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24971,"took":"688.318416ms","hash":1464298752,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":36343808,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-23T06:45:10.27059Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1464298752,"revision":24971,"compact-revision":21742} {"level":"info","ts":"2026-06-23T06:47:25.012282Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T06:47:25.018681Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-23T06:47:25.018776Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-23T06:50:09.585719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27729} {"level":"info","ts":"2026-06-23T06:50:09.942846Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27729,"took":"353.305426ms","hash":3584445985,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":35397632,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-23T06:50:09.942919Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3584445985,"revision":27729,"compact-revision":24971} {"level":"info","ts":"2026-06-23T06:55:09.59254Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30414} {"level":"info","ts":"2026-06-23T06:55:09.751789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30414,"took":"154.242716ms","hash":1419995437,"current-db-size-bytes":58101760,"current-db-size":"58 MB","current-db-size-in-use-bytes":30937088,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-23T06:55:09.751868Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1419995437,"revision":30414,"compact-revision":27729} {"level":"info","ts":"2026-06-23T07:00:09.599664Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32665} {"level":"info","ts":"2026-06-23T07:00:09.82106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32665,"took":"215.220715ms","hash":1405749727,"current-db-size-bytes":59146240,"current-db-size":"59 MB","current-db-size-in-use-bytes":30715904,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-23T07:00:09.821161Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1405749727,"revision":32665,"compact-revision":30414} {"level":"info","ts":"2026-06-23T07:05:09.607233Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34940} {"level":"info","ts":"2026-06-23T07:05:09.751973Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34940,"took":"139.028163ms","hash":3290114511,"current-db-size-bytes":59146240,"current-db-size":"59 MB","current-db-size-in-use-bytes":32378880,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-23T07:05:09.752041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3290114511,"revision":34940,"compact-revision":32665} {"level":"info","ts":"2026-06-23T07:08:27.940093Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T07:08:27.944647Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-23T07:08:27.944957Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-23T07:10:09.613364Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37272} {"level":"info","ts":"2026-06-23T07:10:09.896516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37272,"took":"279.161994ms","hash":352056708,"current-db-size-bytes":59146240,"current-db-size":"59 MB","current-db-size-in-use-bytes":33271808,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-23T07:10:09.89662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":352056708,"revision":37272,"compact-revision":34940} {"level":"info","ts":"2026-06-23T07:15:09.621001Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39560} {"level":"info","ts":"2026-06-23T07:15:09.947253Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39560,"took":"319.897617ms","hash":3915693688,"current-db-size-bytes":59604992,"current-db-size":"60 MB","current-db-size-in-use-bytes":32563200,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-23T07:15:09.947355Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3915693688,"revision":39560,"compact-revision":37272} {"level":"info","ts":"2026-06-23T07:20:09.62691Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41791} {"level":"info","ts":"2026-06-23T07:20:09.756244Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41791,"took":"125.171651ms","hash":1168418225,"current-db-size-bytes":59604992,"current-db-size":"60 MB","current-db-size-in-use-bytes":30396416,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T07:20:09.756325Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1168418225,"revision":41791,"compact-revision":39560}