{"level":"warn","ts":"2026-09-07T10:42:24.07231Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T10:42:24.072449Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.55:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.55:2380","--initial-cluster=instance=https://162.253.55.55:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.55:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.55:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-07T10:42:24.072521Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T10:42:24.072535Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.55:2380"]} {"level":"info","ts":"2026-09-07T10:42:24.072557Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-07T10:42:24.0732Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.55:2379"]} {"level":"info","ts":"2026-09-07T10:42:24.073281Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.55:2380"],"listen-peer-urls":["https://162.253.55.55:2380"],"advertise-client-urls":["https://162.253.55.55:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.55:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.55:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-07T10:42:24.078124Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.599198ms"} {"level":"info","ts":"2026-09-07T10:42:24.086531Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"357bf0025115def9","cluster-id":"5f69314e1ae3c800"} {"level":"info","ts":"2026-09-07T10:42:24.086643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T10:42:24.086668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became follower at term 0"} {"level":"info","ts":"2026-09-07T10:42:24.086681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 357bf0025115def9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T10:42:24.086692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became follower at term 1"} {"level":"info","ts":"2026-09-07T10:42:24.086742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 switched to configuration voters=(3853937798886579961)"} {"level":"warn","ts":"2026-09-07T10:42:24.095912Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T10:42:24.098022Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T10:42:24.100736Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-07T10:42:24.102848Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"357bf0025115def9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T10:42:24.103008Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"357bf0025115def9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T10:42:24.103123Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T10:42:24.103257Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T10:42:24.103279Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T10:42:24.106636Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-07T10:42:24.106989Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"357bf0025115def9","initial-advertise-peer-urls":["https://162.253.55.55:2380"],"listen-peer-urls":["https://162.253.55.55:2380"],"advertise-client-urls":["https://162.253.55.55:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.55:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T10:42:24.106759Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.55:2380"} {"level":"info","ts":"2026-09-07T10:42:24.107613Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.55:2380"} {"level":"info","ts":"2026-09-07T10:42:24.10707Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T10:42:24.107513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 switched to configuration voters=(3853937798886579961)"} {"level":"info","ts":"2026-09-07T10:42:24.107838Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f69314e1ae3c800","local-member-id":"357bf0025115def9","added-peer-id":"357bf0025115def9","added-peer-peer-urls":["https://162.253.55.55:2380"]} {"level":"info","ts":"2026-09-07T10:42:24.68709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T10:42:24.68722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T10:42:24.687278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 received MsgPreVoteResp from 357bf0025115def9 at term 1"} {"level":"info","ts":"2026-09-07T10:42:24.687304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became candidate at term 2"} {"level":"info","ts":"2026-09-07T10:42:24.687316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 received MsgVoteResp from 357bf0025115def9 at term 2"} {"level":"info","ts":"2026-09-07T10:42:24.687337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became leader at term 2"} {"level":"info","ts":"2026-09-07T10:42:24.687371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 357bf0025115def9 elected leader 357bf0025115def9 at term 2"} {"level":"info","ts":"2026-09-07T10:42:24.688797Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"357bf0025115def9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.55:2379]}","request-path":"/0/members/357bf0025115def9/attributes","cluster-id":"5f69314e1ae3c800","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T10:42:24.688843Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T10:42:24.688853Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T10:42:24.689229Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:42:24.689705Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T10:42:24.689789Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T10:42:24.692462Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f69314e1ae3c800","local-member-id":"357bf0025115def9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:42:24.692571Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:42:24.692608Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:42:24.692971Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T10:42:24.693049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.55:2379"} {"level":"info","ts":"2026-09-07T10:42:30.075673Z","caller":"traceutil/trace.go:171","msg":"trace[1639536952] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"124.363039ms","start":"2026-09-07T10:42:29.95128Z","end":"2026-09-07T10:42:30.075643Z","steps":["trace[1639536952] 'process raft request' (duration: 75.379889ms)","trace[1639536952] 'compare' (duration: 48.774496ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:42:30.075908Z","caller":"traceutil/trace.go:171","msg":"trace[1915047124] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"124.283666ms","start":"2026-09-07T10:42:29.951571Z","end":"2026-09-07T10:42:30.075854Z","steps":["trace[1915047124] 'process raft request' (duration: 124.067242ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:42:30.076181Z","caller":"traceutil/trace.go:171","msg":"trace[1861069317] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"124.604152ms","start":"2026-09-07T10:42:29.951437Z","end":"2026-09-07T10:42:30.076041Z","steps":["trace[1861069317] 'process raft request' (duration: 124.149544ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:42:30.075965Z","caller":"traceutil/trace.go:171","msg":"trace[258133270] transaction","detail":"{read_only:false; number_of_response:0; response_revision:282; }","duration":"121.664477ms","start":"2026-09-07T10:42:29.954291Z","end":"2026-09-07T10:42:30.075956Z","steps":["trace[258133270] 'process raft request' (duration: 121.484963ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:42:30.076236Z","caller":"traceutil/trace.go:171","msg":"trace[531675404] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"122.465402ms","start":"2026-09-07T10:42:29.953755Z","end":"2026-09-07T10:42:30.07622Z","steps":["trace[531675404] 'process raft request' (duration: 121.924142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:42:48.067411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.424659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.55\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-07T10:42:48.06753Z","caller":"traceutil/trace.go:171","msg":"trace[1356204487] range","detail":"{range_begin:/registry/masterleases/162.253.55.55; range_end:; response_count:1; response_revision:428; }","duration":"117.601822ms","start":"2026-09-07T10:42:47.949907Z","end":"2026-09-07T10:42:48.067508Z","steps":["trace[1356204487] 'range keys from in-memory index tree' (duration: 117.289496ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:05.113867Z","caller":"traceutil/trace.go:171","msg":"trace[403653372] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"110.44088ms","start":"2026-09-07T10:43:05.003398Z","end":"2026-09-07T10:43:05.113838Z","steps":["trace[403653372] 'process raft request' (duration: 101.403523ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:11.147871Z","caller":"traceutil/trace.go:171","msg":"trace[239746590] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"176.248268ms","start":"2026-09-07T10:43:10.971585Z","end":"2026-09-07T10:43:11.147833Z","steps":["trace[239746590] 'read index received' (duration: 62.989879ms)","trace[239746590] 'applied index is now lower than readState.Index' (duration: 113.257109ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:43:11.148197Z","caller":"traceutil/trace.go:171","msg":"trace[380785339] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"184.234359ms","start":"2026-09-07T10:43:10.963937Z","end":"2026-09-07T10:43:11.148171Z","steps":["trace[380785339] 'process raft request' (duration: 176.486536ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:43:11.148204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.568866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tdvz5\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-07T10:43:11.148258Z","caller":"traceutil/trace.go:171","msg":"trace[374383043] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tdvz5; range_end:; response_count:1; response_revision:638; }","duration":"176.711791ms","start":"2026-09-07T10:43:10.971531Z","end":"2026-09-07T10:43:11.148243Z","steps":["trace[374383043] 'agreement among raft nodes before linearized reading' (duration: 176.452924ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:11.382096Z","caller":"traceutil/trace.go:171","msg":"trace[1861138554] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"211.555635ms","start":"2026-09-07T10:43:11.170459Z","end":"2026-09-07T10:43:11.382014Z","steps":["trace[1861138554] 'process raft request' (duration: 180.382737ms)","trace[1861138554] 'compare' (duration: 31.052855ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:43:11.407724Z","caller":"traceutil/trace.go:171","msg":"trace[240845889] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"177.94468ms","start":"2026-09-07T10:43:11.229726Z","end":"2026-09-07T10:43:11.407671Z","steps":["trace[240845889] 'process raft request' (duration: 177.808176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:43:11.856772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.414877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:43:11.85687Z","caller":"traceutil/trace.go:171","msg":"trace[1093662331] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"430.548495ms","start":"2026-09-07T10:43:11.426305Z","end":"2026-09-07T10:43:11.856854Z","steps":["trace[1093662331] 'process raft request' (duration: 70.584904ms)","trace[1093662331] 'compare' (duration: 359.303493ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:43:11.856917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:43:11.426285Z","time spent":"430.617226ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T10:43:12.012683Z","caller":"traceutil/trace.go:171","msg":"trace[1832227140] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"131.88302ms","start":"2026-09-07T10:43:11.880774Z","end":"2026-09-07T10:43:12.012657Z","steps":["trace[1832227140] 'process raft request' (duration: 124.359734ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:13.481831Z","caller":"traceutil/trace.go:171","msg":"trace[80838545] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"216.997374ms","start":"2026-09-07T10:43:13.264753Z","end":"2026-09-07T10:43:13.48175Z","steps":["trace[80838545] 'read index received' (duration: 139.903014ms)","trace[80838545] 'applied index is now lower than readState.Index' (duration: 77.09234ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:43:13.482127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.290923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:43:13.482201Z","caller":"traceutil/trace.go:171","msg":"trace[1193304667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"217.478888ms","start":"2026-09-07T10:43:13.264708Z","end":"2026-09-07T10:43:13.482187Z","steps":["trace[1193304667] 'agreement among raft nodes before linearized reading' (duration: 217.248712ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:13.482285Z","caller":"traceutil/trace.go:171","msg":"trace[568987054] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"219.363509ms","start":"2026-09-07T10:43:13.262869Z","end":"2026-09-07T10:43:13.482233Z","steps":["trace[568987054] 'process raft request' (duration: 141.98023ms)","trace[568987054] 'compare' (duration: 76.173476ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:43:28.354139Z","caller":"traceutil/trace.go:171","msg":"trace[2123051966] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"264.07139ms","start":"2026-09-07T10:43:28.090032Z","end":"2026-09-07T10:43:28.354103Z","steps":["trace[2123051966] 'read index received' (duration: 263.723291ms)","trace[2123051966] 'applied index is now lower than readState.Index' (duration: 346.369µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:43:28.354228Z","caller":"traceutil/trace.go:171","msg":"trace[1492761739] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"265.977648ms","start":"2026-09-07T10:43:28.088198Z","end":"2026-09-07T10:43:28.354175Z","steps":["trace[1492761739] 'process raft request' (duration: 265.674091ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:43:28.354381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.306825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:43:28.354442Z","caller":"traceutil/trace.go:171","msg":"trace[1153552768] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:809; }","duration":"264.399738ms","start":"2026-09-07T10:43:28.090026Z","end":"2026-09-07T10:43:28.354426Z","steps":["trace[1153552768] 'agreement among raft nodes before linearized reading' (duration: 264.270744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:43:28.354585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.391654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-07T10:43:28.35464Z","caller":"traceutil/trace.go:171","msg":"trace[240968620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"217.470636ms","start":"2026-09-07T10:43:28.137154Z","end":"2026-09-07T10:43:28.354624Z","steps":["trace[240968620] 'agreement among raft nodes before linearized reading' (duration: 217.279751ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:28.483768Z","caller":"traceutil/trace.go:171","msg":"trace[1010502730] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"122.524974ms","start":"2026-09-07T10:43:28.361211Z","end":"2026-09-07T10:43:28.483736Z","steps":["trace[1010502730] 'process raft request' (duration: 117.716612ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:42.732969Z","caller":"traceutil/trace.go:171","msg":"trace[710735972] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"121.689204ms","start":"2026-09-07T10:43:42.611246Z","end":"2026-09-07T10:43:42.732935Z","steps":["trace[710735972] 'read index received' (duration: 435.42µs)","trace[710735972] 'applied index is now lower than readState.Index' (duration: 121.252274ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:43:42.733119Z","caller":"traceutil/trace.go:171","msg":"trace[715510316] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"123.97502ms","start":"2026-09-07T10:43:42.609117Z","end":"2026-09-07T10:43:42.733092Z","steps":["trace[715510316] 'process raft request' (duration: 49.061849ms)","trace[715510316] 'compare' (duration: 74.624024ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:43:42.733255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.983431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-pvkjn\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-09-07T10:43:42.733303Z","caller":"traceutil/trace.go:171","msg":"trace[1571190887] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-pvkjn; range_end:; response_count:1; response_revision:969; }","duration":"122.051393ms","start":"2026-09-07T10:43:42.611236Z","end":"2026-09-07T10:43:42.733287Z","steps":["trace[1571190887] 'agreement among raft nodes before linearized reading' (duration: 121.858908ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:42.88672Z","caller":"traceutil/trace.go:171","msg":"trace[586783193] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"142.509285ms","start":"2026-09-07T10:43:42.744182Z","end":"2026-09-07T10:43:42.886691Z","steps":["trace[586783193] 'process raft request' (duration: 140.530527ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:49.879391Z","caller":"traceutil/trace.go:171","msg":"trace[1367046042] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"135.375635ms","start":"2026-09-07T10:43:49.743962Z","end":"2026-09-07T10:43:49.879338Z","steps":["trace[1367046042] 'process raft request' (duration: 124.735415ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:49.879783Z","caller":"traceutil/trace.go:171","msg":"trace[674196007] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"135.371745ms","start":"2026-09-07T10:43:49.744387Z","end":"2026-09-07T10:43:49.879759Z","steps":["trace[674196007] 'process raft request' (duration: 134.827282ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:49.880205Z","caller":"traceutil/trace.go:171","msg":"trace[1921187134] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"133.642194ms","start":"2026-09-07T10:43:49.746524Z","end":"2026-09-07T10:43:49.880166Z","steps":["trace[1921187134] 'process raft request' (duration: 132.757804ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:49.880694Z","caller":"traceutil/trace.go:171","msg":"trace[1467947824] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"133.565913ms","start":"2026-09-07T10:43:49.747111Z","end":"2026-09-07T10:43:49.880677Z","steps":["trace[1467947824] 'process raft request' (duration: 132.259692ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:43:54.633036Z","caller":"traceutil/trace.go:171","msg":"trace[126946896] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"142.12644ms","start":"2026-09-07T10:43:54.490855Z","end":"2026-09-07T10:43:54.632982Z","steps":["trace[126946896] 'process raft request' (duration: 141.747901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:03.427189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.557254ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-07T10:44:03.427559Z","caller":"traceutil/trace.go:171","msg":"trace[146679640] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"162.199374ms","start":"2026-09-07T10:44:03.265332Z","end":"2026-09-07T10:44:03.427532Z","steps":["trace[146679640] 'read index received' (duration: 66.592µs)","trace[146679640] 'applied index is now lower than readState.Index' (duration: 162.127472ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:44:03.427841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.458571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:03.42801Z","caller":"traceutil/trace.go:171","msg":"trace[1196086399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1228; }","duration":"162.715666ms","start":"2026-09-07T10:44:03.265265Z","end":"2026-09-07T10:44:03.427981Z","steps":["trace[1196086399] 'agreement among raft nodes before linearized reading' (duration: 162.373188ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:44:04.064863Z","caller":"traceutil/trace.go:171","msg":"trace[1345448625] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"631.26227ms","start":"2026-09-07T10:44:03.433558Z","end":"2026-09-07T10:44:04.064821Z","steps":["trace[1345448625] 'process raft request' (duration: 631.024135ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:04.065169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:03.433523Z","time spent":"631.499146ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T10:44:35.569046Z","caller":"traceutil/trace.go:171","msg":"trace[1786196063] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1596; }","duration":"100.432068ms","start":"2026-09-07T10:44:35.46858Z","end":"2026-09-07T10:44:35.569012Z","steps":["trace[1786196063] 'process raft request' (duration: 100.299785ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:53.799987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.543398ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-07T10:44:53.800383Z","caller":"traceutil/trace.go:171","msg":"trace[1790376650] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"253.843532ms","start":"2026-09-07T10:44:53.546459Z","end":"2026-09-07T10:44:53.800303Z","steps":["trace[1790376650] 'process raft request' (duration: 253.71383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:53.800576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.249394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d9bdcccc-ecf2-4202-b5c5-120a1c58e02b\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-07T10:44:53.800659Z","caller":"traceutil/trace.go:171","msg":"trace[740494345] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d9bdcccc-ecf2-4202-b5c5-120a1c58e02b; range_end:; response_count:1; response_revision:1899; }","duration":"436.345206ms","start":"2026-09-07T10:44:53.364296Z","end":"2026-09-07T10:44:53.800641Z","steps":["trace[740494345] 'agreement among raft nodes before linearized reading' (duration: 436.136842ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:53.8007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:53.364269Z","time spent":"436.420007ms","remote":"127.0.0.1:46394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d9bdcccc-ecf2-4202-b5c5-120a1c58e02b\" "} {"level":"info","ts":"2026-09-07T10:44:53.800394Z","caller":"traceutil/trace.go:171","msg":"trace[1624869382] linearizableReadLoop","detail":"{readStateIndex:1976; appliedIndex:1975; }","duration":"436.014959ms","start":"2026-09-07T10:44:53.364306Z","end":"2026-09-07T10:44:53.800321Z","steps":["trace[1624869382] 'read index received' (duration: 205.123973ms)","trace[1624869382] 'applied index is now lower than readState.Index' (duration: 230.887245ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:44:53.801404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.11531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d9bdcccc-ecf2-4202-b5c5-120a1c58e02b\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-09-07T10:44:53.801423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.376955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-07T10:44:53.801451Z","caller":"traceutil/trace.go:171","msg":"trace[2075677915] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d9bdcccc-ecf2-4202-b5c5-120a1c58e02b; range_end:; response_count:1; response_revision:1899; }","duration":"300.206232ms","start":"2026-09-07T10:44:53.501232Z","end":"2026-09-07T10:44:53.801438Z","steps":["trace[2075677915] 'agreement among raft nodes before linearized reading' (duration: 300.076319ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:44:53.801472Z","caller":"traceutil/trace.go:171","msg":"trace[478984065] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1899; }","duration":"435.423836ms","start":"2026-09-07T10:44:53.36603Z","end":"2026-09-07T10:44:53.801454Z","steps":["trace[478984065] 'agreement among raft nodes before linearized reading' (duration: 435.146101ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:53.801481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:53.501204Z","time spent":"300.269673ms","remote":"127.0.0.1:46394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d9bdcccc-ecf2-4202-b5c5-120a1c58e02b\" "} {"level":"warn","ts":"2026-09-07T10:44:53.801516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:53.365957Z","time spent":"435.551288ms","remote":"127.0.0.1:52006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-07T10:44:54.191391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.45447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:44:54.191504Z","caller":"traceutil/trace.go:171","msg":"trace[1169491706] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"381.757703ms","start":"2026-09-07T10:44:53.809723Z","end":"2026-09-07T10:44:54.191481Z","steps":["trace[1169491706] 'process raft request' (duration: 191.1336ms)","trace[1169491706] 'compare' (duration: 190.313666ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:44:54.191562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:53.809691Z","time spent":"381.844024ms","remote":"127.0.0.1:46394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T10:45:07.287276Z","caller":"traceutil/trace.go:171","msg":"trace[1809773709] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"138.700225ms","start":"2026-09-07T10:45:07.148558Z","end":"2026-09-07T10:45:07.287258Z","steps":["trace[1809773709] 'process raft request' (duration: 138.499961ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:07.28726Z","caller":"traceutil/trace.go:171","msg":"trace[1407007071] linearizableReadLoop","detail":"{readStateIndex:2096; appliedIndex:2095; }","duration":"136.276426ms","start":"2026-09-07T10:45:07.150951Z","end":"2026-09-07T10:45:07.287227Z","steps":["trace[1407007071] 'read index received' (duration: 136.037481ms)","trace[1407007071] 'applied index is now lower than readState.Index' (duration: 237.955µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:45:07.287407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.441069ms","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-09-07T10:45:07.287762Z","caller":"traceutil/trace.go:171","msg":"trace[1908138455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2015; }","duration":"136.647323ms","start":"2026-09-07T10:45:07.150892Z","end":"2026-09-07T10:45:07.287539Z","steps":["trace[1908138455] 'agreement among raft nodes before linearized reading' (duration: 136.416149ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:26.958951Z","caller":"traceutil/trace.go:171","msg":"trace[27232984] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2219; }","duration":"315.758016ms","start":"2026-09-07T10:45:26.64317Z","end":"2026-09-07T10:45:26.958928Z","steps":["trace[27232984] 'read index received' (duration: 315.622612ms)","trace[27232984] 'applied index is now lower than readState.Index' (duration: 134.564µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:45:26.959056Z","caller":"traceutil/trace.go:171","msg":"trace[1036585295] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"325.031416ms","start":"2026-09-07T10:45:26.634014Z","end":"2026-09-07T10:45:26.959046Z","steps":["trace[1036585295] 'process raft request' (duration: 324.76799ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:26.959157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:26.633988Z","time spent":"325.091568ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T10:45:26.959436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.260076ms","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-09-07T10:45:26.959477Z","caller":"traceutil/trace.go:171","msg":"trace[1886926870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"316.320176ms","start":"2026-09-07T10:45:26.643145Z","end":"2026-09-07T10:45:26.959465Z","steps":["trace[1886926870] 'agreement among raft nodes before linearized reading' (duration: 316.153253ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:26.959503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:26.643133Z","time spent":"316.363547ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-07T10:45:27.086883Z","caller":"traceutil/trace.go:171","msg":"trace[1514538134] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"182.192621ms","start":"2026-09-07T10:45:26.904651Z","end":"2026-09-07T10:45:27.086844Z","steps":["trace[1514538134] 'process raft request' (duration: 140.475796ms)","trace[1514538134] 'compare' (duration: 41.43051ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:45:27.08695Z","caller":"traceutil/trace.go:171","msg":"trace[1017060473] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2220; }","duration":"127.913809ms","start":"2026-09-07T10:45:26.959017Z","end":"2026-09-07T10:45:27.086931Z","steps":["trace[1017060473] 'read index received' (duration: 86.066571ms)","trace[1017060473] 'applied index is now lower than readState.Index' (duration: 41.844908ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:45:27.087038Z","caller":"traceutil/trace.go:171","msg":"trace[605500430] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"122.524244ms","start":"2026-09-07T10:45:26.964493Z","end":"2026-09-07T10:45:27.087017Z","steps":["trace[605500430] 'process raft request' (duration: 122.32899ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:27.08714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.363737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-09-07T10:45:27.087292Z","caller":"traceutil/trace.go:171","msg":"trace[1142023349] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2137; }","duration":"153.566881ms","start":"2026-09-07T10:45:26.933705Z","end":"2026-09-07T10:45:27.087272Z","steps":["trace[1142023349] 'agreement among raft nodes before linearized reading' (duration: 153.249565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:27.08769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.739226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d3040ae0aa2cf2\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-09-07T10:45:27.08777Z","caller":"traceutil/trace.go:171","msg":"trace[1824325988] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18d3040ae0aa2cf2; range_end:; response_count:1; response_revision:2138; }","duration":"331.87653ms","start":"2026-09-07T10:45:26.755867Z","end":"2026-09-07T10:45:27.087743Z","steps":["trace[1824325988] 'agreement among raft nodes before linearized reading' (duration: 331.134214ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:27.087821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:26.755844Z","time spent":"331.963591ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":868,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d3040ae0aa2cf2\" "} {"level":"info","ts":"2026-09-07T10:45:27.087654Z","caller":"traceutil/trace.go:171","msg":"trace[1456196405] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"109.438618ms","start":"2026-09-07T10:45:26.978181Z","end":"2026-09-07T10:45:27.08762Z","steps":["trace[1456196405] 'process raft request' (duration: 108.778996ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:28.320223Z","caller":"traceutil/trace.go:171","msg":"trace[1910540439] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"222.182787ms","start":"2026-09-07T10:45:28.098013Z","end":"2026-09-07T10:45:28.320196Z","steps":["trace[1910540439] 'process raft request' (duration: 212.59992ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:28.320219Z","caller":"traceutil/trace.go:171","msg":"trace[1890259188] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2231; }","duration":"213.460087ms","start":"2026-09-07T10:45:28.10673Z","end":"2026-09-07T10:45:28.32019Z","steps":["trace[1890259188] 'read index received' (duration: 203.948292ms)","trace[1890259188] 'applied index is now lower than readState.Index' (duration: 9.510295ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:45:28.320519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.730384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-09-07T10:45:28.321477Z","caller":"traceutil/trace.go:171","msg":"trace[753610439] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2146; }","duration":"214.769463ms","start":"2026-09-07T10:45:28.106688Z","end":"2026-09-07T10:45:28.321457Z","steps":["trace[753610439] 'agreement among raft nodes before linearized reading' (duration: 213.58506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:34.681095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.586253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-07T10:46:34.681177Z","caller":"traceutil/trace.go:171","msg":"trace[479373231] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2604; }","duration":"180.702585ms","start":"2026-09-07T10:46:34.500458Z","end":"2026-09-07T10:46:34.681161Z","steps":["trace[479373231] 'range keys from in-memory index tree' (duration: 180.469881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:34.68143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.247853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T10:46:34.681497Z","caller":"traceutil/trace.go:171","msg":"trace[948875574] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2604; }","duration":"166.346535ms","start":"2026-09-07T10:46:34.515133Z","end":"2026-09-07T10:46:34.681479Z","steps":["trace[948875574] 'count revisions from in-memory index tree' (duration: 166.148831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:06.32931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.846682ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:47:06.329997Z","caller":"traceutil/trace.go:171","msg":"trace[462242706] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"379.478457ms","start":"2026-09-07T10:47:05.950491Z","end":"2026-09-07T10:47:06.329969Z","steps":["trace[462242706] 'process raft request' (duration: 273.883032ms)","trace[462242706] 'compare' (duration: 104.73658ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:47:06.33011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:47:05.950417Z","time spent":"379.64992ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T10:47:11.925773Z","caller":"traceutil/trace.go:171","msg":"trace[668339330] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"175.418677ms","start":"2026-09-07T10:47:11.750332Z","end":"2026-09-07T10:47:11.925751Z","steps":["trace[668339330] 'process raft request' (duration: 172.614254ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:29.072436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.261351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:51:29.072557Z","caller":"traceutil/trace.go:171","msg":"trace[613446257] linearizableReadLoop","detail":"{readStateIndex:5034; appliedIndex:5033; }","duration":"279.477085ms","start":"2026-09-07T10:51:28.793059Z","end":"2026-09-07T10:51:29.072536Z","steps":["trace[613446257] 'read index received' (duration: 170.99634ms)","trace[613446257] 'applied index is now lower than readState.Index' (duration: 108.479205ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:29.072635Z","caller":"traceutil/trace.go:171","msg":"trace[1788725520] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"306.619866ms","start":"2026-09-07T10:51:28.765968Z","end":"2026-09-07T10:51:29.072588Z","steps":["trace[1788725520] 'process raft request' (duration: 198.10234ms)","trace[1788725520] 'compare' (duration: 108.106918ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:51:29.072782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:28.765954Z","time spent":"306.758179ms","remote":"127.0.0.1:47500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3568,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T10:51:29.072828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.75704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-07T10:51:29.072871Z","caller":"traceutil/trace.go:171","msg":"trace[1694701222] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4846; }","duration":"279.831592ms","start":"2026-09-07T10:51:28.793022Z","end":"2026-09-07T10:51:29.072854Z","steps":["trace[1694701222] 'agreement among raft nodes before linearized reading' (duration: 279.614838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:29.072856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.687909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-07T10:51:29.072926Z","caller":"traceutil/trace.go:171","msg":"trace[1548775652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4846; }","duration":"160.766731ms","start":"2026-09-07T10:51:28.91214Z","end":"2026-09-07T10:51:29.072907Z","steps":["trace[1548775652] 'agreement among raft nodes before linearized reading' (duration: 160.565087ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:29.230658Z","caller":"traceutil/trace.go:171","msg":"trace[1410248516] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"152.510678ms","start":"2026-09-07T10:51:29.07812Z","end":"2026-09-07T10:51:29.23063Z","steps":["trace[1410248516] 'process raft request' (duration: 110.010282ms)","trace[1410248516] 'compare' (duration: 42.389994ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:29.413755Z","caller":"traceutil/trace.go:171","msg":"trace[1193957910] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"334.811058ms","start":"2026-09-07T10:51:29.078909Z","end":"2026-09-07T10:51:29.41372Z","steps":["trace[1193957910] 'process raft request' (duration: 326.625707ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:29.413776Z","caller":"traceutil/trace.go:171","msg":"trace[73667122] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"333.016434ms","start":"2026-09-07T10:51:29.080746Z","end":"2026-09-07T10:51:29.413762Z","steps":["trace[73667122] 'process raft request' (duration: 332.903782ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:29.413901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:29.080729Z","time spent":"333.105416ms","remote":"127.0.0.1:46394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4932,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T10:51:29.413919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:29.078886Z","time spent":"334.9334ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T10:51:29.413934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.275002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-07T10:51:29.413988Z","caller":"traceutil/trace.go:171","msg":"trace[8539179] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4849; }","duration":"291.358844ms","start":"2026-09-07T10:51:29.122612Z","end":"2026-09-07T10:51:29.413971Z","steps":["trace[8539179] 'agreement among raft nodes before linearized reading' (duration: 291.230142ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:29.413725Z","caller":"traceutil/trace.go:171","msg":"trace[671511696] linearizableReadLoop","detail":"{readStateIndex:5037; appliedIndex:5034; }","duration":"291.060409ms","start":"2026-09-07T10:51:29.122644Z","end":"2026-09-07T10:51:29.413704Z","steps":["trace[671511696] 'read index received' (duration: 65.575301ms)","trace[671511696] 'applied index is now lower than readState.Index' (duration: 225.484138ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:51:29.414515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.008226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-09-07T10:51:29.414545Z","caller":"traceutil/trace.go:171","msg":"trace[1821757759] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4849; }","duration":"187.077378ms","start":"2026-09-07T10:51:29.227458Z","end":"2026-09-07T10:51:29.414536Z","steps":["trace[1821757759] 'agreement among raft nodes before linearized reading' (duration: 186.981106ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:34.630975Z","caller":"traceutil/trace.go:171","msg":"trace[1841089528] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"131.025951ms","start":"2026-09-07T10:51:34.499912Z","end":"2026-09-07T10:51:34.630938Z","steps":["trace[1841089528] 'process raft request' (duration: 130.894629ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:34.710739Z","caller":"traceutil/trace.go:171","msg":"trace[319251660] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"100.369485ms","start":"2026-09-07T10:51:34.61034Z","end":"2026-09-07T10:51:34.71071Z","steps":["trace[319251660] 'process raft request' (duration: 100.304343ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:34.710799Z","caller":"traceutil/trace.go:171","msg":"trace[548710356] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"104.980221ms","start":"2026-09-07T10:51:34.605796Z","end":"2026-09-07T10:51:34.710776Z","steps":["trace[548710356] 'process raft request' (duration: 104.687866ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:44.740295Z","caller":"traceutil/trace.go:171","msg":"trace[188292811] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"130.479681ms","start":"2026-09-07T10:51:44.609777Z","end":"2026-09-07T10:51:44.740257Z","steps":["trace[188292811] 'process raft request' (duration: 130.046484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:48.937675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.915612ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:51:48.938033Z","caller":"traceutil/trace.go:171","msg":"trace[1005899722] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5142; }","duration":"208.299099ms","start":"2026-09-07T10:51:48.729715Z","end":"2026-09-07T10:51:48.938014Z","steps":["trace[1005899722] 'range keys from in-memory index tree' (duration: 207.893012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:48.963779Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16067049597746742373,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-07T10:51:48.99836Z","caller":"traceutil/trace.go:171","msg":"trace[1405622930] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"538.989981ms","start":"2026-09-07T10:51:48.459348Z","end":"2026-09-07T10:51:48.998338Z","steps":["trace[1405622930] 'process raft request' (duration: 538.565363ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:48.998695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:48.459328Z","time spent":"539.233125ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T10:51:49.004967Z","caller":"traceutil/trace.go:171","msg":"trace[1659953738] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"234.787159ms","start":"2026-09-07T10:51:48.770158Z","end":"2026-09-07T10:51:49.004945Z","steps":["trace[1659953738] 'process raft request' (duration: 234.632476ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:49.005121Z","caller":"traceutil/trace.go:171","msg":"trace[502380124] linearizableReadLoop","detail":"{readStateIndex:5342; appliedIndex:5339; }","duration":"542.223759ms","start":"2026-09-07T10:51:48.462854Z","end":"2026-09-07T10:51:49.005078Z","steps":["trace[502380124] 'read index received' (duration: 535.139159ms)","trace[502380124] 'applied index is now lower than readState.Index' (duration: 7.08294ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:49.00523Z","caller":"traceutil/trace.go:171","msg":"trace[1030568492] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"234.456551ms","start":"2026-09-07T10:51:48.770743Z","end":"2026-09-07T10:51:49.0052Z","steps":["trace[1030568492] 'process raft request' (duration: 234.167256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:49.005318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.449573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-07T10:51:49.005358Z","caller":"traceutil/trace.go:171","msg":"trace[978707504] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5145; }","duration":"542.517414ms","start":"2026-09-07T10:51:48.46283Z","end":"2026-09-07T10:51:49.005347Z","steps":["trace[978707504] 'agreement among raft nodes before linearized reading' (duration: 542.377942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:49.00535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.311605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-07T10:51:49.005396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:48.46282Z","time spent":"542.565196ms","remote":"127.0.0.1:46466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-07T10:51:49.005405Z","caller":"traceutil/trace.go:171","msg":"trace[788295066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5145; }","duration":"191.417697ms","start":"2026-09-07T10:51:48.813973Z","end":"2026-09-07T10:51:49.005391Z","steps":["trace[788295066] 'agreement among raft nodes before linearized reading' (duration: 191.321285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:49.005407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.545878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"warn","ts":"2026-09-07T10:51:49.005423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.656874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:51:49.005447Z","caller":"traceutil/trace.go:171","msg":"trace[192243490] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5145; }","duration":"383.63549ms","start":"2026-09-07T10:51:48.6218Z","end":"2026-09-07T10:51:49.005435Z","steps":["trace[192243490] 'agreement among raft nodes before linearized reading' (duration: 383.489747ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:49.005463Z","caller":"traceutil/trace.go:171","msg":"trace[1407629226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5145; }","duration":"176.734716ms","start":"2026-09-07T10:51:48.828716Z","end":"2026-09-07T10:51:49.005451Z","steps":["trace[1407629226] 'agreement among raft nodes before linearized reading' (duration: 176.661255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:49.005489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:48.621775Z","time spent":"383.707101ms","remote":"127.0.0.1:46394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10413,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-09-07T10:51:49.005535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.85851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-07T10:51:49.005566Z","caller":"traceutil/trace.go:171","msg":"trace[232299064] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5145; }","duration":"312.929062ms","start":"2026-09-07T10:51:48.692628Z","end":"2026-09-07T10:51:49.005557Z","steps":["trace[232299064] 'agreement among raft nodes before linearized reading' (duration: 312.84545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:49.00559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:51:48.692606Z","time spent":"312.977493ms","remote":"127.0.0.1:46374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-09-07T10:51:49.175037Z","caller":"traceutil/trace.go:171","msg":"trace[944414750] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"156.854629ms","start":"2026-09-07T10:51:49.018154Z","end":"2026-09-07T10:51:49.175009Z","steps":["trace[944414750] 'process raft request' (duration: 109.85266ms)","trace[944414750] 'compare' (duration: 46.804905ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:49.175536Z","caller":"traceutil/trace.go:171","msg":"trace[1910428005] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"153.245112ms","start":"2026-09-07T10:51:49.022278Z","end":"2026-09-07T10:51:49.175523Z","steps":["trace[1910428005] 'process raft request' (duration: 152.676602ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:49.38041Z","caller":"traceutil/trace.go:171","msg":"trace[1933406988] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"145.117262ms","start":"2026-09-07T10:51:49.235267Z","end":"2026-09-07T10:51:49.380385Z","steps":["trace[1933406988] 'process raft request' (duration: 45.207996ms)","trace[1933406988] 'compare' (duration: 99.713402ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:49.380617Z","caller":"traceutil/trace.go:171","msg":"trace[2017468655] linearizableReadLoop","detail":"{readStateIndex:5353; appliedIndex:5351; }","duration":"116.93386ms","start":"2026-09-07T10:51:49.263658Z","end":"2026-09-07T10:51:49.380592Z","steps":["trace[2017468655] 'read index received' (duration: 16.737149ms)","trace[2017468655] 'applied index is now lower than readState.Index' (duration: 100.195161ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:49.380653Z","caller":"traceutil/trace.go:171","msg":"trace[1198738763] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"138.668992ms","start":"2026-09-07T10:51:49.241956Z","end":"2026-09-07T10:51:49.380625Z","steps":["trace[1198738763] 'process raft request' (duration: 138.358906ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:49.380826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.152054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:51:49.380889Z","caller":"traceutil/trace.go:171","msg":"trace[834012160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5156; }","duration":"117.266726ms","start":"2026-09-07T10:51:49.263609Z","end":"2026-09-07T10:51:49.380876Z","steps":["trace[834012160] 'agreement among raft nodes before linearized reading' (duration: 117.098953ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:24.737533Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-09-07T10:52:24.807705Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"68.844463ms","hash":1684184379,"current-db-size-bytes":51851264,"current-db-size":"52 MB","current-db-size-in-use-bytes":28397568,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-07T10:52:24.807749Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1684184379,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-09-07T10:57:03.12953Z","caller":"traceutil/trace.go:171","msg":"trace[1459300245] transaction","detail":"{read_only:false; response_revision:7300; number_of_response:1; }","duration":"148.738068ms","start":"2026-09-07T10:57:02.980767Z","end":"2026-09-07T10:57:03.129505Z","steps":["trace[1459300245] 'process raft request' (duration: 105.829318ms)","trace[1459300245] 'compare' (duration: 42.626367ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:57:03.130028Z","caller":"traceutil/trace.go:171","msg":"trace[588987381] transaction","detail":"{read_only:false; response_revision:7301; number_of_response:1; }","duration":"146.537128ms","start":"2026-09-07T10:57:02.983434Z","end":"2026-09-07T10:57:03.129971Z","steps":["trace[588987381] 'process raft request' (duration: 145.989204ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:57:18.244689Z","caller":"traceutil/trace.go:171","msg":"trace[1297570742] linearizableReadLoop","detail":"{readStateIndex:7649; appliedIndex:7648; }","duration":"216.834195ms","start":"2026-09-07T10:57:18.027836Z","end":"2026-09-07T10:57:18.244671Z","steps":["trace[1297570742] 'read index received' (duration: 216.766852ms)","trace[1297570742] 'applied index is now lower than readState.Index' (duration: 66.243µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:57:18.244782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.926869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:57:18.244804Z","caller":"traceutil/trace.go:171","msg":"trace[60649733] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7376; }","duration":"216.996843ms","start":"2026-09-07T10:57:18.0278Z","end":"2026-09-07T10:57:18.244797Z","steps":["trace[60649733] 'agreement among raft nodes before linearized reading' (duration: 216.93241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:57:23.792173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.723794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-07T10:57:23.792285Z","caller":"traceutil/trace.go:171","msg":"trace[1873332267] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7404; }","duration":"132.87179ms","start":"2026-09-07T10:57:23.659392Z","end":"2026-09-07T10:57:23.792264Z","steps":["trace[1873332267] 'range keys from in-memory index tree' (duration: 132.575118ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:57:24.811466Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5455} {"level":"info","ts":"2026-09-07T10:57:25.108998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5455,"took":"296.20472ms","hash":4257216196,"current-db-size-bytes":51851264,"current-db-size":"52 MB","current-db-size-in-use-bytes":18534400,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-07T10:57:25.109044Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4257216196,"revision":5455,"compact-revision":2877}