{"level":"warn","ts":"2026-06-29T20:56:44.885284Z","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-29T20:56:44.885367Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.157:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.157:2380","--initial-cluster=instance=https://199.19.213.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.157:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-29T20:56:44.885423Z","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-29T20:56:44.885431Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.157:2380"]} {"level":"info","ts":"2026-06-29T20:56:44.885448Z","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-29T20:56:44.886026Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.157:2379"]} {"level":"info","ts":"2026-06-29T20:56:44.886094Z","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.19.213.157:2380"],"listen-peer-urls":["https://199.19.213.157:2380"],"advertise-client-urls":["https://199.19.213.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.157:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-29T20:56:44.888404Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.126622ms"} {"level":"info","ts":"2026-06-29T20:56:44.892782Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"10058a425931b8de","cluster-id":"2ff97ff1d0272754"} {"level":"info","ts":"2026-06-29T20:56:44.892862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de switched to configuration voters=()"} {"level":"info","ts":"2026-06-29T20:56:44.892881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de became follower at term 0"} {"level":"info","ts":"2026-06-29T20:56:44.892899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 10058a425931b8de [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-29T20:56:44.892908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de became follower at term 1"} {"level":"info","ts":"2026-06-29T20:56:44.892948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de switched to configuration voters=(1154480897059305694)"} {"level":"warn","ts":"2026-06-29T20:56:44.896935Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-29T20:56:44.898339Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-29T20:56:44.899379Z","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-29T20:56:44.902074Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"10058a425931b8de","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-29T20:56:44.902552Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"10058a425931b8de","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-29T20:56:44.902685Z","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-29T20:56:44.902746Z","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-29T20:56:44.902758Z","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-29T20:56:44.905319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de switched to configuration voters=(1154480897059305694)"} {"level":"info","ts":"2026-06-29T20:56:44.905567Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2ff97ff1d0272754","local-member-id":"10058a425931b8de","added-peer-id":"10058a425931b8de","added-peer-peer-urls":["https://199.19.213.157:2380"]} {"level":"info","ts":"2026-06-29T20:56:44.908924Z","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-29T20:56:44.909239Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.157:2380"} {"level":"info","ts":"2026-06-29T20:56:44.909349Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.157:2380"} {"level":"info","ts":"2026-06-29T20:56:44.909371Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"10058a425931b8de","initial-advertise-peer-urls":["https://199.19.213.157:2380"],"listen-peer-urls":["https://199.19.213.157:2380"],"advertise-client-urls":["https://199.19.213.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-29T20:56:44.90945Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-29T20:56:45.893149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de is starting a new election at term 1"} {"level":"info","ts":"2026-06-29T20:56:45.893219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de became pre-candidate at term 1"} {"level":"info","ts":"2026-06-29T20:56:45.893254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de received MsgPreVoteResp from 10058a425931b8de at term 1"} {"level":"info","ts":"2026-06-29T20:56:45.893281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de became candidate at term 2"} {"level":"info","ts":"2026-06-29T20:56:45.893298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de received MsgVoteResp from 10058a425931b8de at term 2"} {"level":"info","ts":"2026-06-29T20:56:45.893314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"10058a425931b8de became leader at term 2"} {"level":"info","ts":"2026-06-29T20:56:45.893329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 10058a425931b8de elected leader 10058a425931b8de at term 2"} {"level":"info","ts":"2026-06-29T20:56:45.894715Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"10058a425931b8de","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.157:2379]}","request-path":"/0/members/10058a425931b8de/attributes","cluster-id":"2ff97ff1d0272754","publish-timeout":"7s"} {"level":"info","ts":"2026-06-29T20:56:45.894778Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-29T20:56:45.894853Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-29T20:56:45.894939Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-29T20:56:45.895249Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-29T20:56:45.895302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-29T20:56:45.89597Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2ff97ff1d0272754","local-member-id":"10058a425931b8de","cluster-version":"3.5"} {"level":"info","ts":"2026-06-29T20:56:45.896072Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-29T20:56:45.896106Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-29T20:56:45.897942Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.157:2379"} {"level":"info","ts":"2026-06-29T20:56:45.898634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-29T20:57:12.259848Z","caller":"traceutil/trace.go:171","msg":"trace[1046970304] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"128.484252ms","start":"2026-06-29T20:57:12.131335Z","end":"2026-06-29T20:57:12.259819Z","steps":["trace[1046970304] 'process raft request' (duration: 128.252756ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.357423Z","caller":"traceutil/trace.go:171","msg":"trace[217935902] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"178.872036ms","start":"2026-06-29T20:57:22.178529Z","end":"2026-06-29T20:57:22.357401Z","steps":["trace[217935902] 'process raft request' (duration: 178.709772ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.364387Z","caller":"traceutil/trace.go:171","msg":"trace[142187251] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"175.328558ms","start":"2026-06-29T20:57:22.18903Z","end":"2026-06-29T20:57:22.364359Z","steps":["trace[142187251] 'process raft request' (duration: 175.105683ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.36451Z","caller":"traceutil/trace.go:171","msg":"trace[2018691714] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"174.871747ms","start":"2026-06-29T20:57:22.189605Z","end":"2026-06-29T20:57:22.364477Z","steps":["trace[2018691714] 'process raft request' (duration: 174.632161ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.364932Z","caller":"traceutil/trace.go:171","msg":"trace[1607492511] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"167.475494ms","start":"2026-06-29T20:57:22.197079Z","end":"2026-06-29T20:57:22.364555Z","steps":["trace[1607492511] 'process raft request' (duration: 167.337171ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.365105Z","caller":"traceutil/trace.go:171","msg":"trace[1633730218] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"167.909235ms","start":"2026-06-29T20:57:22.197134Z","end":"2026-06-29T20:57:22.365043Z","steps":["trace[1633730218] 'process raft request' (duration: 167.340191ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.364541Z","caller":"traceutil/trace.go:171","msg":"trace[528650753] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"168.955471ms","start":"2026-06-29T20:57:22.195557Z","end":"2026-06-29T20:57:22.364512Z","steps":["trace[528650753] 'process raft request' (duration: 168.736636ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.36738Z","caller":"traceutil/trace.go:171","msg":"trace[870261656] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"168.56555ms","start":"2026-06-29T20:57:22.1988Z","end":"2026-06-29T20:57:22.367365Z","steps":["trace[870261656] 'process raft request' (duration: 165.767781ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.367432Z","caller":"traceutil/trace.go:171","msg":"trace[363897737] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"167.524406ms","start":"2026-06-29T20:57:22.199888Z","end":"2026-06-29T20:57:22.367413Z","steps":["trace[363897737] 'process raft request' (duration: 167.361462ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.368053Z","caller":"traceutil/trace.go:171","msg":"trace[639889902] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"161.127118ms","start":"2026-06-29T20:57:22.206373Z","end":"2026-06-29T20:57:22.367501Z","steps":["trace[639889902] 'process raft request' (duration: 161.005375ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.368491Z","caller":"traceutil/trace.go:171","msg":"trace[1215573466] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"126.035181ms","start":"2026-06-29T20:57:22.242441Z","end":"2026-06-29T20:57:22.368476Z","steps":["trace[1215573466] 'process raft request' (duration: 125.840187ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:22.368688Z","caller":"traceutil/trace.go:171","msg":"trace[649286963] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"159.724002ms","start":"2026-06-29T20:57:22.208948Z","end":"2026-06-29T20:57:22.368672Z","steps":["trace[649286963] 'process raft request' (duration: 159.162829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:28.606468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.101849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-29T20:57:28.606621Z","caller":"traceutil/trace.go:171","msg":"trace[1552094053] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"196.310746ms","start":"2026-06-29T20:57:28.410294Z","end":"2026-06-29T20:57:28.606605Z","steps":["trace[1552094053] 'read index received' (duration: 39.581µs)","trace[1552094053] 'applied index is now lower than readState.Index' (duration: 196.269915ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T20:57:28.60671Z","caller":"traceutil/trace.go:171","msg":"trace[20478003] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"316.704608ms","start":"2026-06-29T20:57:28.289975Z","end":"2026-06-29T20:57:28.606679Z","steps":["trace[20478003] 'process raft request' (duration: 83.828049ms)","trace[20478003] 'compare' (duration: 231.961796ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T20:57:28.606781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.48903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-29T20:57:28.606815Z","caller":"traceutil/trace.go:171","msg":"trace[2048365668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"196.552332ms","start":"2026-06-29T20:57:28.410251Z","end":"2026-06-29T20:57:28.606803Z","steps":["trace[2048365668] 'agreement among raft nodes before linearized reading' (duration: 196.421458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:28.607009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.289937Z","time spent":"316.896892ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-29T20:57:28.936255Z","caller":"traceutil/trace.go:171","msg":"trace[477182505] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"329.537405ms","start":"2026-06-29T20:57:28.606648Z","end":"2026-06-29T20:57:28.936185Z","steps":["trace[477182505] 'read index received' (duration: 324.313405ms)","trace[477182505] 'applied index is now lower than readState.Index' (duration: 5.219219ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T20:57:28.936326Z","caller":"traceutil/trace.go:171","msg":"trace[1816349182] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"374.72966ms","start":"2026-06-29T20:57:28.561467Z","end":"2026-06-29T20:57:28.936197Z","steps":["trace[1816349182] 'process raft request' (duration: 370.209688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:28.936408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.731917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-29T20:57:28.936481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.561441Z","time spent":"374.947685ms","remote":"127.0.0.1:38810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-29T20:57:28.937214Z","caller":"traceutil/trace.go:171","msg":"trace[800277567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"352.830119ms","start":"2026-06-29T20:57:28.583623Z","end":"2026-06-29T20:57:28.936453Z","steps":["trace[800277567] 'agreement among raft nodes before linearized reading' (duration: 352.661285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:28.937258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.583599Z","time spent":"353.648409ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-29T20:57:28.937302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.018231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x4mbd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-29T20:57:28.937438Z","caller":"traceutil/trace.go:171","msg":"trace[1924491638] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x4mbd; range_end:; response_count:1; response_revision:632; }","duration":"331.162035ms","start":"2026-06-29T20:57:28.606228Z","end":"2026-06-29T20:57:28.93739Z","steps":["trace[1924491638] 'agreement among raft nodes before linearized reading' (duration: 329.956565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:28.937507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.60622Z","time spent":"331.271577ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-x4mbd\" "} {"level":"warn","ts":"2026-06-29T20:57:28.948647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.71816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-29T20:57:28.948641Z","caller":"traceutil/trace.go:171","msg":"trace[1467653997] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"337.608924ms","start":"2026-06-29T20:57:28.610979Z","end":"2026-06-29T20:57:28.948588Z","steps":["trace[1467653997] 'process raft request' (duration: 337.484021ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:28.948709Z","caller":"traceutil/trace.go:171","msg":"trace[1879148061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"103.781072ms","start":"2026-06-29T20:57:28.84491Z","end":"2026-06-29T20:57:28.948691Z","steps":["trace[1879148061] 'agreement among raft nodes before linearized reading' (duration: 103.656229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:28.948805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.610967Z","time spent":"337.751587ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-29T20:57:29.907497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.358667ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-06-29T20:57:29.907851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.950165Z","time spent":"957.67438ms","remote":"127.0.0.1:38758","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-29T20:57:29.9081Z","caller":"traceutil/trace.go:171","msg":"trace[1911955133] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"956.873909ms","start":"2026-06-29T20:57:28.951201Z","end":"2026-06-29T20:57:29.908075Z","steps":["trace[1911955133] 'process raft request' (duration: 956.594782ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:29.908148Z","caller":"traceutil/trace.go:171","msg":"trace[426905093] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"957.852593ms","start":"2026-06-29T20:57:28.950259Z","end":"2026-06-29T20:57:29.908112Z","steps":["trace[426905093] 'read index received' (duration: 17.581604ms)","trace[426905093] 'applied index is now lower than readState.Index' (duration: 940.267139ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T20:57:29.908197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.951188Z","time spent":"956.955852ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-29T20:57:29.908251Z","caller":"traceutil/trace.go:171","msg":"trace[1824461554] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"921.673821ms","start":"2026-06-29T20:57:28.98656Z","end":"2026-06-29T20:57:29.908234Z","steps":["trace[1824461554] 'process raft request' (duration: 921.480045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:29.908329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.986536Z","time spent":"921.759084ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-29T20:57:29.908441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.149021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-29T20:57:29.908509Z","caller":"traceutil/trace.go:171","msg":"trace[791658394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"958.262144ms","start":"2026-06-29T20:57:28.950228Z","end":"2026-06-29T20:57:29.90849Z","steps":["trace[791658394] 'agreement among raft nodes before linearized reading' (duration: 958.07618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:29.908544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.021849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-29T20:57:29.908565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:28.950215Z","time spent":"958.337376ms","remote":"127.0.0.1:38728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-29T20:57:29.908577Z","caller":"traceutil/trace.go:171","msg":"trace[1845996072] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"638.0756ms","start":"2026-06-29T20:57:29.27049Z","end":"2026-06-29T20:57:29.908566Z","steps":["trace[1845996072] 'agreement among raft nodes before linearized reading' (duration: 637.867595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:29.908639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:29.27048Z","time spent":"638.151353ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-29T20:57:29.908647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.107133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-29T20:57:29.908771Z","caller":"traceutil/trace.go:171","msg":"trace[1996179623] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"649.271237ms","start":"2026-06-29T20:57:29.259467Z","end":"2026-06-29T20:57:29.908738Z","steps":["trace[1996179623] 'agreement among raft nodes before linearized reading' (duration: 648.853677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T20:57:29.908826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:57:29.259447Z","time spent":"649.369259ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-29T20:57:42.981774Z","caller":"traceutil/trace.go:171","msg":"trace[1768466684] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"105.35413ms","start":"2026-06-29T20:57:42.87639Z","end":"2026-06-29T20:57:42.981745Z","steps":["trace[1768466684] 'process raft request' (duration: 105.119004ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:57:46.222109Z","caller":"traceutil/trace.go:171","msg":"trace[741247999] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"143.921052ms","start":"2026-06-29T20:57:46.078164Z","end":"2026-06-29T20:57:46.222085Z","steps":["trace[741247999] 'read index received' (duration: 101.317861ms)","trace[741247999] 'applied index is now lower than readState.Index' (duration: 42.602341ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T20:57:46.222138Z","caller":"traceutil/trace.go:171","msg":"trace[1570706668] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"236.20681ms","start":"2026-06-29T20:57:45.985905Z","end":"2026-06-29T20:57:46.222111Z","steps":["trace[1570706668] 'process raft request' (duration: 193.505997ms)","trace[1570706668] 'compare' (duration: 42.57346ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T20:57:46.222391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.209709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-29T20:57:46.222452Z","caller":"traceutil/trace.go:171","msg":"trace[1071182039] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:803; }","duration":"144.326972ms","start":"2026-06-29T20:57:46.07811Z","end":"2026-06-29T20:57:46.222437Z","steps":["trace[1071182039] 'agreement among raft nodes before linearized reading' (duration: 144.107957ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:58:19.079324Z","caller":"traceutil/trace.go:171","msg":"trace[1457932790] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"165.279009ms","start":"2026-06-29T20:58:18.914Z","end":"2026-06-29T20:58:19.079279Z","steps":["trace[1457932790] 'process raft request' (duration: 136.597308ms)","trace[1457932790] 'compare' (duration: 28.073789ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T20:59:05.784859Z","caller":"traceutil/trace.go:171","msg":"trace[1620747466] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"320.86254ms","start":"2026-06-29T20:59:05.463961Z","end":"2026-06-29T20:59:05.784823Z","steps":["trace[1620747466] 'process raft request' (duration: 227.107301ms)","trace[1620747466] 'compare' (duration: 93.617567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T20:59:05.785127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T20:59:05.463949Z","time spent":"321.048984ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-29T20:59:06.225331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.059367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e958cd2b-d015-4fce-9c69-c0f331df56e4\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-29T20:59:06.225403Z","caller":"traceutil/trace.go:171","msg":"trace[1156169227] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e958cd2b-d015-4fce-9c69-c0f331df56e4; range_end:; response_count:1; response_revision:1888; }","duration":"137.182409ms","start":"2026-06-29T20:59:06.088207Z","end":"2026-06-29T20:59:06.225389Z","steps":["trace[1156169227] 'range keys from in-memory index tree' (duration: 136.897574ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:59:18.787953Z","caller":"traceutil/trace.go:171","msg":"trace[41781185] linearizableReadLoop","detail":"{readStateIndex:2066; appliedIndex:2065; }","duration":"104.306161ms","start":"2026-06-29T20:59:18.683632Z","end":"2026-06-29T20:59:18.787939Z","steps":["trace[41781185] 'read index received' (duration: 104.242691ms)","trace[41781185] 'applied index is now lower than readState.Index' (duration: 62.92µs)"],"step_count":2} {"level":"warn","ts":"2026-06-29T20:59:18.788131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.486744ms","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-29T20:59:18.788151Z","caller":"traceutil/trace.go:171","msg":"trace[1223405262] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1990; }","duration":"104.558975ms","start":"2026-06-29T20:59:18.683586Z","end":"2026-06-29T20:59:18.788145Z","steps":["trace[1223405262] 'agreement among raft nodes before linearized reading' (duration: 104.450934ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:59:18.788353Z","caller":"traceutil/trace.go:171","msg":"trace[1316603076] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"115.119215ms","start":"2026-06-29T20:59:18.673227Z","end":"2026-06-29T20:59:18.788346Z","steps":["trace[1316603076] 'process raft request' (duration: 114.607718ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:59:45.057798Z","caller":"traceutil/trace.go:171","msg":"trace[164388795] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"121.899152ms","start":"2026-06-29T20:59:44.935875Z","end":"2026-06-29T20:59:45.057774Z","steps":["trace[164388795] 'process raft request' (duration: 80.831998ms)","trace[164388795] 'compare' (duration: 40.979963ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T20:59:56.161909Z","caller":"traceutil/trace.go:171","msg":"trace[592239073] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"123.590057ms","start":"2026-06-29T20:59:56.038294Z","end":"2026-06-29T20:59:56.161884Z","steps":["trace[592239073] 'process raft request' (duration: 123.432573ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T20:59:56.273378Z","caller":"traceutil/trace.go:171","msg":"trace[1517866187] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"103.055314ms","start":"2026-06-29T20:59:56.170302Z","end":"2026-06-29T20:59:56.273357Z","steps":["trace[1517866187] 'process raft request' (duration: 102.936172ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:00:38.269408Z","caller":"traceutil/trace.go:171","msg":"trace[630034349] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"118.952215ms","start":"2026-06-29T21:00:38.150429Z","end":"2026-06-29T21:00:38.269382Z","steps":["trace[630034349] 'process raft request' (duration: 118.879543ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:00:38.269478Z","caller":"traceutil/trace.go:171","msg":"trace[950325381] transaction","detail":"{read_only:false; response_revision:2512; number_of_response:1; }","duration":"141.905706ms","start":"2026-06-29T21:00:38.127517Z","end":"2026-06-29T21:00:38.269423Z","steps":["trace[950325381] 'process raft request' (duration: 46.822678ms)","trace[950325381] 'compare' (duration: 94.771703ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:00:38.271221Z","caller":"traceutil/trace.go:171","msg":"trace[1412408110] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"111.372577ms","start":"2026-06-29T21:00:38.159833Z","end":"2026-06-29T21:00:38.271206Z","steps":["trace[1412408110] 'process raft request' (duration: 111.232795ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:00:38.271216Z","caller":"traceutil/trace.go:171","msg":"trace[1023115131] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"111.395498ms","start":"2026-06-29T21:00:38.159787Z","end":"2026-06-29T21:00:38.271182Z","steps":["trace[1023115131] 'process raft request' (duration: 111.213195ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:01:21.991748Z","caller":"traceutil/trace.go:171","msg":"trace[7561680] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"145.39926ms","start":"2026-06-29T21:01:21.846319Z","end":"2026-06-29T21:01:21.991719Z","steps":["trace[7561680] 'process raft request' (duration: 73.960844ms)","trace[7561680] 'compare' (duration: 71.318164ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:03:47.655363Z","caller":"traceutil/trace.go:171","msg":"trace[934125339] transaction","detail":"{read_only:false; response_revision:3835; number_of_response:1; }","duration":"212.153947ms","start":"2026-06-29T21:03:47.443184Z","end":"2026-06-29T21:03:47.655338Z","steps":["trace[934125339] 'process raft request' (duration: 212.011624ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:08.766325Z","caller":"traceutil/trace.go:171","msg":"trace[2100918739] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"107.918962ms","start":"2026-06-29T21:05:08.658382Z","end":"2026-06-29T21:05:08.766301Z","steps":["trace[2100918739] 'process raft request' (duration: 107.763809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:05:13.854791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.050142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-29T21:05:13.854881Z","caller":"traceutil/trace.go:171","msg":"trace[273756238] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"213.992584ms","start":"2026-06-29T21:05:13.640875Z","end":"2026-06-29T21:05:13.854867Z","steps":["trace[273756238] 'process raft request' (duration: 73.811039ms)","trace[273756238] 'compare' (duration: 139.93175ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:05:13.883791Z","caller":"traceutil/trace.go:171","msg":"trace[1904492226] linearizableReadLoop","detail":"{readStateIndex:5214; appliedIndex:5212; }","duration":"205.052039ms","start":"2026-06-29T21:05:13.67872Z","end":"2026-06-29T21:05:13.883772Z","steps":["trace[1904492226] 'read index received' (duration: 36.22853ms)","trace[1904492226] 'applied index is now lower than readState.Index' (duration: 168.822699ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T21:05:13.883957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.229353ms","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-29T21:05:13.883984Z","caller":"traceutil/trace.go:171","msg":"trace[1175145861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5026; }","duration":"205.312304ms","start":"2026-06-29T21:05:13.678665Z","end":"2026-06-29T21:05:13.883977Z","steps":["trace[1175145861] 'agreement among raft nodes before linearized reading' (duration: 205.180861ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:13.884223Z","caller":"traceutil/trace.go:171","msg":"trace[766870497] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"215.675871ms","start":"2026-06-29T21:05:13.66851Z","end":"2026-06-29T21:05:13.884186Z","steps":["trace[766870497] 'process raft request' (duration: 215.148849ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:16.164418Z","caller":"traceutil/trace.go:171","msg":"trace[232245806] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"143.440997ms","start":"2026-06-29T21:05:16.020951Z","end":"2026-06-29T21:05:16.164392Z","steps":["trace[232245806] 'process raft request' (duration: 143.233992ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:16.206257Z","caller":"traceutil/trace.go:171","msg":"trace[509119514] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"173.475931ms","start":"2026-06-29T21:05:16.032755Z","end":"2026-06-29T21:05:16.206231Z","steps":["trace[509119514] 'process raft request' (duration: 173.257827ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:16.206536Z","caller":"traceutil/trace.go:171","msg":"trace[1436343339] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"125.529537ms","start":"2026-06-29T21:05:16.080985Z","end":"2026-06-29T21:05:16.206515Z","steps":["trace[1436343339] 'process raft request' (duration: 125.191959ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:16.206645Z","caller":"traceutil/trace.go:171","msg":"trace[1838816754] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"125.525476ms","start":"2026-06-29T21:05:16.081094Z","end":"2026-06-29T21:05:16.206619Z","steps":["trace[1838816754] 'process raft request' (duration: 125.352112ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:16.20664Z","caller":"traceutil/trace.go:171","msg":"trace[1540096360] linearizableReadLoop","detail":"{readStateIndex:5268; appliedIndex:5266; }","duration":"132.774033ms","start":"2026-06-29T21:05:16.073815Z","end":"2026-06-29T21:05:16.206589Z","steps":["trace[1540096360] 'read index received' (duration: 90.42736ms)","trace[1540096360] 'applied index is now lower than readState.Index' (duration: 42.345523ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T21:05:16.206807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.980498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-29T21:05:16.206874Z","caller":"traceutil/trace.go:171","msg":"trace[69582849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5079; }","duration":"133.097561ms","start":"2026-06-29T21:05:16.07376Z","end":"2026-06-29T21:05:16.206858Z","steps":["trace[69582849] 'agreement among raft nodes before linearized reading' (duration: 132.964708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:05:16.206981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.040037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-29T21:05:16.207054Z","caller":"traceutil/trace.go:171","msg":"trace[1217961542] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5079; }","duration":"115.16467ms","start":"2026-06-29T21:05:16.091872Z","end":"2026-06-29T21:05:16.207037Z","steps":["trace[1217961542] 'agreement among raft nodes before linearized reading' (duration: 114.954005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:05:16.207175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.733457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-29T21:05:16.207216Z","caller":"traceutil/trace.go:171","msg":"trace[99243291] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:5079; }","duration":"101.8317ms","start":"2026-06-29T21:05:16.105374Z","end":"2026-06-29T21:05:16.207206Z","steps":["trace[99243291] 'agreement among raft nodes before linearized reading' (duration: 101.751598ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:16.322118Z","caller":"traceutil/trace.go:171","msg":"trace[324825731] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"109.686701ms","start":"2026-06-29T21:05:16.212397Z","end":"2026-06-29T21:05:16.322084Z","steps":["trace[324825731] 'process raft request' (duration: 109.490706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:05:26.103506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.372715ms","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-29T21:05:26.103588Z","caller":"traceutil/trace.go:171","msg":"trace[1164257476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5246; }","duration":"149.508029ms","start":"2026-06-29T21:05:25.954062Z","end":"2026-06-29T21:05:26.103571Z","steps":["trace[1164257476] 'range keys from in-memory index tree' (duration: 149.196131ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:35.343815Z","caller":"traceutil/trace.go:171","msg":"trace[1577741682] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"202.796731ms","start":"2026-06-29T21:05:35.140991Z","end":"2026-06-29T21:05:35.343787Z","steps":["trace[1577741682] 'process raft request' (duration: 202.617277ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:05:37.435307Z","caller":"traceutil/trace.go:171","msg":"trace[1128042352] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"188.648491ms","start":"2026-06-29T21:05:37.246638Z","end":"2026-06-29T21:05:37.435286Z","steps":["trace[1128042352] 'process raft request' (duration: 188.494768ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:06:45.929536Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000} {"level":"info","ts":"2026-06-29T21:06:45.998217Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"67.343249ms","hash":3529397634,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":34082816,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-29T21:06:45.998274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3529397634,"revision":3000,"compact-revision":-1} {"level":"info","ts":"2026-06-29T21:11:45.937196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6110} {"level":"info","ts":"2026-06-29T21:11:46.030532Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6110,"took":"91.52072ms","hash":4240449663,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":23576576,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-29T21:11:46.030605Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4240449663,"revision":6110,"compact-revision":3000} {"level":"info","ts":"2026-06-29T21:11:49.519956Z","caller":"traceutil/trace.go:171","msg":"trace[1438866193] transaction","detail":"{read_only:false; response_revision:8326; number_of_response:1; }","duration":"122.395762ms","start":"2026-06-29T21:11:49.397541Z","end":"2026-06-29T21:11:49.519937Z","steps":["trace[1438866193] 'process raft request' (duration: 122.28204ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:11:49.705123Z","caller":"traceutil/trace.go:171","msg":"trace[1442168639] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"216.221233ms","start":"2026-06-29T21:11:49.488868Z","end":"2026-06-29T21:11:49.70509Z","steps":["trace[1442168639] 'process raft request' (duration: 204.46528ms)","trace[1442168639] 'compare' (duration: 11.328863ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:11:49.705365Z","caller":"traceutil/trace.go:171","msg":"trace[95049943] linearizableReadLoop","detail":"{readStateIndex:8621; appliedIndex:8618; }","duration":"101.727708ms","start":"2026-06-29T21:11:49.603607Z","end":"2026-06-29T21:11:49.705335Z","steps":["trace[95049943] 'read index received' (duration: 89.73854ms)","trace[95049943] 'applied index is now lower than readState.Index' (duration: 11.987888ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:11:49.705525Z","caller":"traceutil/trace.go:171","msg":"trace[2016480176] transaction","detail":"{read_only:false; response_revision:8328; number_of_response:1; }","duration":"133.062001ms","start":"2026-06-29T21:11:49.572432Z","end":"2026-06-29T21:11:49.705494Z","steps":["trace[2016480176] 'process raft request' (duration: 132.626432ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:11:49.705547Z","caller":"traceutil/trace.go:171","msg":"trace[501664819] transaction","detail":"{read_only:false; response_revision:8329; number_of_response:1; }","duration":"130.833621ms","start":"2026-06-29T21:11:49.574691Z","end":"2026-06-29T21:11:49.705524Z","steps":["trace[501664819] 'process raft request' (duration: 130.541125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:11:49.705628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.987453ms","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-06-29T21:11:49.705686Z","caller":"traceutil/trace.go:171","msg":"trace[963374362] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8329; }","duration":"102.102416ms","start":"2026-06-29T21:11:49.603566Z","end":"2026-06-29T21:11:49.705669Z","steps":["trace[963374362] 'agreement among raft nodes before linearized reading' (duration: 101.943353ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:02.032959Z","caller":"traceutil/trace.go:171","msg":"trace[941267600] linearizableReadLoop","detail":"{readStateIndex:8684; appliedIndex:8683; }","duration":"272.001583ms","start":"2026-06-29T21:12:01.760929Z","end":"2026-06-29T21:12:02.03293Z","steps":["trace[941267600] 'read index received' (duration: 227.660691ms)","trace[941267600] 'applied index is now lower than readState.Index' (duration: 44.339582ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:12:02.033045Z","caller":"traceutil/trace.go:171","msg":"trace[471007577] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"277.940756ms","start":"2026-06-29T21:12:01.755069Z","end":"2026-06-29T21:12:02.03301Z","steps":["trace[471007577] 'process raft request' (duration: 233.43725ms)","trace[471007577] 'compare' (duration: 44.194689ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T21:12:02.033177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.231348ms","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-06-29T21:12:02.03324Z","caller":"traceutil/trace.go:171","msg":"trace[1612996385] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8390; }","duration":"272.3298ms","start":"2026-06-29T21:12:01.760898Z","end":"2026-06-29T21:12:02.033228Z","steps":["trace[1612996385] 'agreement among raft nodes before linearized reading' (duration: 272.232707ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:02.069416Z","caller":"traceutil/trace.go:171","msg":"trace[941840507] transaction","detail":"{read_only:false; response_revision:8392; number_of_response:1; }","duration":"307.437215ms","start":"2026-06-29T21:12:01.761902Z","end":"2026-06-29T21:12:02.069339Z","steps":["trace[941840507] 'process raft request' (duration: 307.347783ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:02.069446Z","caller":"traceutil/trace.go:171","msg":"trace[1363967801] transaction","detail":"{read_only:false; response_revision:8391; number_of_response:1; }","duration":"307.565498ms","start":"2026-06-29T21:12:01.761848Z","end":"2026-06-29T21:12:02.069414Z","steps":["trace[1363967801] 'process raft request' (duration: 307.273842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:12:02.069572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T21:12:01.761883Z","time spent":"307.60669ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-29T21:12:02.069596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T21:12:01.761823Z","time spent":"307.690341ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-29T21:12:02.080445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.215121ms","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:5"} {"level":"info","ts":"2026-06-29T21:12:02.080508Z","caller":"traceutil/trace.go:171","msg":"trace[966655633] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:8393; }","duration":"190.287782ms","start":"2026-06-29T21:12:01.890206Z","end":"2026-06-29T21:12:02.080494Z","steps":["trace[966655633] 'agreement among raft nodes before linearized reading' (duration: 190.1688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:12:02.080634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.948002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-29T21:12:02.080672Z","caller":"traceutil/trace.go:171","msg":"trace[1937026080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8393; }","duration":"235.013433ms","start":"2026-06-29T21:12:01.845649Z","end":"2026-06-29T21:12:02.080663Z","steps":["trace[1937026080] 'agreement among raft nodes before linearized reading' (duration: 234.959652ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:02.887324Z","caller":"traceutil/trace.go:171","msg":"trace[25518983] transaction","detail":"{read_only:false; response_revision:8397; number_of_response:1; }","duration":"175.032751ms","start":"2026-06-29T21:12:02.712262Z","end":"2026-06-29T21:12:02.887295Z","steps":["trace[25518983] 'process raft request' (duration: 174.713024ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:28.265632Z","caller":"traceutil/trace.go:171","msg":"trace[1544690072] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"120.62244ms","start":"2026-06-29T21:12:28.144985Z","end":"2026-06-29T21:12:28.265608Z","steps":["trace[1544690072] 'process raft request' (duration: 117.056531ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:28.26582Z","caller":"traceutil/trace.go:171","msg":"trace[712885793] transaction","detail":"{read_only:false; response_revision:8585; number_of_response:1; }","duration":"119.588668ms","start":"2026-06-29T21:12:28.146223Z","end":"2026-06-29T21:12:28.265812Z","steps":["trace[712885793] 'process raft request' (duration: 119.102577ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:28.266172Z","caller":"traceutil/trace.go:171","msg":"trace[1026312028] transaction","detail":"{read_only:false; response_revision:8586; number_of_response:1; }","duration":"106.52044ms","start":"2026-06-29T21:12:28.159643Z","end":"2026-06-29T21:12:28.266164Z","steps":["trace[1026312028] 'process raft request' (duration: 105.726053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:12:30.093616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.353179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-29T21:12:30.093696Z","caller":"traceutil/trace.go:171","msg":"trace[1618043670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8593; }","duration":"249.477142ms","start":"2026-06-29T21:12:29.844201Z","end":"2026-06-29T21:12:30.093678Z","steps":["trace[1618043670] 'range keys from in-memory index tree' (duration: 249.269307ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:30.094004Z","caller":"traceutil/trace.go:171","msg":"trace[2105610698] transaction","detail":"{read_only:false; response_revision:8594; number_of_response:1; }","duration":"146.561119ms","start":"2026-06-29T21:12:29.947431Z","end":"2026-06-29T21:12:30.093992Z","steps":["trace[2105610698] 'process raft request' (duration: 145.134218ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:30.243917Z","caller":"traceutil/trace.go:171","msg":"trace[1392000630] transaction","detail":"{read_only:false; response_revision:8595; number_of_response:1; }","duration":"111.552661ms","start":"2026-06-29T21:12:30.132331Z","end":"2026-06-29T21:12:30.243884Z","steps":["trace[1392000630] 'process raft request' (duration: 93.898834ms)","trace[1392000630] 'compare' (duration: 17.503754ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:12:42.756362Z","caller":"traceutil/trace.go:171","msg":"trace[973688450] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"130.558648ms","start":"2026-06-29T21:12:42.625774Z","end":"2026-06-29T21:12:42.756333Z","steps":["trace[973688450] 'process raft request' (duration: 130.375924ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:42.814639Z","caller":"traceutil/trace.go:171","msg":"trace[95320470] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"185.152779ms","start":"2026-06-29T21:12:42.629462Z","end":"2026-06-29T21:12:42.814615Z","steps":["trace[95320470] 'process raft request' (duration: 185.023486ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:42.81474Z","caller":"traceutil/trace.go:171","msg":"trace[2040623592] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"188.518032ms","start":"2026-06-29T21:12:42.626192Z","end":"2026-06-29T21:12:42.81471Z","steps":["trace[2040623592] 'process raft request' (duration: 188.124943ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:43.704992Z","caller":"traceutil/trace.go:171","msg":"trace[2081519286] linearizableReadLoop","detail":"{readStateIndex:9017; appliedIndex:9016; }","duration":"148.141175ms","start":"2026-06-29T21:12:43.556823Z","end":"2026-06-29T21:12:43.704964Z","steps":["trace[2081519286] 'read index received' (duration: 148.001152ms)","trace[2081519286] 'applied index is now lower than readState.Index' (duration: 138.863µs)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:12:43.705035Z","caller":"traceutil/trace.go:171","msg":"trace[228952783] transaction","detail":"{read_only:false; response_revision:8710; number_of_response:1; }","duration":"193.762967ms","start":"2026-06-29T21:12:43.51124Z","end":"2026-06-29T21:12:43.705003Z","steps":["trace[228952783] 'process raft request' (duration: 193.516631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:12:43.705235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.39532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-tcrb6\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-06-29T21:12:43.705278Z","caller":"traceutil/trace.go:171","msg":"trace[21195212] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-tcrb6; range_end:; response_count:1; response_revision:8710; }","duration":"148.499633ms","start":"2026-06-29T21:12:43.556769Z","end":"2026-06-29T21:12:43.705268Z","steps":["trace[21195212] 'agreement among raft nodes before linearized reading' (duration: 148.304048ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:43.75419Z","caller":"traceutil/trace.go:171","msg":"trace[811766166] transaction","detail":"{read_only:false; response_revision:8711; number_of_response:1; }","duration":"197.114852ms","start":"2026-06-29T21:12:43.557051Z","end":"2026-06-29T21:12:43.754166Z","steps":["trace[811766166] 'process raft request' (duration: 196.460216ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:12:57.105262Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023b7.wal"} {"level":"warn","ts":"2026-06-29T21:13:59.073745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.399535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-29T21:13:59.073842Z","caller":"traceutil/trace.go:171","msg":"trace[1551134490] range","detail":"{range_begin:/registry/masterleases/199.19.213.157; range_end:; response_count:1; response_revision:9453; }","duration":"168.554719ms","start":"2026-06-29T21:13:58.905268Z","end":"2026-06-29T21:13:59.073823Z","steps":["trace[1551134490] 'range keys from in-memory index tree' (duration: 168.1676ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:14:28.749607Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"10058a425931b8de","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-29T21:14:28.758802Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-29T21:14:28.75894Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-29T21:16:45.945814Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8304} {"level":"info","ts":"2026-06-29T21:16:46.021809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8304,"took":"73.233705ms","hash":1721979425,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":25133056,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-29T21:16:46.021889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1721979425,"revision":8304,"compact-revision":6110} {"level":"warn","ts":"2026-06-29T21:19:36.840227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.805383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-29T21:19:36.840318Z","caller":"traceutil/trace.go:171","msg":"trace[2027695841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11882; }","duration":"100.944665ms","start":"2026-06-29T21:19:36.739361Z","end":"2026-06-29T21:19:36.840306Z","steps":["trace[2027695841] 'range keys from in-memory index tree' (duration: 100.637169ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:19:37.240459Z","caller":"traceutil/trace.go:171","msg":"trace[1527210664] transaction","detail":"{read_only:false; response_revision:11885; number_of_response:1; }","duration":"158.532612ms","start":"2026-06-29T21:19:37.081896Z","end":"2026-06-29T21:19:37.240428Z","steps":["trace[1527210664] 'process raft request' (duration: 158.294077ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:21:45.952479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10531} {"level":"info","ts":"2026-06-29T21:21:46.027166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10531,"took":"72.767082ms","hash":680130665,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":26247168,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-29T21:21:46.027222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":680130665,"revision":10531,"compact-revision":8304} {"level":"info","ts":"2026-06-29T21:26:21.6922Z","caller":"traceutil/trace.go:171","msg":"trace[2118522119] transaction","detail":"{read_only:false; response_revision:14578; number_of_response:1; }","duration":"422.337664ms","start":"2026-06-29T21:26:21.26982Z","end":"2026-06-29T21:26:21.692157Z","steps":["trace[2118522119] 'process raft request' (duration: 422.202911ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:26:21.692208Z","caller":"traceutil/trace.go:171","msg":"trace[982859408] transaction","detail":"{read_only:false; response_revision:14579; number_of_response:1; }","duration":"421.463416ms","start":"2026-06-29T21:26:21.270708Z","end":"2026-06-29T21:26:21.692171Z","steps":["trace[982859408] 'process raft request' (duration: 421.363453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:26:21.692405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T21:26:21.269782Z","time spent":"422.517178ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-29T21:26:21.692383Z","caller":"traceutil/trace.go:171","msg":"trace[477647363] transaction","detail":"{read_only:false; response_revision:14580; number_of_response:1; }","duration":"410.465167ms","start":"2026-06-29T21:26:21.281881Z","end":"2026-06-29T21:26:21.692347Z","steps":["trace[477647363] 'process raft request' (duration: 410.231692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:26:21.692426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T21:26:21.270676Z","time spent":"421.63479ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-29T21:26:21.692202Z","caller":"traceutil/trace.go:171","msg":"trace[2123130467] transaction","detail":"{read_only:false; response_revision:14577; number_of_response:1; }","duration":"422.328744ms","start":"2026-06-29T21:26:21.26982Z","end":"2026-06-29T21:26:21.692148Z","steps":["trace[2123130467] 'process raft request' (duration: 422.001547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:26:21.692768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T21:26:21.281857Z","time spent":"410.611561ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-29T21:26:21.692808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-29T21:26:21.26978Z","time spent":"422.967289ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-29T21:26:31.390568Z","caller":"traceutil/trace.go:171","msg":"trace[992265023] transaction","detail":"{read_only:false; response_revision:14747; number_of_response:1; }","duration":"221.030536ms","start":"2026-06-29T21:26:31.169514Z","end":"2026-06-29T21:26:31.390545Z","steps":["trace[992265023] 'process raft request' (duration: 220.715699ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:26:45.95869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12754} {"level":"info","ts":"2026-06-29T21:26:46.033474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12754,"took":"72.520043ms","hash":3181324077,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":29483008,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-29T21:26:46.033553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3181324077,"revision":12754,"compact-revision":10531} {"level":"info","ts":"2026-06-29T21:28:10.265758Z","caller":"traceutil/trace.go:171","msg":"trace[1526690609] transaction","detail":"{read_only:false; response_revision:15832; number_of_response:1; }","duration":"106.634854ms","start":"2026-06-29T21:28:10.159099Z","end":"2026-06-29T21:28:10.265734Z","steps":["trace[1526690609] 'process raft request' (duration: 106.596843ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:28:10.26577Z","caller":"traceutil/trace.go:171","msg":"trace[1170378722] transaction","detail":"{read_only:false; response_revision:15831; number_of_response:1; }","duration":"138.18536ms","start":"2026-06-29T21:28:10.127551Z","end":"2026-06-29T21:28:10.265737Z","steps":["trace[1170378722] 'process raft request' (duration: 39.945658ms)","trace[1170378722] 'compare' (duration: 98.070778ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:28:10.26579Z","caller":"traceutil/trace.go:171","msg":"trace[474788509] linearizableReadLoop","detail":"{readStateIndex:16374; appliedIndex:16373; }","duration":"130.817189ms","start":"2026-06-29T21:28:10.134935Z","end":"2026-06-29T21:28:10.265752Z","steps":["trace[474788509] 'read index received' (duration: 32.576038ms)","trace[474788509] 'applied index is now lower than readState.Index' (duration: 98.236801ms)"],"step_count":2} {"level":"warn","ts":"2026-06-29T21:28:10.266875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.914413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-29T21:28:10.266934Z","caller":"traceutil/trace.go:171","msg":"trace[2070901090] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:15832; }","duration":"132.016304ms","start":"2026-06-29T21:28:10.134901Z","end":"2026-06-29T21:28:10.266917Z","steps":["trace[2070901090] 'agreement among raft nodes before linearized reading' (duration: 131.002963ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:28:10.944528Z","caller":"traceutil/trace.go:171","msg":"trace[389849594] transaction","detail":"{read_only:false; response_revision:15834; number_of_response:1; }","duration":"108.185069ms","start":"2026-06-29T21:28:10.836315Z","end":"2026-06-29T21:28:10.9445Z","steps":["trace[389849594] 'process raft request' (duration: 108.009085ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:31:45.964943Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15032} {"level":"info","ts":"2026-06-29T21:31:46.060119Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15032,"took":"92.22415ms","hash":3662179697,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":30752768,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-29T21:31:46.06019Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3662179697,"revision":15032,"compact-revision":12754} {"level":"info","ts":"2026-06-29T21:33:55.805381Z","caller":"traceutil/trace.go:171","msg":"trace[239046302] transaction","detail":"{read_only:false; response_revision:18377; number_of_response:1; }","duration":"153.616301ms","start":"2026-06-29T21:33:55.651739Z","end":"2026-06-29T21:33:55.805355Z","steps":["trace[239046302] 'process raft request' (duration: 153.438227ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:33:56.180466Z","caller":"traceutil/trace.go:171","msg":"trace[777308591] transaction","detail":"{read_only:false; response_revision:18378; number_of_response:1; }","duration":"227.896693ms","start":"2026-06-29T21:33:55.95251Z","end":"2026-06-29T21:33:56.180406Z","steps":["trace[777308591] 'process raft request' (duration: 227.651698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-29T21:33:56.550358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.039894ms","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-29T21:33:56.55052Z","caller":"traceutil/trace.go:171","msg":"trace[1815934222] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:18378; }","duration":"227.215898ms","start":"2026-06-29T21:33:56.32328Z","end":"2026-06-29T21:33:56.550496Z","steps":["trace[1815934222] 'range keys from in-memory index tree' (duration: 227.016304ms)"],"step_count":1} {"level":"info","ts":"2026-06-29T21:33:56.550983Z","caller":"traceutil/trace.go:171","msg":"trace[1037368877] transaction","detail":"{read_only:false; response_revision:18379; number_of_response:1; }","duration":"182.160692ms","start":"2026-06-29T21:33:56.368787Z","end":"2026-06-29T21:33:56.550948Z","steps":["trace[1037368877] 'process raft request' (duration: 152.242692ms)","trace[1037368877] 'compare' (duration: 28.849666ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:33:56.700299Z","caller":"traceutil/trace.go:171","msg":"trace[1074067332] transaction","detail":"{read_only:false; response_revision:18380; number_of_response:1; }","duration":"140.63641ms","start":"2026-06-29T21:33:56.559619Z","end":"2026-06-29T21:33:56.700255Z","steps":["trace[1074067332] 'process raft request' (duration: 111.249112ms)","trace[1074067332] 'compare' (duration: 29.121632ms)"],"step_count":2} {"level":"info","ts":"2026-06-29T21:36:41.801444Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"10058a425931b8de","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-29T21:36:41.806973Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-29T21:36:41.807073Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-29T21:36:45.972796Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17474} {"level":"info","ts":"2026-06-29T21:36:46.067997Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17474,"took":"92.23096ms","hash":1114105076,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":29872128,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-29T21:36:46.068082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1114105076,"revision":17474,"compact-revision":15032} {"level":"info","ts":"2026-06-29T21:41:45.979816Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19357} {"level":"info","ts":"2026-06-29T21:41:46.067001Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19357,"took":"84.14835ms","hash":878335691,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":24174592,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-29T21:41:46.067054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":878335691,"revision":19357,"compact-revision":17474}