{"level":"warn","ts":"2026-06-15T11:43:01.439843Z","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-15T11:43:01.439946Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.27: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.27:2380","--initial-cluster=instance=https://199.19.213.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.27: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-15T11:43:01.440021Z","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-15T11:43:01.440031Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-06-15T11:43:01.440053Z","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-15T11:43:01.440696Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"]} {"level":"info","ts":"2026-06-15T11:43:01.440774Z","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.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.27: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-15T11:43:01.443488Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.467293ms"} {"level":"info","ts":"2026-06-15T11:43:01.454373Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0494904b1be7692","cluster-id":"7c10a1b21fbd6dff"} {"level":"info","ts":"2026-06-15T11:43:01.454535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T11:43:01.454575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became follower at term 0"} {"level":"info","ts":"2026-06-15T11:43:01.454598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0494904b1be7692 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T11:43:01.454623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became follower at term 1"} {"level":"info","ts":"2026-06-15T11:43:01.454685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"warn","ts":"2026-06-15T11:43:01.459931Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T11:43:01.461854Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T11:43:01.463029Z","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-15T11:43:01.467996Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0494904b1be7692","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T11:43:01.471401Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0494904b1be7692","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T11:43:01.471794Z","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-15T11:43:01.471695Z","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-15T11:43:01.471929Z","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-15T11:43:01.472096Z","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-15T11:43:01.472704Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0494904b1be7692","initial-advertise-peer-urls":["https://199.19.213.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T11:43:01.472739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T11:43:01.473139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"info","ts":"2026-06-15T11:43:01.472184Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-06-15T11:43:01.47329Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-06-15T11:43:01.473355Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","added-peer-id":"d0494904b1be7692","added-peer-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-06-15T11:43:01.555211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T11:43:01.555283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T11:43:01.55532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 received MsgPreVoteResp from d0494904b1be7692 at term 1"} {"level":"info","ts":"2026-06-15T11:43:01.555338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became candidate at term 2"} {"level":"info","ts":"2026-06-15T11:43:01.555353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 received MsgVoteResp from d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-06-15T11:43:01.555365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0494904b1be7692 became leader at term 2"} {"level":"info","ts":"2026-06-15T11:43:01.555375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0494904b1be7692 elected leader d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-06-15T11:43:01.556494Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:43:01.557466Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T11:43:01.557522Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T11:43:01.557465Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0494904b1be7692","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.27:2379]}","request-path":"/0/members/d0494904b1be7692/attributes","cluster-id":"7c10a1b21fbd6dff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T11:43:01.557926Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T11:43:01.558028Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T11:43:01.560062Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T11:43:01.56026Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:43:01.560375Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:43:01.560409Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:43:01.560649Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.27:2379"} {"level":"info","ts":"2026-06-15T11:43:03.283004Z","caller":"traceutil/trace.go:171","msg":"trace[2143615310] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"103.83702ms","start":"2026-06-15T11:43:03.179097Z","end":"2026-06-15T11:43:03.282934Z","steps":["trace[2143615310] 'process raft request' (duration: 103.104961ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:43:21.823009Z","caller":"traceutil/trace.go:171","msg":"trace[532331927] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"114.599926ms","start":"2026-06-15T11:43:21.708371Z","end":"2026-06-15T11:43:21.82297Z","steps":["trace[532331927] 'process raft request' (duration: 114.404281ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:43:40.459818Z","caller":"traceutil/trace.go:171","msg":"trace[1306106896] transaction","detail":"{read_only:false; number_of_response:1; response_revision:585; }","duration":"102.173694ms","start":"2026-06-15T11:43:40.357615Z","end":"2026-06-15T11:43:40.459789Z","steps":["trace[1306106896] 'process raft request' (duration: 98.211063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:43:46.021584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.449229ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:43:46.021751Z","caller":"traceutil/trace.go:171","msg":"trace[1508895906] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"351.218318ms","start":"2026-06-15T11:43:45.67051Z","end":"2026-06-15T11:43:46.021728Z","steps":["trace[1508895906] 'process raft request' (duration: 33.872246ms)","trace[1508895906] 'compare' (duration: 316.218544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:43:46.02182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:45.670491Z","time spent":"351.297541ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:43:46.311383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.16458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:43:46.311578Z","caller":"traceutil/trace.go:171","msg":"trace[745963505] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"640.598992ms","start":"2026-06-15T11:43:45.670908Z","end":"2026-06-15T11:43:46.311507Z","steps":["trace[745963505] 'process raft request' (duration: 535.185666ms)","trace[745963505] 'compare' (duration: 104.890593ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:43:46.311774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:45.670897Z","time spent":"640.810068ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:43:46.409252Z","caller":"traceutil/trace.go:171","msg":"trace[1801670822] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"467.660206ms","start":"2026-06-15T11:43:45.94155Z","end":"2026-06-15T11:43:46.40921Z","steps":["trace[1801670822] 'read index received' (duration: 264.634832ms)","trace[1801670822] 'applied index is now lower than readState.Index' (duration: 203.024384ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:43:46.409423Z","caller":"traceutil/trace.go:171","msg":"trace[1209404354] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"587.4137ms","start":"2026-06-15T11:43:45.821963Z","end":"2026-06-15T11:43:46.409377Z","steps":["trace[1209404354] 'process raft request' (duration: 586.651761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:43:46.409615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:45.821921Z","time spent":"587.598485ms","remote":"127.0.0.1:33826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:43:46.409721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.127549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T11:43:46.409846Z","caller":"traceutil/trace.go:171","msg":"trace[1019994674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"468.319384ms","start":"2026-06-15T11:43:45.941496Z","end":"2026-06-15T11:43:46.409815Z","steps":["trace[1019994674] 'agreement among raft nodes before linearized reading' (duration: 467.917243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:43:46.409865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.028703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:43:46.40999Z","caller":"traceutil/trace.go:171","msg":"trace[638892902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"226.217938ms","start":"2026-06-15T11:43:46.183746Z","end":"2026-06-15T11:43:46.409963Z","steps":["trace[638892902] 'agreement among raft nodes before linearized reading' (duration: 225.977121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:43:46.409972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.820885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jpnqz\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-06-15T11:43:46.409909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:45.941469Z","time spent":"468.429286ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T11:43:46.410091Z","caller":"traceutil/trace.go:171","msg":"trace[2108283655] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jpnqz; range_end:; response_count:1; response_revision:639; }","duration":"307.96802ms","start":"2026-06-15T11:43:46.102097Z","end":"2026-06-15T11:43:46.410065Z","steps":["trace[2108283655] 'agreement among raft nodes before linearized reading' (duration: 307.60338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:43:46.41015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:46.102014Z","time spent":"308.126404ms","remote":"127.0.0.1:33916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-jpnqz\" "} {"level":"warn","ts":"2026-06-15T11:43:47.022914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.200866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:43:47.023188Z","caller":"traceutil/trace.go:171","msg":"trace[1489021574] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"550.264653ms","start":"2026-06-15T11:43:46.4729Z","end":"2026-06-15T11:43:47.023165Z","steps":["trace[1489021574] 'process raft request' (duration: 550.185731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:43:47.023314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:46.47287Z","time spent":"550.406237ms","remote":"127.0.0.1:34078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T11:43:47.023279Z","caller":"traceutil/trace.go:171","msg":"trace[1208656543] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"581.575195ms","start":"2026-06-15T11:43:46.44162Z","end":"2026-06-15T11:43:47.023195Z","steps":["trace[1208656543] 'process raft request' (duration: 335.912378ms)","trace[1208656543] 'compare' (duration: 244.9943ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:43:47.023537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:43:46.441584Z","time spent":"581.823111ms","remote":"127.0.0.1:33916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:44:30.365788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.430286ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T11:44:30.365933Z","caller":"traceutil/trace.go:171","msg":"trace[1214870261] linearizableReadLoop","detail":"{readStateIndex:1234; appliedIndex:1233; }","duration":"180.317005ms","start":"2026-06-15T11:44:30.185594Z","end":"2026-06-15T11:44:30.365911Z","steps":["trace[1214870261] 'read index received' (duration: 3.701214ms)","trace[1214870261] 'applied index is now lower than readState.Index' (duration: 176.614141ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:44:30.366084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.488279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:44:30.366111Z","caller":"traceutil/trace.go:171","msg":"trace[1680677171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"180.577581ms","start":"2026-06-15T11:44:30.185526Z","end":"2026-06-15T11:44:30.366103Z","steps":["trace[1680677171] 'agreement among raft nodes before linearized reading' (duration: 180.510779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:30.366292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.350032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T11:44:30.366398Z","caller":"traceutil/trace.go:171","msg":"trace[1687177161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1198; }","duration":"106.519637ms","start":"2026-06-15T11:44:30.259858Z","end":"2026-06-15T11:44:30.366378Z","steps":["trace[1687177161] 'agreement among raft nodes before linearized reading' (duration: 106.211199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:44:54.683404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.800276ms","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-15T11:44:54.683551Z","caller":"traceutil/trace.go:171","msg":"trace[1296563657] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1463; }","duration":"104.003602ms","start":"2026-06-15T11:44:54.579526Z","end":"2026-06-15T11:44:54.683529Z","steps":["trace[1296563657] 'range keys from in-memory index tree' (duration: 103.593202ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:18.56262Z","caller":"traceutil/trace.go:171","msg":"trace[1411897512] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"308.319821ms","start":"2026-06-15T11:45:18.254264Z","end":"2026-06-15T11:45:18.562584Z","steps":["trace[1411897512] 'process raft request' (duration: 308.105925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:45:18.562884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:45:18.254247Z","time spent":"308.520556ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:45:18.719571Z","caller":"traceutil/trace.go:171","msg":"trace[703646428] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"100.77749ms","start":"2026-06-15T11:45:18.618749Z","end":"2026-06-15T11:45:18.719526Z","steps":["trace[703646428] 'process raft request' (duration: 36.04175ms)","trace[703646428] 'compare' (duration: 64.558576ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:45:18.99883Z","caller":"traceutil/trace.go:171","msg":"trace[7692979] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"177.354973ms","start":"2026-06-15T11:45:18.821442Z","end":"2026-06-15T11:45:18.998797Z","steps":["trace[7692979] 'read index received' (duration: 177.106257ms)","trace[7692979] 'applied index is now lower than readState.Index' (duration: 247.626µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:45:18.998993Z","caller":"traceutil/trace.go:171","msg":"trace[429571326] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"376.927891ms","start":"2026-06-15T11:45:18.622053Z","end":"2026-06-15T11:45:18.998981Z","steps":["trace[429571326] 'process raft request' (duration: 376.548821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:45:18.999163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:45:18.622035Z","time spent":"376.995943ms","remote":"127.0.0.1:33916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:45:18.999333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.052717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T11:45:18.999371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.907727ms","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-15T11:45:18.999457Z","caller":"traceutil/trace.go:171","msg":"trace[190693258] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1882; }","duration":"154.236583ms","start":"2026-06-15T11:45:18.845175Z","end":"2026-06-15T11:45:18.999412Z","steps":["trace[190693258] 'agreement among raft nodes before linearized reading' (duration: 154.029817ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:18.999505Z","caller":"traceutil/trace.go:171","msg":"trace[867159887] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1882; }","duration":"178.081621ms","start":"2026-06-15T11:45:18.82137Z","end":"2026-06-15T11:45:18.999451Z","steps":["trace[867159887] 'agreement among raft nodes before linearized reading' (duration: 177.812364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:45:18.999633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.169167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-15T11:45:18.999745Z","caller":"traceutil/trace.go:171","msg":"trace[1425471975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1882; }","duration":"137.312961ms","start":"2026-06-15T11:45:18.862405Z","end":"2026-06-15T11:45:18.999718Z","steps":["trace[1425471975] 'agreement among raft nodes before linearized reading' (duration: 136.941882ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:45:35.603125Z","caller":"traceutil/trace.go:171","msg":"trace[1655860072] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"179.536128ms","start":"2026-06-15T11:45:35.423559Z","end":"2026-06-15T11:45:35.603095Z","steps":["trace[1655860072] 'process raft request' (duration: 179.333883ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:46:15.256905Z","caller":"traceutil/trace.go:171","msg":"trace[1594173802] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"235.802119ms","start":"2026-06-15T11:46:15.021051Z","end":"2026-06-15T11:46:15.256854Z","steps":["trace[1594173802] 'read index received' (duration: 235.614914ms)","trace[1594173802] 'applied index is now lower than readState.Index' (duration: 185.915µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:46:15.256992Z","caller":"traceutil/trace.go:171","msg":"trace[591008421] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"365.602868ms","start":"2026-06-15T11:46:14.891351Z","end":"2026-06-15T11:46:15.256954Z","steps":["trace[591008421] 'process raft request' (duration: 365.339761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:46:15.25725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:46:14.891323Z","time spent":"365.823983ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:46:15.257274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.158144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T11:46:15.257319Z","caller":"traceutil/trace.go:171","msg":"trace[1345965850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2234; }","duration":"113.285537ms","start":"2026-06-15T11:46:15.14402Z","end":"2026-06-15T11:46:15.257306Z","steps":["trace[1345965850] 'agreement among raft nodes before linearized reading' (duration: 113.090832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:46:15.257344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.27882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.27\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-15T11:46:15.257457Z","caller":"traceutil/trace.go:171","msg":"trace[24731095] range","detail":"{range_begin:/registry/masterleases/199.19.213.27; range_end:; response_count:1; response_revision:2234; }","duration":"236.451986ms","start":"2026-06-15T11:46:15.02098Z","end":"2026-06-15T11:46:15.257432Z","steps":["trace[24731095] 'agreement among raft nodes before linearized reading' (duration: 236.106387ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:46:58.220362Z","caller":"traceutil/trace.go:171","msg":"trace[755973103] transaction","detail":"{read_only:false; response_revision:2644; number_of_response:1; }","duration":"193.162562ms","start":"2026-06-15T11:46:58.027149Z","end":"2026-06-15T11:46:58.220312Z","steps":["trace[755973103] 'process raft request' (duration: 192.114356ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:46:58.220935Z","caller":"traceutil/trace.go:171","msg":"trace[1195024307] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"168.074781ms","start":"2026-06-15T11:46:58.052832Z","end":"2026-06-15T11:46:58.220907Z","steps":["trace[1195024307] 'process raft request' (duration: 167.669821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:47:32.009507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.814799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T11:47:32.009636Z","caller":"traceutil/trace.go:171","msg":"trace[579530145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2843; }","duration":"169.008494ms","start":"2026-06-15T11:47:31.840603Z","end":"2026-06-15T11:47:32.009611Z","steps":["trace[579530145] 'range keys from in-memory index tree' (duration: 168.559873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:47:32.009609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.037548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T11:47:32.009724Z","caller":"traceutil/trace.go:171","msg":"trace[678576811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2843; }","duration":"173.242252ms","start":"2026-06-15T11:47:31.836458Z","end":"2026-06-15T11:47:32.009701Z","steps":["trace[678576811] 'range keys from in-memory index tree' (duration: 172.637838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:47:32.009713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.890631ms","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-15T11:47:32.010118Z","caller":"traceutil/trace.go:171","msg":"trace[1486762569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2843; }","duration":"169.371693ms","start":"2026-06-15T11:47:31.840729Z","end":"2026-06-15T11:47:32.0101Z","steps":["trace[1486762569] 'range keys from in-memory index tree' (duration: 168.391339ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:47:32.175991Z","caller":"traceutil/trace.go:171","msg":"trace[1028265470] transaction","detail":"{read_only:false; response_revision:2844; number_of_response:1; }","duration":"161.898492ms","start":"2026-06-15T11:47:32.014053Z","end":"2026-06-15T11:47:32.175951Z","steps":["trace[1028265470] 'process raft request' (duration: 161.657946ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:47:32.273084Z","caller":"traceutil/trace.go:171","msg":"trace[1235786011] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"258.768021ms","start":"2026-06-15T11:47:32.014255Z","end":"2026-06-15T11:47:32.273023Z","steps":["trace[1235786011] 'process raft request' (duration: 258.548515ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:47:32.273386Z","caller":"traceutil/trace.go:171","msg":"trace[2019326935] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"257.773986ms","start":"2026-06-15T11:47:32.015572Z","end":"2026-06-15T11:47:32.273346Z","steps":["trace[2019326935] 'process raft request' (duration: 257.412937ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:47:32.273554Z","caller":"traceutil/trace.go:171","msg":"trace[1214937401] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"221.235301ms","start":"2026-06-15T11:47:32.05227Z","end":"2026-06-15T11:47:32.273505Z","steps":["trace[1214937401] 'process raft request' (duration: 221.000675ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:47:32.273676Z","caller":"traceutil/trace.go:171","msg":"trace[602535088] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"221.18547ms","start":"2026-06-15T11:47:32.052429Z","end":"2026-06-15T11:47:32.273615Z","steps":["trace[602535088] 'process raft request' (duration: 220.944064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:36.505522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.547886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T11:49:36.505624Z","caller":"traceutil/trace.go:171","msg":"trace[943114462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3635; }","duration":"102.67528ms","start":"2026-06-15T11:49:36.402929Z","end":"2026-06-15T11:49:36.505604Z","steps":["trace[943114462] 'agreement among raft nodes before linearized reading' (duration: 102.391272ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:40.035899Z","caller":"traceutil/trace.go:171","msg":"trace[750069941] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"102.7049ms","start":"2026-06-15T11:51:39.933173Z","end":"2026-06-15T11:51:40.035878Z","steps":["trace[750069941] 'process raft request' (duration: 102.502295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:41.020104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.442364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-06-15T11:51:41.020201Z","caller":"traceutil/trace.go:171","msg":"trace[1363536742] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:5070; }","duration":"102.618388ms","start":"2026-06-15T11:51:40.91756Z","end":"2026-06-15T11:51:41.020178Z","steps":["trace[1363536742] 'range keys from in-memory index tree' (duration: 102.229729ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:41.996347Z","caller":"traceutil/trace.go:171","msg":"trace[1332556053] linearizableReadLoop","detail":"{readStateIndex:5299; appliedIndex:5298; }","duration":"163.219994ms","start":"2026-06-15T11:51:41.833088Z","end":"2026-06-15T11:51:41.996308Z","steps":["trace[1332556053] 'read index received' (duration: 88.738723ms)","trace[1332556053] 'applied index is now lower than readState.Index' (duration: 74.479511ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:41.996374Z","caller":"traceutil/trace.go:171","msg":"trace[455174611] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"163.923542ms","start":"2026-06-15T11:51:41.832416Z","end":"2026-06-15T11:51:41.99634Z","steps":["trace[455174611] 'process raft request' (duration: 89.364909ms)","trace[455174611] 'compare' (duration: 74.378528ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:51:41.99663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.512231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-9pbxj\" ","response":"range_response_count:1 size:5851"} {"level":"info","ts":"2026-06-15T11:51:41.996721Z","caller":"traceutil/trace.go:171","msg":"trace[2018885693] range","detail":"{range_begin:/registry/pods/monitoring/vector-9pbxj; range_end:; response_count:1; response_revision:5104; }","duration":"163.679486ms","start":"2026-06-15T11:51:41.833024Z","end":"2026-06-15T11:51:41.996703Z","steps":["trace[2018885693] 'agreement among raft nodes before linearized reading' (duration: 163.399949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:41.997254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.290858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787065"} {"level":"info","ts":"2026-06-15T11:51:41.997313Z","caller":"traceutil/trace.go:171","msg":"trace[215298537] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5104; }","duration":"118.395781ms","start":"2026-06-15T11:51:41.878903Z","end":"2026-06-15T11:51:41.997299Z","steps":["trace[215298537] 'agreement among raft nodes before linearized reading' (duration: 117.620081ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:55.574415Z","caller":"traceutil/trace.go:171","msg":"trace[1797280760] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"106.705432ms","start":"2026-06-15T11:51:55.467677Z","end":"2026-06-15T11:51:55.574382Z","steps":["trace[1797280760] 'process raft request' (duration: 71.940465ms)","trace[1797280760] 'compare' (duration: 34.622443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:51:55.99249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.118978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T11:51:55.992591Z","caller":"traceutil/trace.go:171","msg":"trace[1778688722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5342; }","duration":"313.251072ms","start":"2026-06-15T11:51:55.679315Z","end":"2026-06-15T11:51:55.992566Z","steps":["trace[1778688722] 'range keys from in-memory index tree' (duration: 312.943624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:55.992639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:55.679305Z","time spent":"313.323853ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T11:51:55.993905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.311998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-15T11:51:55.993991Z","caller":"traceutil/trace.go:171","msg":"trace[584099817] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5342; }","duration":"265.461962ms","start":"2026-06-15T11:51:55.728511Z","end":"2026-06-15T11:51:55.993973Z","steps":["trace[584099817] 'range keys from in-memory index tree' (duration: 264.377715ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:03.727116Z","caller":"traceutil/trace.go:171","msg":"trace[1258905209] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"100.236257ms","start":"2026-06-15T11:52:03.626829Z","end":"2026-06-15T11:52:03.727065Z","steps":["trace[1258905209] 'process raft request' (duration: 85.81594ms)","trace[1258905209] 'compare' (duration: 14.189842ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:52:04.17415Z","caller":"traceutil/trace.go:171","msg":"trace[1640996600] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"102.164507ms","start":"2026-06-15T11:52:04.07194Z","end":"2026-06-15T11:52:04.174105Z","steps":["trace[1640996600] 'process raft request' (duration: 101.779547ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:04.261245Z","caller":"traceutil/trace.go:171","msg":"trace[2077772666] linearizableReadLoop","detail":"{readStateIndex:5727; appliedIndex:5725; }","duration":"185.279226ms","start":"2026-06-15T11:52:04.075926Z","end":"2026-06-15T11:52:04.261205Z","steps":["trace[2077772666] 'read index received' (duration: 97.929078ms)","trace[2077772666] 'applied index is now lower than readState.Index' (duration: 87.348628ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:52:04.261471Z","caller":"traceutil/trace.go:171","msg":"trace[1826508272] transaction","detail":"{read_only:false; response_revision:5519; number_of_response:1; }","duration":"187.887563ms","start":"2026-06-15T11:52:04.073547Z","end":"2026-06-15T11:52:04.261435Z","steps":["trace[1826508272] 'process raft request' (duration: 187.411271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:04.261569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.599565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1e54b2fe-b95e-451e-ade3-27658fe4e838\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-15T11:52:04.261622Z","caller":"traceutil/trace.go:171","msg":"trace[694250697] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1e54b2fe-b95e-451e-ade3-27658fe4e838; range_end:; response_count:1; response_revision:5519; }","duration":"185.718057ms","start":"2026-06-15T11:52:04.075885Z","end":"2026-06-15T11:52:04.261603Z","steps":["trace[694250697] 'agreement among raft nodes before linearized reading' (duration: 185.464961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:06.284139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.325333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-15T11:52:06.284258Z","caller":"traceutil/trace.go:171","msg":"trace[1605059669] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5540; }","duration":"106.510147ms","start":"2026-06-15T11:52:06.177722Z","end":"2026-06-15T11:52:06.284232Z","steps":["trace[1605059669] 'range keys from in-memory index tree' (duration: 106.116617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:06.284569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.741151ms","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-15T11:52:06.284755Z","caller":"traceutil/trace.go:171","msg":"trace[43963643] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5540; }","duration":"104.963297ms","start":"2026-06-15T11:52:06.179715Z","end":"2026-06-15T11:52:06.284679Z","steps":["trace[43963643] 'range keys from in-memory index tree' (duration: 104.341381ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:11.309391Z","caller":"traceutil/trace.go:171","msg":"trace[666920206] transaction","detail":"{read_only:false; response_revision:5637; number_of_response:1; }","duration":"113.151255ms","start":"2026-06-15T11:52:11.196198Z","end":"2026-06-15T11:52:11.30935Z","steps":["trace[666920206] 'process raft request' (duration: 112.850798ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:53:01.85849Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3007} {"level":"info","ts":"2026-06-15T11:53:01.948347Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3007,"took":"87.82871ms","hash":1671808106,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":31342592,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-15T11:53:01.948445Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1671808106,"revision":3007,"compact-revision":-1} {"level":"info","ts":"2026-06-15T11:58:01.867129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6086} {"level":"info","ts":"2026-06-15T11:58:01.968719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6086,"took":"99.292795ms","hash":54547190,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":21868544,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-15T11:58:01.968811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":54547190,"revision":6086,"compact-revision":3007} {"level":"warn","ts":"2026-06-15T11:58:20.049013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.459157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:58:20.049162Z","caller":"traceutil/trace.go:171","msg":"trace[73770671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8403; }","duration":"119.643052ms","start":"2026-06-15T11:58:19.929499Z","end":"2026-06-15T11:58:20.049142Z","steps":["trace[73770671] 'range keys from in-memory index tree' (duration: 119.383976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:20.049145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.02145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T11:58:20.049266Z","caller":"traceutil/trace.go:171","msg":"trace[963911634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8403; }","duration":"162.221365ms","start":"2026-06-15T11:58:19.887018Z","end":"2026-06-15T11:58:20.049239Z","steps":["trace[963911634] 'range keys from in-memory index tree' (duration: 161.733252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:20.04924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.838179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:58:20.049675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.086084ms","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-06-15T11:58:20.049822Z","caller":"traceutil/trace.go:171","msg":"trace[881888443] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:8403; }","duration":"487.463225ms","start":"2026-06-15T11:58:19.562281Z","end":"2026-06-15T11:58:20.049745Z","steps":["trace[881888443] 'count revisions from in-memory index tree' (duration: 486.724606ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:20.04987Z","caller":"traceutil/trace.go:171","msg":"trace[1191328695] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8403; }","duration":"216.30982ms","start":"2026-06-15T11:58:19.83353Z","end":"2026-06-15T11:58:20.049839Z","steps":["trace[1191328695] 'range keys from in-memory index tree' (duration: 216.047564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:20.049929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:19.562255Z","time spent":"487.65885ms","remote":"127.0.0.1:34142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-06-15T11:58:31.027956Z","caller":"traceutil/trace.go:171","msg":"trace[672870478] transaction","detail":"{read_only:false; response_revision:8461; number_of_response:1; }","duration":"129.37806ms","start":"2026-06-15T11:58:30.898545Z","end":"2026-06-15T11:58:31.027923Z","steps":["trace[672870478] 'process raft request' (duration: 117.598281ms)","trace[672870478] 'compare' (duration: 11.653846ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:58:31.052541Z","caller":"traceutil/trace.go:171","msg":"trace[1315844520] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"147.88383ms","start":"2026-06-15T11:58:30.904621Z","end":"2026-06-15T11:58:31.052505Z","steps":["trace[1315844520] 'process raft request' (duration: 147.577502ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:31.053276Z","caller":"traceutil/trace.go:171","msg":"trace[222580183] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"141.935789ms","start":"2026-06-15T11:58:30.911312Z","end":"2026-06-15T11:58:31.053248Z","steps":["trace[222580183] 'process raft request' (duration: 141.851557ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:31.053334Z","caller":"traceutil/trace.go:171","msg":"trace[316165468] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"142.276048ms","start":"2026-06-15T11:58:30.911037Z","end":"2026-06-15T11:58:31.053314Z","steps":["trace[316165468] 'process raft request' (duration: 141.343134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:31.327198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.885738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:58:31.327299Z","caller":"traceutil/trace.go:171","msg":"trace[234127327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8464; }","duration":"142.059313ms","start":"2026-06-15T11:58:31.185217Z","end":"2026-06-15T11:58:31.327277Z","steps":["trace[234127327] 'range keys from in-memory index tree' (duration: 141.766985ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:32.902797Z","caller":"traceutil/trace.go:171","msg":"trace[603197294] transaction","detail":"{read_only:false; response_revision:8469; number_of_response:1; }","duration":"246.036236ms","start":"2026-06-15T11:58:32.656718Z","end":"2026-06-15T11:58:32.902754Z","steps":["trace[603197294] 'process raft request' (duration: 231.285881ms)","trace[603197294] 'compare' (duration: 14.57313ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:59:04.748525Z","caller":"traceutil/trace.go:171","msg":"trace[715751493] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"180.356766ms","start":"2026-06-15T11:59:04.568131Z","end":"2026-06-15T11:59:04.748488Z","steps":["trace[715751493] 'process raft request' (duration: 144.395787ms)","trace[715751493] 'compare' (duration: 35.745883ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:59:04.750374Z","caller":"traceutil/trace.go:171","msg":"trace[551187612] linearizableReadLoop","detail":"{readStateIndex:9008; appliedIndex:9006; }","duration":"175.959585ms","start":"2026-06-15T11:59:04.57439Z","end":"2026-06-15T11:59:04.75035Z","steps":["trace[551187612] 'read index received' (duration: 138.153079ms)","trace[551187612] 'applied index is now lower than readState.Index' (duration: 37.805406ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:59:04.750667Z","caller":"traceutil/trace.go:171","msg":"trace[1387684055] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"178.772125ms","start":"2026-06-15T11:59:04.571875Z","end":"2026-06-15T11:59:04.750648Z","steps":["trace[1387684055] 'process raft request' (duration: 178.322384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:59:04.750886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.475938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228837"} {"level":"info","ts":"2026-06-15T11:59:04.750924Z","caller":"traceutil/trace.go:171","msg":"trace[1592854016] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8695; }","duration":"176.529719ms","start":"2026-06-15T11:59:04.574384Z","end":"2026-06-15T11:59:04.750914Z","steps":["trace[1592854016] 'agreement among raft nodes before linearized reading' (duration: 176.088308ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:59:13.267269Z","caller":"traceutil/trace.go:171","msg":"trace[1317910091] transaction","detail":"{read_only:false; response_revision:8783; number_of_response:1; }","duration":"117.971079ms","start":"2026-06-15T11:59:13.149263Z","end":"2026-06-15T11:59:13.267234Z","steps":["trace[1317910091] 'process raft request' (duration: 117.62061ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:59:14.552866Z","caller":"traceutil/trace.go:171","msg":"trace[1898440712] transaction","detail":"{read_only:false; response_revision:8793; number_of_response:1; }","duration":"107.049544ms","start":"2026-06-15T11:59:14.445793Z","end":"2026-06-15T11:59:14.552842Z","steps":["trace[1898440712] 'process raft request' (duration: 106.8928ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:59:32.617304Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002454.wal"} {"level":"info","ts":"2026-06-15T12:00:38.919542Z","caller":"traceutil/trace.go:171","msg":"trace[1754986882] linearizableReadLoop","detail":"{readStateIndex:9960; appliedIndex:9959; }","duration":"101.328719ms","start":"2026-06-15T12:00:38.818176Z","end":"2026-06-15T12:00:38.919505Z","steps":["trace[1754986882] 'read index received' (duration: 101.061113ms)","trace[1754986882] 'applied index is now lower than readState.Index' (duration: 266.086µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:00:38.919633Z","caller":"traceutil/trace.go:171","msg":"trace[965021376] transaction","detail":"{read_only:false; response_revision:9617; number_of_response:1; }","duration":"105.822683ms","start":"2026-06-15T12:00:38.813758Z","end":"2026-06-15T12:00:38.91958Z","steps":["trace[965021376] 'process raft request' (duration: 105.500725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:00:38.919748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.542534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T12:00:38.919852Z","caller":"traceutil/trace.go:171","msg":"trace[1918565155] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:9617; }","duration":"101.698489ms","start":"2026-06-15T12:00:38.81814Z","end":"2026-06-15T12:00:38.919838Z","steps":["trace[1918565155] 'agreement among raft nodes before linearized reading' (duration: 101.516084ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:00:39.389221Z","caller":"traceutil/trace.go:171","msg":"trace[110331793] transaction","detail":"{read_only:false; response_revision:9619; number_of_response:1; }","duration":"248.6096ms","start":"2026-06-15T12:00:39.140585Z","end":"2026-06-15T12:00:39.389195Z","steps":["trace[110331793] 'process raft request' (duration: 187.058365ms)","trace[110331793] 'compare' (duration: 60.949589ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:00:39.389649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.402763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:00:39.38969Z","caller":"traceutil/trace.go:171","msg":"trace[97962372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9619; }","duration":"206.512756ms","start":"2026-06-15T12:00:39.183167Z","end":"2026-06-15T12:00:39.38968Z","steps":["trace[97962372] 'agreement among raft nodes before linearized reading' (duration: 206.432734ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:00:39.389552Z","caller":"traceutil/trace.go:171","msg":"trace[726772263] linearizableReadLoop","detail":"{readStateIndex:9962; appliedIndex:9961; }","duration":"205.718626ms","start":"2026-06-15T12:00:39.183242Z","end":"2026-06-15T12:00:39.38896Z","steps":["trace[726772263] 'read index received' (duration: 144.350107ms)","trace[726772263] 'applied index is now lower than readState.Index' (duration: 61.367389ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:00:39.554232Z","caller":"traceutil/trace.go:171","msg":"trace[1445113552] linearizableReadLoop","detail":"{readStateIndex:9963; appliedIndex:9962; }","duration":"164.229377ms","start":"2026-06-15T12:00:39.389979Z","end":"2026-06-15T12:00:39.554208Z","steps":["trace[1445113552] 'read index received' (duration: 125.037877ms)","trace[1445113552] 'applied index is now lower than readState.Index' (duration: 39.19034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:00:39.554591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.90285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:00:39.554677Z","caller":"traceutil/trace.go:171","msg":"trace[270742259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9620; }","duration":"164.042414ms","start":"2026-06-15T12:00:39.390615Z","end":"2026-06-15T12:00:39.554657Z","steps":["trace[270742259] 'agreement among raft nodes before linearized reading' (duration: 163.89167ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:00:39.55466Z","caller":"traceutil/trace.go:171","msg":"trace[241009105] transaction","detail":"{read_only:false; response_revision:9620; number_of_response:1; }","duration":"211.396729ms","start":"2026-06-15T12:00:39.343214Z","end":"2026-06-15T12:00:39.55461Z","steps":["trace[241009105] 'process raft request' (duration: 171.900121ms)","trace[241009105] 'compare' (duration: 38.841951ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:00:39.554712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.827305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8lgv4\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-06-15T12:00:39.554671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.262632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-15T12:00:39.5548Z","caller":"traceutil/trace.go:171","msg":"trace[1230018191] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8lgv4; range_end:; response_count:1; response_revision:9620; }","duration":"149.941758ms","start":"2026-06-15T12:00:39.404836Z","end":"2026-06-15T12:00:39.554778Z","steps":["trace[1230018191] 'agreement among raft nodes before linearized reading' (duration: 149.690311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:00:39.5549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.095302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:00:39.55502Z","caller":"traceutil/trace.go:171","msg":"trace[1969121128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9620; }","duration":"173.273247ms","start":"2026-06-15T12:00:39.381719Z","end":"2026-06-15T12:00:39.554993Z","steps":["trace[1969121128] 'agreement among raft nodes before linearized reading' (duration: 172.890007ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:00:39.554926Z","caller":"traceutil/trace.go:171","msg":"trace[1943246989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9620; }","duration":"273.56436ms","start":"2026-06-15T12:00:39.281342Z","end":"2026-06-15T12:00:39.554906Z","steps":["trace[1943246989] 'agreement among raft nodes before linearized reading' (duration: 273.16778ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:00:44.025619Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d0494904b1be7692","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T12:00:44.031474Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-15T12:00:44.031585Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-15T12:03:01.87377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8168} {"level":"info","ts":"2026-06-15T12:03:01.940372Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8168,"took":"64.104407ms","hash":3079388996,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":28393472,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-15T12:03:01.940431Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3079388996,"revision":8168,"compact-revision":6086} {"level":"warn","ts":"2026-06-15T12:06:10.215282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.856704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:06:10.215418Z","caller":"traceutil/trace.go:171","msg":"trace[665913574] linearizableReadLoop","detail":"{readStateIndex:12432; appliedIndex:12431; }","duration":"284.478144ms","start":"2026-06-15T12:06:09.930919Z","end":"2026-06-15T12:06:10.215398Z","steps":["trace[665913574] 'read index received' (duration: 4.269769ms)","trace[665913574] 'applied index is now lower than readState.Index' (duration: 280.206815ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:06:10.215516Z","caller":"traceutil/trace.go:171","msg":"trace[1381488524] transaction","detail":"{read_only:false; response_revision:12012; number_of_response:1; }","duration":"326.305294ms","start":"2026-06-15T12:06:09.889198Z","end":"2026-06-15T12:06:10.215503Z","steps":["trace[1381488524] 'process raft request' (duration: 46.09906ms)","trace[1381488524] 'compare' (duration: 279.693841ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:06:10.215587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:09.889179Z","time spent":"326.373946ms","remote":"127.0.0.1:33812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":789,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:06:10.215961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.021437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:06:10.216063Z","caller":"traceutil/trace.go:171","msg":"trace[532140372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12012; }","duration":"285.182831ms","start":"2026-06-15T12:06:09.930856Z","end":"2026-06-15T12:06:10.216038Z","steps":["trace[532140372] 'agreement among raft nodes before linearized reading' (duration: 284.969875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:10.234062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.733298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8lgv4\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-06-15T12:06:10.234062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.354614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-15T12:06:10.234097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.098616ms","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-15T12:06:10.23417Z","caller":"traceutil/trace.go:171","msg":"trace[1362041778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12012; }","duration":"298.521898ms","start":"2026-06-15T12:06:09.93562Z","end":"2026-06-15T12:06:10.234142Z","steps":["trace[1362041778] 'agreement among raft nodes before linearized reading' (duration: 298.215081ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:10.234188Z","caller":"traceutil/trace.go:171","msg":"trace[1754770480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12012; }","duration":"124.23706ms","start":"2026-06-15T12:06:10.109924Z","end":"2026-06-15T12:06:10.234161Z","steps":["trace[1754770480] 'agreement among raft nodes before linearized reading' (duration: 123.967963ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:10.234117Z","caller":"traceutil/trace.go:171","msg":"trace[494254375] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8lgv4; range_end:; response_count:1; response_revision:12012; }","duration":"209.82062ms","start":"2026-06-15T12:06:10.024285Z","end":"2026-06-15T12:06:10.234105Z","steps":["trace[494254375] 'agreement among raft nodes before linearized reading' (duration: 209.641296ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:08:01.879497Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10571} {"level":"info","ts":"2026-06-15T12:08:01.961393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10571,"took":"79.172507ms","hash":3119555184,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":26611712,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-15T12:08:01.96145Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3119555184,"revision":10571,"compact-revision":8168} {"level":"info","ts":"2026-06-15T12:12:45.389605Z","caller":"traceutil/trace.go:171","msg":"trace[69417277] linearizableReadLoop","detail":"{readStateIndex:15152; appliedIndex:15151; }","duration":"235.614324ms","start":"2026-06-15T12:12:45.153965Z","end":"2026-06-15T12:12:45.389579Z","steps":["trace[69417277] 'read index received' (duration: 173.913987ms)","trace[69417277] 'applied index is now lower than readState.Index' (duration: 61.699187ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:12:45.389641Z","caller":"traceutil/trace.go:171","msg":"trace[1068746843] transaction","detail":"{read_only:false; response_revision:14638; number_of_response:1; }","duration":"257.527216ms","start":"2026-06-15T12:12:45.132077Z","end":"2026-06-15T12:12:45.389604Z","steps":["trace[1068746843] 'process raft request' (duration: 195.82041ms)","trace[1068746843] 'compare' (duration: 61.512512ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:12:45.389816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.831369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T12:12:45.389816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.638547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:12:45.389864Z","caller":"traceutil/trace.go:171","msg":"trace[2112225429] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14638; }","duration":"235.933391ms","start":"2026-06-15T12:12:45.153916Z","end":"2026-06-15T12:12:45.38985Z","steps":["trace[2112225429] 'agreement among raft nodes before linearized reading' (duration: 235.810678ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:12:45.389882Z","caller":"traceutil/trace.go:171","msg":"trace[341990664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14638; }","duration":"205.74674ms","start":"2026-06-15T12:12:45.184109Z","end":"2026-06-15T12:12:45.389855Z","steps":["trace[341990664] 'agreement among raft nodes before linearized reading' (duration: 205.652427ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:13:01.886703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12764} {"level":"info","ts":"2026-06-15T12:13:01.964861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12764,"took":"76.196312ms","hash":4011428849,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":27435008,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-15T12:13:01.964933Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4011428849,"revision":12764,"compact-revision":10571} {"level":"info","ts":"2026-06-15T12:13:10.001298Z","caller":"traceutil/trace.go:171","msg":"trace[287843841] linearizableReadLoop","detail":"{readStateIndex:15503; appliedIndex:15502; }","duration":"350.532082ms","start":"2026-06-15T12:13:09.650744Z","end":"2026-06-15T12:13:10.001276Z","steps":["trace[287843841] 'read index received' (duration: 350.345447ms)","trace[287843841] 'applied index is now lower than readState.Index' (duration: 185.515µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:13:10.001373Z","caller":"traceutil/trace.go:171","msg":"trace[1731226626] transaction","detail":"{read_only:false; response_revision:14974; number_of_response:1; }","duration":"365.993711ms","start":"2026-06-15T12:13:09.635345Z","end":"2026-06-15T12:13:10.001339Z","steps":["trace[1731226626] 'process raft request' (duration: 365.777966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:13:10.001481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.722817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T12:13:10.001527Z","caller":"traceutil/trace.go:171","msg":"trace[2113126546] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:14974; }","duration":"350.795119ms","start":"2026-06-15T12:13:09.650722Z","end":"2026-06-15T12:13:10.001517Z","steps":["trace[2113126546] 'agreement among raft nodes before linearized reading' (duration: 350.694506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:13:10.001563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:13:09.650658Z","time spent":"350.895302ms","remote":"127.0.0.1:34116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-06-15T12:13:10.001589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:13:09.635326Z","time spent":"366.143476ms","remote":"127.0.0.1:33916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3741,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:13:10.00187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.219854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:13:10.002096Z","caller":"traceutil/trace.go:171","msg":"trace[1468803955] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14974; }","duration":"327.497201ms","start":"2026-06-15T12:13:09.674574Z","end":"2026-06-15T12:13:10.002071Z","steps":["trace[1468803955] 'agreement among raft nodes before linearized reading' (duration: 327.105171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:13:10.001949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.358833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T12:13:10.002393Z","caller":"traceutil/trace.go:171","msg":"trace[1822949865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14974; }","duration":"326.766282ms","start":"2026-06-15T12:13:09.675539Z","end":"2026-06-15T12:13:10.002305Z","steps":["trace[1822949865] 'agreement among raft nodes before linearized reading' (duration: 326.200068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:13:10.002484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:13:09.675527Z","time spent":"326.942837ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T12:13:10.001917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.333533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8lgv4\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-06-15T12:13:10.002635Z","caller":"traceutil/trace.go:171","msg":"trace[2053431310] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8lgv4; range_end:; response_count:1; response_revision:14974; }","duration":"289.089282ms","start":"2026-06-15T12:13:09.713521Z","end":"2026-06-15T12:13:10.00261Z","steps":["trace[2053431310] 'agreement among raft nodes before linearized reading' (duration: 288.247781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:13:10.001951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.504915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-15T12:13:10.002736Z","caller":"traceutil/trace.go:171","msg":"trace[663214826] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14974; }","duration":"319.357586ms","start":"2026-06-15T12:13:09.683353Z","end":"2026-06-15T12:13:10.002711Z","steps":["trace[663214826] 'agreement among raft nodes before linearized reading' (duration: 318.375341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:13:10.002793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:13:09.683323Z","time spent":"319.453268ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T12:13:10.00225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:13:09.674555Z","time spent":"327.676106ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T12:14:36.59343Z","caller":"traceutil/trace.go:171","msg":"trace[859932693] linearizableReadLoop","detail":"{readStateIndex:16337; appliedIndex:16336; }","duration":"117.633097ms","start":"2026-06-15T12:14:36.475777Z","end":"2026-06-15T12:14:36.59341Z","steps":["trace[859932693] 'read index received' (duration: 117.545455ms)","trace[859932693] 'applied index is now lower than readState.Index' (duration: 84.582µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:14:36.5936Z","caller":"traceutil/trace.go:171","msg":"trace[2112113113] transaction","detail":"{read_only:false; response_revision:15784; number_of_response:1; }","duration":"118.369585ms","start":"2026-06-15T12:14:36.475214Z","end":"2026-06-15T12:14:36.593583Z","steps":["trace[2112113113] 'process raft request' (duration: 118.031317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.594017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.211942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-15T12:14:36.594146Z","caller":"traceutil/trace.go:171","msg":"trace[1303288794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15784; }","duration":"118.399647ms","start":"2026-06-15T12:14:36.475718Z","end":"2026-06-15T12:14:36.594118Z","steps":["trace[1303288794] 'agreement among raft nodes before linearized reading' (duration: 118.083689ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:14:36.684691Z","caller":"traceutil/trace.go:171","msg":"trace[2119454020] transaction","detail":"{read_only:false; response_revision:15785; number_of_response:1; }","duration":"206.168201ms","start":"2026-06-15T12:14:36.478495Z","end":"2026-06-15T12:14:36.684663Z","steps":["trace[2119454020] 'process raft request' (duration: 205.954105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.684954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.61905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:14:36.684996Z","caller":"traceutil/trace.go:171","msg":"trace[1359287250] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15785; }","duration":"198.704612ms","start":"2026-06-15T12:14:36.486281Z","end":"2026-06-15T12:14:36.684985Z","steps":["trace[1359287250] 'agreement among raft nodes before linearized reading' (duration: 198.61988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.685166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.909347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:14:36.685228Z","caller":"traceutil/trace.go:171","msg":"trace[1139907846] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15785; }","duration":"199.00117ms","start":"2026-06-15T12:14:36.486213Z","end":"2026-06-15T12:14:36.685214Z","steps":["trace[1139907846] 'agreement among raft nodes before linearized reading' (duration: 198.868587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.685264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.015281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-15T12:14:36.685505Z","caller":"traceutil/trace.go:171","msg":"trace[572896172] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15785; }","duration":"197.274347ms","start":"2026-06-15T12:14:36.488204Z","end":"2026-06-15T12:14:36.685478Z","steps":["trace[572896172] 'agreement among raft nodes before linearized reading' (duration: 196.762354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.686802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.924513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:14:36.686862Z","caller":"traceutil/trace.go:171","msg":"trace[1385539017] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15785; }","duration":"199.996295ms","start":"2026-06-15T12:14:36.486851Z","end":"2026-06-15T12:14:36.686847Z","steps":["trace[1385539017] 'agreement among raft nodes before linearized reading' (duration: 197.825621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.980298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.159841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:14:36.980415Z","caller":"traceutil/trace.go:171","msg":"trace[2030571802] linearizableReadLoop","detail":"{readStateIndex:16339; appliedIndex:16338; }","duration":"295.77071ms","start":"2026-06-15T12:14:36.684626Z","end":"2026-06-15T12:14:36.980397Z","steps":["trace[2030571802] 'read index received' (duration: 129.335422ms)","trace[2030571802] 'applied index is now lower than readState.Index' (duration: 166.433608ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:14:36.980549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.836849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"warn","ts":"2026-06-15T12:14:36.980593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.738822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"warn","ts":"2026-06-15T12:14:36.980596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.733482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:14:36.980638Z","caller":"traceutil/trace.go:171","msg":"trace[1578775920] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15786; }","duration":"369.948952ms","start":"2026-06-15T12:14:36.610664Z","end":"2026-06-15T12:14:36.980613Z","steps":["trace[1578775920] 'agreement among raft nodes before linearized reading' (duration: 369.746767ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:14:36.980639Z","caller":"traceutil/trace.go:171","msg":"trace[1243868294] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15786; }","duration":"372.811514ms","start":"2026-06-15T12:14:36.607819Z","end":"2026-06-15T12:14:36.98063Z","steps":["trace[1243868294] 'agreement among raft nodes before linearized reading' (duration: 372.65268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.98067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:14:36.610651Z","time spent":"370.013053ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5544,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"info","ts":"2026-06-15T12:14:36.980666Z","caller":"traceutil/trace.go:171","msg":"trace[1760753975] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15786; }","duration":"372.830525ms","start":"2026-06-15T12:14:36.607812Z","end":"2026-06-15T12:14:36.980643Z","steps":["trace[1760753975] 'agreement among raft nodes before linearized reading' (duration: 372.738692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.980695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:14:36.60781Z","time spent":"372.857965ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-06-15T12:14:36.98073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:14:36.607802Z","time spent":"372.911176ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-06-15T12:14:36.980715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.286308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-06-15T12:14:36.980788Z","caller":"traceutil/trace.go:171","msg":"trace[819559418] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15786; }","duration":"385.395331ms","start":"2026-06-15T12:14:36.595376Z","end":"2026-06-15T12:14:36.980772Z","steps":["trace[819559418] 'agreement among raft nodes before linearized reading' (duration: 385.198256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:36.980825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:14:36.595363Z","time spent":"385.454042ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"info","ts":"2026-06-15T12:14:36.980891Z","caller":"traceutil/trace.go:171","msg":"trace[1939934998] transaction","detail":"{read_only:false; response_revision:15786; number_of_response:1; }","duration":"382.044056ms","start":"2026-06-15T12:14:36.598821Z","end":"2026-06-15T12:14:36.980865Z","steps":["trace[1939934998] 'process raft request' (duration: 215.224809ms)","trace[1939934998] 'compare' (duration: 165.990117ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:14:36.981012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:14:36.598793Z","time spent":"382.145869ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:14:37.065633Z","caller":"traceutil/trace.go:171","msg":"trace[1542095604] transaction","detail":"{read_only:false; response_revision:15788; number_of_response:1; }","duration":"112.151759ms","start":"2026-06-15T12:14:36.953454Z","end":"2026-06-15T12:14:37.065606Z","steps":["trace[1542095604] 'process raft request' (duration: 111.921693ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:14:37.065909Z","caller":"traceutil/trace.go:171","msg":"trace[447707401] transaction","detail":"{read_only:false; response_revision:15789; number_of_response:1; }","duration":"111.539064ms","start":"2026-06-15T12:14:36.954332Z","end":"2026-06-15T12:14:37.065871Z","steps":["trace[447707401] 'process raft request' (duration: 111.203495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:37.066349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.868067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:14:37.066402Z","caller":"traceutil/trace.go:171","msg":"trace[1626996645] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:15792; }","duration":"135.980641ms","start":"2026-06-15T12:14:36.930405Z","end":"2026-06-15T12:14:37.066385Z","steps":["trace[1626996645] 'agreement among raft nodes before linearized reading' (duration: 135.882399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:37.066527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.224224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8lgv4\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-06-15T12:14:37.066518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.559099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-15T12:14:37.066616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.134541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T12:14:37.066653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.757008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:14:37.066658Z","caller":"traceutil/trace.go:171","msg":"trace[1773308885] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:15792; }","duration":"124.206352ms","start":"2026-06-15T12:14:36.942436Z","end":"2026-06-15T12:14:37.066643Z","steps":["trace[1773308885] 'agreement among raft nodes before linearized reading' (duration: 124.148331ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:14:37.066682Z","caller":"traceutil/trace.go:171","msg":"trace[530457529] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:15792; }","duration":"350.810439ms","start":"2026-06-15T12:14:36.715862Z","end":"2026-06-15T12:14:37.066672Z","steps":["trace[530457529] 'agreement among raft nodes before linearized reading' (duration: 350.765188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:14:37.066713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:14:36.715847Z","time spent":"350.85969ms","remote":"127.0.0.1:48352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"warn","ts":"2026-06-15T12:14:37.066771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.268096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T12:14:37.066814Z","caller":"traceutil/trace.go:171","msg":"trace[1425819588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15792; }","duration":"109.324578ms","start":"2026-06-15T12:14:36.957475Z","end":"2026-06-15T12:14:37.0668Z","steps":["trace[1425819588] 'agreement among raft nodes before linearized reading' (duration: 109.227266ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:14:37.066662Z","caller":"traceutil/trace.go:171","msg":"trace[85134627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15792; }","duration":"112.742133ms","start":"2026-06-15T12:14:36.953893Z","end":"2026-06-15T12:14:37.066635Z","steps":["trace[85134627] 'agreement among raft nodes before linearized reading' (duration: 112.408405ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:14:37.066606Z","caller":"traceutil/trace.go:171","msg":"trace[2087315308] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8lgv4; range_end:; response_count:1; response_revision:15792; }","duration":"279.357077ms","start":"2026-06-15T12:14:36.78723Z","end":"2026-06-15T12:14:37.066587Z","steps":["trace[2087315308] 'agreement among raft nodes before linearized reading' (duration: 279.165942ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:18:01.89267Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14813} {"level":"info","ts":"2026-06-15T12:18:01.985395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14813,"took":"87.684592ms","hash":927803955,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":30445568,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-15T12:18:01.985478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":927803955,"revision":14813,"compact-revision":12764} {"level":"info","ts":"2026-06-15T12:23:01.900357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17413} {"level":"info","ts":"2026-06-15T12:23:01.998197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17413,"took":"94.321926ms","hash":3098401310,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":29671424,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-15T12:23:01.998261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3098401310,"revision":17413,"compact-revision":14813} {"level":"info","ts":"2026-06-15T12:23:27.811533Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d0494904b1be7692","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T12:23:27.817392Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-15T12:23:27.820874Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-15T12:28:01.908239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19186} {"level":"info","ts":"2026-06-15T12:28:02.001071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19186,"took":"89.836796ms","hash":1888596860,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":24113152,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-15T12:28:02.001149Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1888596860,"revision":19186,"compact-revision":17413}