{"level":"warn","ts":"2026-03-26T17:55:05.432922Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T17:55:05.433155Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-03-26T17:55:05.433275Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T17:55:05.433323Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-03-26T17:55:05.433371Z","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-03-26T17:55:05.434177Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-03-26T17:55:05.434287Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-03-26T17:55:05.437869Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.31942ms"} {"level":"info","ts":"2026-03-26T17:55:05.444532Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-03-26T17:55:05.444675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-03-26T17:55:05.444717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-03-26T17:55:05.444746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-26T17:55:05.44477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-03-26T17:55:05.444833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-03-26T17:55:05.44958Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-26T17:55:05.450802Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-26T17:55:05.451955Z","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-03-26T17:55:05.454052Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-26T17:55:05.454365Z","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-03-26T17:55:05.4544Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-26T17:55:05.454499Z","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-03-26T17:55:05.454544Z","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-03-26T17:55:05.456272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-03-26T17:55:05.45842Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-03-26T17:55:05.460109Z","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-03-26T17:55:05.460226Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-03-26T17:55:05.460247Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-03-26T17:55:05.460647Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-26T17:55:05.460715Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-26T17:55:05.945895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-03-26T17:55:05.946046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-03-26T17:55:05.946117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-03-26T17:55:05.94617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-03-26T17:55:05.946214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-03-26T17:55:05.946253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-03-26T17:55:05.946299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-03-26T17:55:05.947376Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:05.948404Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-03-26T17:55:05.948467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T17:55:05.948506Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T17:55:05.94887Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-26T17:55:05.949033Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-26T17:55:05.949247Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:05.950295Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:05.950394Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:05.95225Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-03-26T17:55:05.952271Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-26T17:55:27.848774Z","caller":"traceutil/trace.go:171","msg":"trace[1234868669] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:471; }","duration":"133.685164ms","start":"2026-03-26T17:55:27.715054Z","end":"2026-03-26T17:55:27.848739Z","steps":["trace[1234868669] 'read index received' (duration: 133.566561ms)","trace[1234868669] 'applied index is now lower than readState.Index' (duration: 117.403µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:55:27.848814Z","caller":"traceutil/trace.go:171","msg":"trace[439043385] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"189.598718ms","start":"2026-03-26T17:55:27.659184Z","end":"2026-03-26T17:55:27.848783Z","steps":["trace[439043385] 'process raft request' (duration: 189.378013ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:27.848994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.882588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-26T17:55:27.849098Z","caller":"traceutil/trace.go:171","msg":"trace[70296331] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:455; }","duration":"134.065072ms","start":"2026-03-26T17:55:27.715017Z","end":"2026-03-26T17:55:27.849082Z","steps":["trace[70296331] 'agreement among raft nodes before linearized reading' (duration: 133.856928ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:27.918671Z","caller":"traceutil/trace.go:171","msg":"trace[249376668] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"161.966027ms","start":"2026-03-26T17:55:27.756686Z","end":"2026-03-26T17:55:27.918652Z","steps":["trace[249376668] 'process raft request' (duration: 128.800379ms)","trace[249376668] 'compare' (duration: 32.968494ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:55:34.781913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.35381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:55:34.782012Z","caller":"traceutil/trace.go:171","msg":"trace[1947516070] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"219.034356ms","start":"2026-03-26T17:55:34.562963Z","end":"2026-03-26T17:55:34.781998Z","steps":["trace[1947516070] 'process raft request' (duration: 98.764468ms)","trace[1947516070] 'compare' (duration: 119.573613ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:55:34.783048Z","caller":"traceutil/trace.go:171","msg":"trace[367920531] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"218.244119ms","start":"2026-03-26T17:55:34.564768Z","end":"2026-03-26T17:55:34.783012Z","steps":["trace[367920531] 'process raft request' (duration: 218.023764ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:34.783124Z","caller":"traceutil/trace.go:171","msg":"trace[1221638323] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"213.244293ms","start":"2026-03-26T17:55:34.569853Z","end":"2026-03-26T17:55:34.783097Z","steps":["trace[1221638323] 'process raft request' (duration: 213.081199ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:34.783152Z","caller":"traceutil/trace.go:171","msg":"trace[9765324] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"193.518911ms","start":"2026-03-26T17:55:34.589611Z","end":"2026-03-26T17:55:34.783129Z","steps":["trace[9765324] 'process raft request' (duration: 193.415159ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:34.795021Z","caller":"traceutil/trace.go:171","msg":"trace[1600216622] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"131.452627ms","start":"2026-03-26T17:55:34.663531Z","end":"2026-03-26T17:55:34.794984Z","steps":["trace[1600216622] 'process raft request' (duration: 131.347614ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:36.223449Z","caller":"traceutil/trace.go:171","msg":"trace[185822086] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"254.377031ms","start":"2026-03-26T17:55:35.969046Z","end":"2026-03-26T17:55:36.223423Z","steps":["trace[185822086] 'read index received' (duration: 241.742821ms)","trace[185822086] 'applied index is now lower than readState.Index' (duration: 12.63312ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:55:36.223521Z","caller":"traceutil/trace.go:171","msg":"trace[1476258238] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"258.544351ms","start":"2026-03-26T17:55:35.964953Z","end":"2026-03-26T17:55:36.223498Z","steps":["trace[1476258238] 'process raft request' (duration: 245.623284ms)","trace[1476258238] 'compare' (duration: 12.65171ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:55:36.224006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.909552ms","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-03-26T17:55:36.224092Z","caller":"traceutil/trace.go:171","msg":"trace[1602310934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"255.061516ms","start":"2026-03-26T17:55:35.96901Z","end":"2026-03-26T17:55:36.224072Z","steps":["trace[1602310934] 'agreement among raft nodes before linearized reading' (duration: 254.559045ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:36.226457Z","caller":"traceutil/trace.go:171","msg":"trace[231993041] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"235.344874ms","start":"2026-03-26T17:55:35.991091Z","end":"2026-03-26T17:55:36.226436Z","steps":["trace[231993041] 'process raft request' (duration: 235.13864ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:36.226584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.777939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-03-26T17:55:36.226902Z","caller":"traceutil/trace.go:171","msg":"trace[1333390307] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:585; }","duration":"247.118926ms","start":"2026-03-26T17:55:35.979761Z","end":"2026-03-26T17:55:36.226879Z","steps":["trace[1333390307] 'agreement among raft nodes before linearized reading' (duration: 246.652946ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:41.246491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.137353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:55:41.246584Z","caller":"traceutil/trace.go:171","msg":"trace[939151174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"376.281695ms","start":"2026-03-26T17:55:40.870284Z","end":"2026-03-26T17:55:41.246566Z","steps":["trace[939151174] 'range keys from in-memory index tree' (duration: 376.05721ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:41.246626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:55:40.87026Z","time spent":"376.357687ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-26T17:55:41.334915Z","caller":"traceutil/trace.go:171","msg":"trace[595552562] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"320.485973ms","start":"2026-03-26T17:55:41.014404Z","end":"2026-03-26T17:55:41.33489Z","steps":["trace[595552562] 'read index received' (duration: 319.023972ms)","trace[595552562] 'applied index is now lower than readState.Index' (duration: 1.460641ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:55:41.33497Z","caller":"traceutil/trace.go:171","msg":"trace[132351048] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"369.528851ms","start":"2026-03-26T17:55:40.965407Z","end":"2026-03-26T17:55:41.334936Z","steps":["trace[132351048] 'process raft request' (duration: 368.226893ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:41.335214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:55:40.965384Z","time spent":"369.743985ms","remote":"127.0.0.1:52614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:55:41.335261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.82306ms","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-03-26T17:55:41.33545Z","caller":"traceutil/trace.go:171","msg":"trace[1482761080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"320.991934ms","start":"2026-03-26T17:55:41.014361Z","end":"2026-03-26T17:55:41.335353Z","steps":["trace[1482761080] 'agreement among raft nodes before linearized reading' (duration: 320.662837ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:41.33551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:55:41.014342Z","time spent":"321.155207ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-26T17:55:41.491923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.063086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:55:41.492047Z","caller":"traceutil/trace.go:171","msg":"trace[6894004] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"331.789983ms","start":"2026-03-26T17:55:41.160231Z","end":"2026-03-26T17:55:41.492021Z","steps":["trace[6894004] 'process raft request' (duration: 194.555684ms)","trace[6894004] 'compare' (duration: 136.959014ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:55:41.492144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:55:41.160198Z","time spent":"331.906806ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:55:41.492068Z","caller":"traceutil/trace.go:171","msg":"trace[805245521] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"156.992632ms","start":"2026-03-26T17:55:41.335063Z","end":"2026-03-26T17:55:41.492056Z","steps":["trace[805245521] 'read index received' (duration: 19.736152ms)","trace[805245521] 'applied index is now lower than readState.Index' (duration: 137.25573ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:55:41.492328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.652543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:55:41.492391Z","caller":"traceutil/trace.go:171","msg":"trace[357713306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"244.731335ms","start":"2026-03-26T17:55:41.247643Z","end":"2026-03-26T17:55:41.492375Z","steps":["trace[357713306] 'agreement among raft nodes before linearized reading' (duration: 244.448469ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:41.492342Z","caller":"traceutil/trace.go:171","msg":"trace[551785797] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"152.926104ms","start":"2026-03-26T17:55:41.339383Z","end":"2026-03-26T17:55:41.492309Z","steps":["trace[551785797] 'process raft request' (duration: 152.635908ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:41.534454Z","caller":"traceutil/trace.go:171","msg":"trace[1926723414] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"142.148164ms","start":"2026-03-26T17:55:41.392144Z","end":"2026-03-26T17:55:41.534293Z","steps":["trace[1926723414] 'process raft request' (duration: 142.059542ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:42.066233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.764996ms","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-03-26T17:55:42.066356Z","caller":"traceutil/trace.go:171","msg":"trace[2026398916] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"125.759045ms","start":"2026-03-26T17:55:41.940576Z","end":"2026-03-26T17:55:42.066335Z","steps":["trace[2026398916] 'process raft request' (duration: 120.598545ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:42.0664Z","caller":"traceutil/trace.go:171","msg":"trace[252264060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"155.941829ms","start":"2026-03-26T17:55:41.910438Z","end":"2026-03-26T17:55:42.06638Z","steps":["trace[252264060] 'range keys from in-memory index tree' (duration: 155.573442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:58.249224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.778977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-26T17:55:58.249303Z","caller":"traceutil/trace.go:171","msg":"trace[1854219417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"104.877539ms","start":"2026-03-26T17:55:58.144411Z","end":"2026-03-26T17:55:58.249289Z","steps":["trace[1854219417] 'range keys from in-memory index tree' (duration: 104.591163ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:58.430905Z","caller":"traceutil/trace.go:171","msg":"trace[753241338] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"111.889649ms","start":"2026-03-26T17:55:58.318999Z","end":"2026-03-26T17:55:58.430888Z","steps":["trace[753241338] 'read index received' (duration: 110.779535ms)","trace[753241338] 'applied index is now lower than readState.Index' (duration: 1.109374ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:55:58.431296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.492751ms","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-03-26T17:55:58.431543Z","caller":"traceutil/trace.go:171","msg":"trace[2037077580] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"178.91526ms","start":"2026-03-26T17:55:58.252595Z","end":"2026-03-26T17:55:58.43151Z","steps":["trace[2037077580] 'process raft request' (duration: 177.713455ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:55:58.431602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.565493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-26T17:55:58.431409Z","caller":"traceutil/trace.go:171","msg":"trace[1231385131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"111.663754ms","start":"2026-03-26T17:55:58.319724Z","end":"2026-03-26T17:55:58.431388Z","steps":["trace[1231385131] 'agreement among raft nodes before linearized reading' (duration: 111.359607ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:58.43187Z","caller":"traceutil/trace.go:171","msg":"trace[367361538] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:782; }","duration":"112.89469ms","start":"2026-03-26T17:55:58.31894Z","end":"2026-03-26T17:55:58.431835Z","steps":["trace[367361538] 'agreement among raft nodes before linearized reading' (duration: 112.040172ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:23.844277Z","caller":"traceutil/trace.go:171","msg":"trace[662629738] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"135.761519ms","start":"2026-03-26T17:56:23.708478Z","end":"2026-03-26T17:56:23.844239Z","steps":["trace[662629738] 'process raft request' (duration: 135.527164ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:09.951477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.055962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T17:57:09.951572Z","caller":"traceutil/trace.go:171","msg":"trace[1145634983] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1831; }","duration":"218.207345ms","start":"2026-03-26T17:57:09.733347Z","end":"2026-03-26T17:57:09.951554Z","steps":["trace[1145634983] 'count revisions from in-memory index tree' (duration: 217.883868ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:39.317664Z","caller":"traceutil/trace.go:171","msg":"trace[1238671724] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"110.585739ms","start":"2026-03-26T17:58:39.207048Z","end":"2026-03-26T17:58:39.317634Z","steps":["trace[1238671724] 'process raft request' (duration: 110.412765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:59:13.461931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.072319ms","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-03-26T17:59:13.462033Z","caller":"traceutil/trace.go:171","msg":"trace[935097832] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2749; }","duration":"116.214702ms","start":"2026-03-26T17:59:13.345792Z","end":"2026-03-26T17:59:13.462007Z","steps":["trace[935097832] 'range keys from in-memory index tree' (duration: 115.915336ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:59:13.727888Z","caller":"traceutil/trace.go:171","msg":"trace[1983090328] linearizableReadLoop","detail":"{readStateIndex:2853; appliedIndex:2852; }","duration":"232.746671ms","start":"2026-03-26T17:59:13.495108Z","end":"2026-03-26T17:59:13.727855Z","steps":["trace[1983090328] 'read index received' (duration: 232.597578ms)","trace[1983090328] 'applied index is now lower than readState.Index' (duration: 147.633µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:59:13.727948Z","caller":"traceutil/trace.go:171","msg":"trace[539542567] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"258.472758ms","start":"2026-03-26T17:59:13.469435Z","end":"2026-03-26T17:59:13.727908Z","steps":["trace[539542567] 'process raft request' (duration: 258.233203ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:59:13.728149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.721274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"} {"level":"info","ts":"2026-03-26T17:59:13.728275Z","caller":"traceutil/trace.go:171","msg":"trace[1064998684] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2751; }","duration":"259.876517ms","start":"2026-03-26T17:59:13.468381Z","end":"2026-03-26T17:59:13.728257Z","steps":["trace[1064998684] 'agreement among raft nodes before linearized reading' (duration: 259.600851ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:59:13.739919Z","caller":"traceutil/trace.go:171","msg":"trace[1850214294] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"240.826902ms","start":"2026-03-26T17:59:13.499071Z","end":"2026-03-26T17:59:13.739898Z","steps":["trace[1850214294] 'process raft request' (duration: 240.27125ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:01:39.764434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.415116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T18:01:39.764566Z","caller":"traceutil/trace.go:171","msg":"trace[294651378] linearizableReadLoop","detail":"{readStateIndex:3862; appliedIndex:3861; }","duration":"284.142875ms","start":"2026-03-26T18:01:39.480402Z","end":"2026-03-26T18:01:39.764545Z","steps":["trace[294651378] 'read index received' (duration: 5.985189ms)","trace[294651378] 'applied index is now lower than readState.Index' (duration: 278.156156ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T18:01:39.764719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.308249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T18:01:39.764762Z","caller":"traceutil/trace.go:171","msg":"trace[1838395816] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:3722; }","duration":"284.386061ms","start":"2026-03-26T18:01:39.480363Z","end":"2026-03-26T18:01:39.764749Z","steps":["trace[1838395816] 'agreement among raft nodes before linearized reading' (duration: 284.286859ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:01:39.764752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.825311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T18:01:39.764814Z","caller":"traceutil/trace.go:171","msg":"trace[907736977] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:3722; }","duration":"144.929773ms","start":"2026-03-26T18:01:39.619867Z","end":"2026-03-26T18:01:39.764797Z","steps":["trace[907736977] 'agreement among raft nodes before linearized reading' (duration: 144.8243ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:01:39.764695Z","caller":"traceutil/trace.go:171","msg":"trace[136426104] transaction","detail":"{read_only:false; response_revision:3722; number_of_response:1; }","duration":"289.358427ms","start":"2026-03-26T18:01:39.475211Z","end":"2026-03-26T18:01:39.76457Z","steps":["trace[136426104] 'process raft request' (duration: 184.697326ms)","trace[136426104] 'compare' (duration: 104.204071ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T18:03:01.962353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.310278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T18:03:01.96253Z","caller":"traceutil/trace.go:171","msg":"trace[1554262552] linearizableReadLoop","detail":"{readStateIndex:5059; appliedIndex:5058; }","duration":"233.537981ms","start":"2026-03-26T18:03:01.728972Z","end":"2026-03-26T18:03:01.96251Z","steps":["trace[1554262552] 'read index received' (duration: 104.995778ms)","trace[1554262552] 'applied index is now lower than readState.Index' (duration: 128.541013ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T18:03:01.962571Z","caller":"traceutil/trace.go:171","msg":"trace[2081911873] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"249.949893ms","start":"2026-03-26T18:03:01.712567Z","end":"2026-03-26T18:03:01.962517Z","steps":["trace[2081911873] 'process raft request' (duration: 121.39153ms)","trace[2081911873] 'compare' (duration: 128.104134ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T18:03:01.962778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.591789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T18:03:01.962823Z","caller":"traceutil/trace.go:171","msg":"trace[89969899] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:4876; }","duration":"224.667721ms","start":"2026-03-26T18:03:01.738144Z","end":"2026-03-26T18:03:01.962812Z","steps":["trace[89969899] 'agreement among raft nodes before linearized reading' (duration: 224.567919ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:03:01.963002Z","caller":"traceutil/trace.go:171","msg":"trace[1779882323] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"218.801296ms","start":"2026-03-26T18:03:01.744178Z","end":"2026-03-26T18:03:01.962979Z","steps":["trace[1779882323] 'process raft request' (duration: 218.289015ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:01.963091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.326994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-jfvbd.18a0762ae6d79630\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-03-26T18:03:01.963132Z","caller":"traceutil/trace.go:171","msg":"trace[1704142225] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-jfvbd.18a0762ae6d79630; range_end:; response_count:1; response_revision:4876; }","duration":"111.403305ms","start":"2026-03-26T18:03:01.851715Z","end":"2026-03-26T18:03:01.963118Z","steps":["trace[1704142225] 'agreement among raft nodes before linearized reading' (duration: 111.265202ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:01.963128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.496824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c9cecc92-8e8e-4d8c-95b8-fc0709145592\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-03-26T18:03:01.963179Z","caller":"traceutil/trace.go:171","msg":"trace[1188618081] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c9cecc92-8e8e-4d8c-95b8-fc0709145592; range_end:; response_count:1; response_revision:4876; }","duration":"116.590716ms","start":"2026-03-26T18:03:01.846574Z","end":"2026-03-26T18:03:01.963165Z","steps":["trace[1188618081] 'agreement among raft nodes before linearized reading' (duration: 116.417982ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:01.963209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.194545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-03-26T18:03:01.963278Z","caller":"traceutil/trace.go:171","msg":"trace[1471252908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4875; }","duration":"234.302778ms","start":"2026-03-26T18:03:01.728961Z","end":"2026-03-26T18:03:01.963264Z","steps":["trace[1471252908] 'agreement among raft nodes before linearized reading' (duration: 233.659303ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:03:04.25835Z","caller":"traceutil/trace.go:171","msg":"trace[860503163] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"171.479743ms","start":"2026-03-26T18:03:04.086851Z","end":"2026-03-26T18:03:04.258331Z","steps":["trace[860503163] 'process raft request' (duration: 171.368201ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:22.368638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.637068ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T18:03:22.368765Z","caller":"traceutil/trace.go:171","msg":"trace[1780627795] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"303.359286ms","start":"2026-03-26T18:03:22.065387Z","end":"2026-03-26T18:03:22.368746Z","steps":["trace[1780627795] 'process raft request' (duration: 114.519553ms)","trace[1780627795] 'compare' (duration: 188.433823ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T18:03:22.368835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T18:03:22.065357Z","time spent":"303.449177ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T18:03:22.513459Z","caller":"traceutil/trace.go:171","msg":"trace[1558965591] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"444.36895ms","start":"2026-03-26T18:03:22.069054Z","end":"2026-03-26T18:03:22.513423Z","steps":["trace[1558965591] 'process raft request' (duration: 415.831143ms)","trace[1558965591] 'compare' (duration: 28.417334ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T18:03:22.513623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T18:03:22.069038Z","time spent":"444.512533ms","remote":"127.0.0.1:52730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3747,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T18:03:22.513479Z","caller":"traceutil/trace.go:171","msg":"trace[1924788295] linearizableReadLoop","detail":"{readStateIndex:5438; appliedIndex:5436; }","duration":"395.380239ms","start":"2026-03-26T18:03:22.118079Z","end":"2026-03-26T18:03:22.51346Z","steps":["trace[1924788295] 'read index received' (duration: 61.802663ms)","trace[1924788295] 'applied index is now lower than readState.Index' (duration: 333.576656ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T18:03:22.513719Z","caller":"traceutil/trace.go:171","msg":"trace[956680720] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"192.343536ms","start":"2026-03-26T18:03:22.321322Z","end":"2026-03-26T18:03:22.513665Z","steps":["trace[956680720] 'process raft request' (duration: 192.08666ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:22.513865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.095086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-26T18:03:22.513898Z","caller":"traceutil/trace.go:171","msg":"trace[335333506] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5247; }","duration":"156.164097ms","start":"2026-03-26T18:03:22.357725Z","end":"2026-03-26T18:03:22.513889Z","steps":["trace[335333506] 'agreement among raft nodes before linearized reading' (duration: 156.043565ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:22.514057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.968921ms","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-03-26T18:03:22.514115Z","caller":"traceutil/trace.go:171","msg":"trace[1221270594] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5247; }","duration":"396.065345ms","start":"2026-03-26T18:03:22.118035Z","end":"2026-03-26T18:03:22.514101Z","steps":["trace[1221270594] 'agreement among raft nodes before linearized reading' (duration: 395.485532ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:03:22.514379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T18:03:22.118021Z","time spent":"396.226208ms","remote":"127.0.0.1:52832","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":"info","ts":"2026-03-26T18:03:34.744472Z","caller":"traceutil/trace.go:171","msg":"trace[351189649] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"156.332601ms","start":"2026-03-26T18:03:34.588108Z","end":"2026-03-26T18:03:34.744441Z","steps":["trace[351189649] 'process raft request' (duration: 143.972949ms)","trace[351189649] 'compare' (duration: 12.220949ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T18:03:34.754585Z","caller":"traceutil/trace.go:171","msg":"trace[1806764097] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"166.065958ms","start":"2026-03-26T18:03:34.588467Z","end":"2026-03-26T18:03:34.754533Z","steps":["trace[1806764097] 'process raft request' (duration: 165.814933ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:05:05.983468Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3038} {"level":"info","ts":"2026-03-26T18:05:06.065873Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3038,"took":"80.717609ms","hash":3256314924,"current-db-size-bytes":58773504,"current-db-size":"59 MB","current-db-size-in-use-bytes":31989760,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-26T18:05:06.065927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3256314924,"revision":3038,"compact-revision":-1} {"level":"info","ts":"2026-03-26T18:09:07.270629Z","caller":"traceutil/trace.go:171","msg":"trace[381673970] transaction","detail":"{read_only:false; response_revision:8012; number_of_response:1; }","duration":"120.065218ms","start":"2026-03-26T18:09:07.150542Z","end":"2026-03-26T18:09:07.270607Z","steps":["trace[381673970] 'process raft request' (duration: 119.919485ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:17.197287Z","caller":"traceutil/trace.go:171","msg":"trace[1210051130] transaction","detail":"{read_only:false; response_revision:8063; number_of_response:1; }","duration":"299.218006ms","start":"2026-03-26T18:09:16.898045Z","end":"2026-03-26T18:09:17.197263Z","steps":["trace[1210051130] 'process raft request' (duration: 299.020651ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:18.016583Z","caller":"traceutil/trace.go:171","msg":"trace[1411344827] transaction","detail":"{read_only:false; response_revision:8066; number_of_response:1; }","duration":"159.954268ms","start":"2026-03-26T18:09:17.856611Z","end":"2026-03-26T18:09:18.016565Z","steps":["trace[1411344827] 'process raft request' (duration: 159.57699ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:09:19.074567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.86384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-03-26T18:09:19.074667Z","caller":"traceutil/trace.go:171","msg":"trace[338488499] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:8074; }","duration":"116.956282ms","start":"2026-03-26T18:09:18.957672Z","end":"2026-03-26T18:09:19.074629Z","steps":["trace[338488499] 'range keys from in-memory index tree' (duration: 115.882029ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:42.969165Z","caller":"traceutil/trace.go:171","msg":"trace[1771739741] transaction","detail":"{read_only:false; response_revision:8254; number_of_response:1; }","duration":"116.770418ms","start":"2026-03-26T18:09:42.852356Z","end":"2026-03-26T18:09:42.969127Z","steps":["trace[1771739741] 'process raft request' (duration: 116.35005ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:48.31777Z","caller":"traceutil/trace.go:171","msg":"trace[1769209751] transaction","detail":"{read_only:false; response_revision:8281; number_of_response:1; }","duration":"176.229685ms","start":"2026-03-26T18:09:48.141514Z","end":"2026-03-26T18:09:48.317744Z","steps":["trace[1769209751] 'process raft request' (duration: 176.057321ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:48.478345Z","caller":"traceutil/trace.go:171","msg":"trace[884391133] transaction","detail":"{read_only:false; response_revision:8282; number_of_response:1; }","duration":"124.82264ms","start":"2026-03-26T18:09:48.353478Z","end":"2026-03-26T18:09:48.478301Z","steps":["trace[884391133] 'process raft request' (duration: 93.877539ms)","trace[884391133] 'compare' (duration: 30.719645ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T18:09:58.585902Z","caller":"traceutil/trace.go:171","msg":"trace[22344160] transaction","detail":"{read_only:false; response_revision:8380; number_of_response:1; }","duration":"237.933ms","start":"2026-03-26T18:09:58.347925Z","end":"2026-03-26T18:09:58.585858Z","steps":["trace[22344160] 'process raft request' (duration: 237.666813ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:58.628079Z","caller":"traceutil/trace.go:171","msg":"trace[1724331293] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"271.604577ms","start":"2026-03-26T18:09:58.356444Z","end":"2026-03-26T18:09:58.628049Z","steps":["trace[1724331293] 'process raft request' (duration: 271.509745ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:09:58.628077Z","caller":"traceutil/trace.go:171","msg":"trace[1407136789] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"277.967853ms","start":"2026-03-26T18:09:58.350065Z","end":"2026-03-26T18:09:58.628033Z","steps":["trace[1407136789] 'process raft request' (duration: 277.724688ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T18:10:05.990357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6168} {"level":"info","ts":"2026-03-26T18:10:06.099205Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6168,"took":"106.884888ms","hash":1835060056,"current-db-size-bytes":58773504,"current-db-size":"59 MB","current-db-size-in-use-bytes":23851008,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-26T18:10:06.099261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1835060056,"revision":6168,"compact-revision":3038} {"level":"info","ts":"2026-03-26T18:10:56.908537Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002434.wal"} {"level":"info","ts":"2026-03-26T18:12:29.870045Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-26T18:12:29.875722Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-26T18:12:29.875822Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-26T18:15:05.996507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8446} {"level":"info","ts":"2026-03-26T18:15:06.082289Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8446,"took":"82.933608ms","hash":3062015544,"current-db-size-bytes":58773504,"current-db-size":"59 MB","current-db-size-in-use-bytes":24399872,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-26T18:15:06.082363Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3062015544,"revision":8446,"compact-revision":6168} {"level":"info","ts":"2026-03-26T18:20:06.002582Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10725} {"level":"info","ts":"2026-03-26T18:20:06.080247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10725,"took":"74.983915ms","hash":3226223359,"current-db-size-bytes":58773504,"current-db-size":"59 MB","current-db-size-in-use-bytes":19947520,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-03-26T18:20:06.080312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3226223359,"revision":10725,"compact-revision":8446}