{"level":"warn","ts":"2026-07-09T23:42:26.665741Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T23:42:26.665875Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-07-09T23:42:26.665943Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T23:42:26.665951Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-09T23:42:26.66597Z","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-07-09T23:42:26.666912Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-07-09T23:42:26.667075Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-07-09T23:42:26.670862Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.471979ms"} {"level":"info","ts":"2026-07-09T23:42:26.675958Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-07-09T23:42:26.676036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T23:42:26.676061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-07-09T23:42:26.676078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T23:42:26.676101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-07-09T23:42:26.676189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-07-09T23:42:26.681549Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T23:42:26.682694Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T23:42:26.68383Z","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-07-09T23:42:26.685753Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T23:42:26.686351Z","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-07-09T23:42:26.686398Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T23:42:26.686459Z","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-07-09T23:42:26.686496Z","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-07-09T23:42:26.688782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-07-09T23:42:26.689293Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-09T23:42:26.691468Z","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-07-09T23:42:26.691606Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-09T23:42:26.691736Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-09T23:42:26.691992Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T23:42:26.691929Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T23:42:27.1781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T23:42:27.178167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T23:42:27.178341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-07-09T23:42:27.17836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-07-09T23:42:27.17841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-09T23:42:27.178465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-07-09T23:42:27.17848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-09T23:42:27.180365Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T23:42:27.180434Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:42:27.180696Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T23:42:27.180826Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T23:42:27.180897Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T23:42:27.181215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T23:42:27.183997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-07-09T23:42:27.184337Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T23:42:27.186569Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:42:27.186777Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:42:27.186913Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:42:42.991177Z","caller":"traceutil/trace.go:171","msg":"trace[525797629] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"192.908539ms","start":"2026-07-09T23:42:42.798239Z","end":"2026-07-09T23:42:42.991147Z","steps":["trace[525797629] 'read index received' (duration: 192.673821ms)","trace[525797629] 'applied index is now lower than readState.Index' (duration: 232.948µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:42:42.991644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.776014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-09T23:42:42.991597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.322693ms","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-07-09T23:42:42.991722Z","caller":"traceutil/trace.go:171","msg":"trace[635642552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:412; }","duration":"116.908238ms","start":"2026-07-09T23:42:42.874776Z","end":"2026-07-09T23:42:42.991684Z","steps":["trace[635642552] 'agreement among raft nodes before linearized reading' (duration: 116.781054ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:42:42.991768Z","caller":"traceutil/trace.go:171","msg":"trace[1515778037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:412; }","duration":"193.533621ms","start":"2026-07-09T23:42:42.798205Z","end":"2026-07-09T23:42:42.991739Z","steps":["trace[1515778037] 'agreement among raft nodes before linearized reading' (duration: 193.155058ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:42:42.992087Z","caller":"traceutil/trace.go:171","msg":"trace[2038544416] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"194.947779ms","start":"2026-07-09T23:42:42.79712Z","end":"2026-07-09T23:42:42.992067Z","steps":["trace[2038544416] 'process raft request' (duration: 193.868992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:42:43.181362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.436461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T23:42:43.181493Z","caller":"traceutil/trace.go:171","msg":"trace[16333255] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"184.688856ms","start":"2026-07-09T23:42:42.996778Z","end":"2026-07-09T23:42:43.181467Z","steps":["trace[16333255] 'process raft request' (duration: 78.553702ms)","trace[16333255] 'compare' (duration: 105.309875ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:42:43.188102Z","caller":"traceutil/trace.go:171","msg":"trace[1704864299] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"191.100961ms","start":"2026-07-09T23:42:42.996971Z","end":"2026-07-09T23:42:43.188072Z","steps":["trace[1704864299] 'process raft request' (duration: 190.912004ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:43:12.980769Z","caller":"traceutil/trace.go:171","msg":"trace[134994951] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"113.516882ms","start":"2026-07-09T23:43:12.867209Z","end":"2026-07-09T23:43:12.980726Z","steps":["trace[134994951] 'process raft request' (duration: 112.752252ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:43:14.029618Z","caller":"traceutil/trace.go:171","msg":"trace[1876767114] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"263.898679ms","start":"2026-07-09T23:43:13.765627Z","end":"2026-07-09T23:43:14.029526Z","steps":["trace[1876767114] 'read index received' (duration: 259.096718ms)","trace[1876767114] 'applied index is now lower than readState.Index' (duration: 4.800411ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:43:14.029918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.268805ms","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-07-09T23:43:14.029962Z","caller":"traceutil/trace.go:171","msg":"trace[1497458318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:644; }","duration":"264.367066ms","start":"2026-07-09T23:43:13.765579Z","end":"2026-07-09T23:43:14.029946Z","steps":["trace[1497458318] 'agreement among raft nodes before linearized reading' (duration: 264.124013ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:43:14.030577Z","caller":"traceutil/trace.go:171","msg":"trace[2043441831] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"490.587773ms","start":"2026-07-09T23:43:13.539969Z","end":"2026-07-09T23:43:14.030556Z","steps":["trace[2043441831] 'process raft request' (duration: 485.075562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:43:14.030664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:43:13.539885Z","time spent":"490.731615ms","remote":"127.0.0.1:46790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:43:14.171087Z","caller":"traceutil/trace.go:171","msg":"trace[1037486079] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"134.90482ms","start":"2026-07-09T23:43:14.036111Z","end":"2026-07-09T23:43:14.171015Z","steps":["trace[1037486079] 'process raft request' (duration: 92.951579ms)","trace[1037486079] 'compare' (duration: 41.633577ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:44:19.642628Z","caller":"traceutil/trace.go:171","msg":"trace[449954249] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"105.817916ms","start":"2026-07-09T23:44:19.536774Z","end":"2026-07-09T23:44:19.642592Z","steps":["trace[449954249] 'process raft request' (duration: 105.528169ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:45:06.799436Z","caller":"traceutil/trace.go:171","msg":"trace[660093040] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"133.094381ms","start":"2026-07-09T23:45:06.666317Z","end":"2026-07-09T23:45:06.799412Z","steps":["trace[660093040] 'process raft request' (duration: 132.682588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:45:41.223761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.461819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T23:45:41.223893Z","caller":"traceutil/trace.go:171","msg":"trace[393042947] linearizableReadLoop","detail":"{readStateIndex:2311; appliedIndex:2310; }","duration":"120.352449ms","start":"2026-07-09T23:45:41.103513Z","end":"2026-07-09T23:45:41.223865Z","steps":["trace[393042947] 'read index received' (duration: 13.607482ms)","trace[393042947] 'applied index is now lower than readState.Index' (duration: 106.742937ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:45:41.223923Z","caller":"traceutil/trace.go:171","msg":"trace[821056171] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"238.243681ms","start":"2026-07-09T23:45:40.985632Z","end":"2026-07-09T23:45:41.223876Z","steps":["trace[821056171] 'process raft request' (duration: 131.590666ms)","trace[821056171] 'compare' (duration: 106.283243ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:45:41.224115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.609397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-09T23:45:41.224154Z","caller":"traceutil/trace.go:171","msg":"trace[907231880] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2227; }","duration":"120.684519ms","start":"2026-07-09T23:45:41.103458Z","end":"2026-07-09T23:45:41.224143Z","steps":["trace[907231880] 'agreement among raft nodes before linearized reading' (duration: 120.561975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:47:03.125763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.467822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-07-09T23:47:03.125866Z","caller":"traceutil/trace.go:171","msg":"trace[581704137] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2772; }","duration":"102.576266ms","start":"2026-07-09T23:47:03.023267Z","end":"2026-07-09T23:47:03.125844Z","steps":["trace[581704137] 'range keys from in-memory index tree' (duration: 102.257366ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:50:57.972684Z","caller":"traceutil/trace.go:171","msg":"trace[1445888214] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"104.740351ms","start":"2026-07-09T23:50:57.867907Z","end":"2026-07-09T23:50:57.972647Z","steps":["trace[1445888214] 'process raft request' (duration: 59.067178ms)","trace[1445888214] 'compare' (duration: 45.447587ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:50:58.171531Z","caller":"traceutil/trace.go:171","msg":"trace[667527624] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"133.912777ms","start":"2026-07-09T23:50:58.037593Z","end":"2026-07-09T23:50:58.171506Z","steps":["trace[667527624] 'process raft request' (duration: 133.708582ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:51:03.428212Z","caller":"traceutil/trace.go:171","msg":"trace[494884813] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"132.281651ms","start":"2026-07-09T23:51:03.295907Z","end":"2026-07-09T23:51:03.428188Z","steps":["trace[494884813] 'process raft request' (duration: 132.128287ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:51:04.131337Z","caller":"traceutil/trace.go:171","msg":"trace[319669598] linearizableReadLoop","detail":"{readStateIndex:4959; appliedIndex:4957; }","duration":"123.941215ms","start":"2026-07-09T23:51:04.007372Z","end":"2026-07-09T23:51:04.131313Z","steps":["trace[319669598] 'read index received' (duration: 123.621676ms)","trace[319669598] 'applied index is now lower than readState.Index' (duration: 318.289µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:51:04.131464Z","caller":"traceutil/trace.go:171","msg":"trace[547949838] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"125.371534ms","start":"2026-07-09T23:51:04.006078Z","end":"2026-07-09T23:51:04.13145Z","steps":["trace[547949838] 'process raft request' (duration: 124.980653ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:51:04.131831Z","caller":"traceutil/trace.go:171","msg":"trace[885169266] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"125.576219ms","start":"2026-07-09T23:51:04.006224Z","end":"2026-07-09T23:51:04.1318Z","steps":["trace[885169266] 'process raft request' (duration: 125.020974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:51:04.132012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.212015ms","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-07-09T23:51:04.132096Z","caller":"traceutil/trace.go:171","msg":"trace[1514960909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4780; }","duration":"104.318509ms","start":"2026-07-09T23:51:04.02776Z","end":"2026-07-09T23:51:04.132078Z","steps":["trace[1514960909] 'agreement among raft nodes before linearized reading' (duration: 104.102132ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:51:04.132105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.193506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-07-09T23:51:04.132175Z","caller":"traceutil/trace.go:171","msg":"trace[1498820318] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4780; }","duration":"119.283428ms","start":"2026-07-09T23:51:04.012876Z","end":"2026-07-09T23:51:04.132159Z","steps":["trace[1498820318] 'agreement among raft nodes before linearized reading' (duration: 119.084761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:51:04.132402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.211573ms","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-07-09T23:51:04.132505Z","caller":"traceutil/trace.go:171","msg":"trace[2028124493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4780; }","duration":"105.622734ms","start":"2026-07-09T23:51:04.026829Z","end":"2026-07-09T23:51:04.132452Z","steps":["trace[2028124493] 'agreement among raft nodes before linearized reading' (duration: 105.182022ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:51:04.132693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.08038ms","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-07-09T23:51:04.132863Z","caller":"traceutil/trace.go:171","msg":"trace[1297516025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4780; }","duration":"120.157412ms","start":"2026-07-09T23:51:04.012574Z","end":"2026-07-09T23:51:04.132731Z","steps":["trace[1297516025] 'agreement among raft nodes before linearized reading' (duration: 119.198955ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:51:04.13598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.581062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60099"} {"level":"info","ts":"2026-07-09T23:51:04.136076Z","caller":"traceutil/trace.go:171","msg":"trace[760967735] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4780; }","duration":"128.709096ms","start":"2026-07-09T23:51:04.007346Z","end":"2026-07-09T23:51:04.136055Z","steps":["trace[760967735] 'agreement among raft nodes before linearized reading' (duration: 124.338846ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:51:52.284716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.702457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T23:51:52.284809Z","caller":"traceutil/trace.go:171","msg":"trace[1896031160] linearizableReadLoop","detail":"{readStateIndex:5496; appliedIndex:5495; }","duration":"122.519782ms","start":"2026-07-09T23:51:52.162276Z","end":"2026-07-09T23:51:52.284796Z","steps":["trace[1896031160] 'read index received' (duration: 33.311µs)","trace[1896031160] 'applied index is now lower than readState.Index' (duration: 122.484951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:51:52.284914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.632605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:51:52.284907Z","caller":"traceutil/trace.go:171","msg":"trace[1021081007] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"138.575559ms","start":"2026-07-09T23:51:52.146308Z","end":"2026-07-09T23:51:52.284883Z","steps":["trace[1021081007] 'process raft request' (duration: 15.621815ms)","trace[1021081007] 'compare' (duration: 122.598644ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:51:52.284966Z","caller":"traceutil/trace.go:171","msg":"trace[1609004910] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:5303; }","duration":"122.716638ms","start":"2026-07-09T23:51:52.162237Z","end":"2026-07-09T23:51:52.284954Z","steps":["trace[1609004910] 'agreement among raft nodes before linearized reading' (duration: 122.626715ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:52:27.394033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2900} {"level":"info","ts":"2026-07-09T23:52:27.458954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2900,"took":"62.628784ms","hash":2937669915,"current-db-size-bytes":53624832,"current-db-size":"54 MB","current-db-size-in-use-bytes":29507584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-09T23:52:27.459005Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2937669915,"revision":2900,"compact-revision":-1} {"level":"info","ts":"2026-07-09T23:57:27.399771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5569} {"level":"info","ts":"2026-07-09T23:57:27.473148Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5569,"took":"72.334599ms","hash":2396263134,"current-db-size-bytes":53624832,"current-db-size":"54 MB","current-db-size-in-use-bytes":18341888,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-09T23:57:27.473217Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2396263134,"revision":5569,"compact-revision":2900}