{"level":"warn","ts":"2026-05-09T21:39:42.957102Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:39:42.95719Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-05-09T21:39:42.957246Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:39:42.957255Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-09T21:39:42.95727Z","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-05-09T21:39:42.957948Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-05-09T21:39:42.958038Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-05-09T21:39:42.962536Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.275069ms"} {"level":"info","ts":"2026-05-09T21:39:42.969571Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-05-09T21:39:42.969638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T21:39:42.969659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-05-09T21:39:42.969669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T21:39:42.969681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-05-09T21:39:42.969716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-05-09T21:39:42.975912Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T21:39:42.977665Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T21:39:42.979363Z","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-05-09T21:39:42.982396Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T21:39:42.982607Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T21:39:42.982766Z","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-05-09T21:39:42.982819Z","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-05-09T21:39:42.982831Z","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-05-09T21:39:42.983629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-05-09T21:39:42.983748Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-09T21:39:42.987957Z","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-05-09T21:39:42.988127Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T21:39:42.988108Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-09T21:39:42.988163Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T21:39:42.98818Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-09T21:39:43.470506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T21:39:43.470564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T21:39:43.470615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-05-09T21:39:43.470642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-05-09T21:39:43.470658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-09T21:39:43.470675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-05-09T21:39:43.470693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-09T21:39:43.471637Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T21:39:43.471853Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:39:43.471892Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:39:43.473576Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-05-09T21:39:43.475209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T21:39:43.472119Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:43.484293Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:43.484404Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:43.484438Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:39:43.485395Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T21:39:43.485411Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-05-09T21:39:48.957439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.791839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:39:48.957606Z","caller":"traceutil/trace.go:171","msg":"trace[614175976] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"228.062784ms","start":"2026-05-09T21:39:48.729524Z","end":"2026-05-09T21:39:48.957586Z","steps":["trace[614175976] 'read index received' (duration: 113.490394ms)","trace[614175976] 'applied index is now lower than readState.Index' (duration: 114.57051ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:39:48.957665Z","caller":"traceutil/trace.go:171","msg":"trace[330315639] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"265.061013ms","start":"2026-05-09T21:39:48.692579Z","end":"2026-05-09T21:39:48.95764Z","steps":["trace[330315639] 'process raft request' (duration: 150.453092ms)","trace[330315639] 'compare' (duration: 113.309012ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:39:48.957823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.257626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-09T21:39:48.957912Z","caller":"traceutil/trace.go:171","msg":"trace[199907916] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:304; }","duration":"228.408929ms","start":"2026-05-09T21:39:48.729486Z","end":"2026-05-09T21:39:48.957895Z","steps":["trace[199907916] 'agreement among raft nodes before linearized reading' (duration: 228.171726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:49.310539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.934786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:39:49.310669Z","caller":"traceutil/trace.go:171","msg":"trace[1463365313] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"349.927255ms","start":"2026-05-09T21:39:48.960725Z","end":"2026-05-09T21:39:49.310652Z","steps":["trace[1463365313] 'process raft request' (duration: 136.822146ms)","trace[1463365313] 'compare' (duration: 212.818125ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:39:49.310712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:48.960702Z","time spent":"349.992167ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":184,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:39:49.377432Z","caller":"traceutil/trace.go:171","msg":"trace[1392292705] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:314; }","duration":"192.162533ms","start":"2026-05-09T21:39:49.185243Z","end":"2026-05-09T21:39:49.377406Z","steps":["trace[1392292705] 'read index received' (duration: 191.94357ms)","trace[1392292705] 'applied index is now lower than readState.Index' (duration: 217.323µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:39:49.37744Z","caller":"traceutil/trace.go:171","msg":"trace[2040693185] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"416.285783ms","start":"2026-05-09T21:39:48.961102Z","end":"2026-05-09T21:39:49.377387Z","steps":["trace[2040693185] 'process raft request' (duration: 416.07509ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:49.377625Z","caller":"traceutil/trace.go:171","msg":"trace[88059642] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"416.169302ms","start":"2026-05-09T21:39:48.961251Z","end":"2026-05-09T21:39:49.37742Z","steps":["trace[88059642] 'process raft request' (duration: 416.04022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:49.377778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:48.961086Z","time spent":"416.627929ms","remote":"127.0.0.1:42304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:39:49.377782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:48.961239Z","time spent":"416.478946ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":302,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:39:49.37773Z","caller":"traceutil/trace.go:171","msg":"trace[418458169] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"415.746466ms","start":"2026-05-09T21:39:48.961952Z","end":"2026-05-09T21:39:49.377698Z","steps":["trace[418458169] 'process raft request' (duration: 415.37673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:49.377881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.63068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-09T21:39:49.377934Z","caller":"traceutil/trace.go:171","msg":"trace[1079738046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:308; }","duration":"192.715521ms","start":"2026-05-09T21:39:49.185204Z","end":"2026-05-09T21:39:49.37792Z","steps":["trace[1079738046] 'agreement among raft nodes before linearized reading' (duration: 192.506498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:39:49.378214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:39:48.961938Z","time spent":"415.962648ms","remote":"127.0.0.1:42304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:39:49.382018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.238846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-05-09T21:39:49.382093Z","caller":"traceutil/trace.go:171","msg":"trace[536537248] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:308; }","duration":"153.341208ms","start":"2026-05-09T21:39:49.228733Z","end":"2026-05-09T21:39:49.382074Z","steps":["trace[536537248] 'agreement among raft nodes before linearized reading' (duration: 153.184586ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:49.382136Z","caller":"traceutil/trace.go:171","msg":"trace[726167410] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"152.14354ms","start":"2026-05-09T21:39:49.229974Z","end":"2026-05-09T21:39:49.382118Z","steps":["trace[726167410] 'process raft request' (duration: 151.856826ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:39:49.38268Z","caller":"traceutil/trace.go:171","msg":"trace[1443116462] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"152.20483ms","start":"2026-05-09T21:39:49.230457Z","end":"2026-05-09T21:39:49.382662Z","steps":["trace[1443116462] 'process raft request' (duration: 151.435519ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.867779Z","caller":"traceutil/trace.go:171","msg":"trace[1296003] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"134.929913ms","start":"2026-05-09T21:40:13.732829Z","end":"2026-05-09T21:40:13.867759Z","steps":["trace[1296003] 'process raft request' (duration: 131.606637ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.874172Z","caller":"traceutil/trace.go:171","msg":"trace[812912415] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"133.516447ms","start":"2026-05-09T21:40:13.740629Z","end":"2026-05-09T21:40:13.874145Z","steps":["trace[812912415] 'process raft request' (duration: 131.955301ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.874446Z","caller":"traceutil/trace.go:171","msg":"trace[1815832209] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"125.506424ms","start":"2026-05-09T21:40:13.748924Z","end":"2026-05-09T21:40:13.87443Z","steps":["trace[1815832209] 'process raft request' (duration: 124.234251ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.874533Z","caller":"traceutil/trace.go:171","msg":"trace[11008867] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"133.841511ms","start":"2026-05-09T21:40:13.740685Z","end":"2026-05-09T21:40:13.874526Z","steps":["trace[11008867] 'process raft request' (duration: 132.349295ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.874588Z","caller":"traceutil/trace.go:171","msg":"trace[1128205840] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"124.666615ms","start":"2026-05-09T21:40:13.749916Z","end":"2026-05-09T21:40:13.874582Z","steps":["trace[1128205840] 'process raft request' (duration: 123.367202ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:13.874474Z","caller":"traceutil/trace.go:171","msg":"trace[1310893285] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"119.643242ms","start":"2026-05-09T21:40:13.754783Z","end":"2026-05-09T21:40:13.874427Z","steps":["trace[1310893285] 'process raft request' (duration: 118.590042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:14.096076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.301791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:40:14.096202Z","caller":"traceutil/trace.go:171","msg":"trace[1716841489] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"132.332504ms","start":"2026-05-09T21:40:13.963852Z","end":"2026-05-09T21:40:14.096185Z","steps":["trace[1716841489] 'compare' (duration: 127.065279ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:14.125047Z","caller":"traceutil/trace.go:171","msg":"trace[1836874359] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"157.422053ms","start":"2026-05-09T21:40:13.967595Z","end":"2026-05-09T21:40:14.125017Z","steps":["trace[1836874359] 'process raft request' (duration: 157.184391ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:14.13163Z","caller":"traceutil/trace.go:171","msg":"trace[800564197] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"156.230651ms","start":"2026-05-09T21:40:13.975378Z","end":"2026-05-09T21:40:14.131609Z","steps":["trace[800564197] 'process raft request' (duration: 156.016959ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:14.131966Z","caller":"traceutil/trace.go:171","msg":"trace[1916376914] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"140.395924ms","start":"2026-05-09T21:40:13.991548Z","end":"2026-05-09T21:40:14.131944Z","steps":["trace[1916376914] 'process raft request' (duration: 139.98023ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:15.314753Z","caller":"traceutil/trace.go:171","msg":"trace[2107570423] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"284.737087ms","start":"2026-05-09T21:40:15.030002Z","end":"2026-05-09T21:40:15.314739Z","steps":["trace[2107570423] 'read index received' (duration: 231.036237ms)","trace[2107570423] 'applied index is now lower than readState.Index' (duration: 53.70026ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:15.314873Z","caller":"traceutil/trace.go:171","msg":"trace[1870995705] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"286.396873ms","start":"2026-05-09T21:40:15.028433Z","end":"2026-05-09T21:40:15.31483Z","steps":["trace[1870995705] 'process raft request' (duration: 232.520351ms)","trace[1870995705] 'compare' (duration: 53.259375ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:40:15.314955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.943519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-05-09T21:40:15.314987Z","caller":"traceutil/trace.go:171","msg":"trace[1877762029] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:581; }","duration":"284.988439ms","start":"2026-05-09T21:40:15.02999Z","end":"2026-05-09T21:40:15.314979Z","steps":["trace[1877762029] 'agreement among raft nodes before linearized reading' (duration: 284.837727ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:15.323814Z","caller":"traceutil/trace.go:171","msg":"trace[121737686] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"244.057499ms","start":"2026-05-09T21:40:15.079733Z","end":"2026-05-09T21:40:15.323791Z","steps":["trace[121737686] 'process raft request' (duration: 243.229161ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:20.901642Z","caller":"traceutil/trace.go:171","msg":"trace[223705283] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"136.859194ms","start":"2026-05-09T21:40:20.764757Z","end":"2026-05-09T21:40:20.901616Z","steps":["trace[223705283] 'process raft request' (duration: 136.276957ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:40:21.419966Z","caller":"traceutil/trace.go:171","msg":"trace[264959327] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"111.645838ms","start":"2026-05-09T21:40:21.308296Z","end":"2026-05-09T21:40:21.419941Z","steps":["trace[264959327] 'read index received' (duration: 111.442465ms)","trace[264959327] 'applied index is now lower than readState.Index' (duration: 202.273µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:40:21.420055Z","caller":"traceutil/trace.go:171","msg":"trace[1353132583] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"460.879865ms","start":"2026-05-09T21:40:20.959151Z","end":"2026-05-09T21:40:21.420031Z","steps":["trace[1353132583] 'process raft request' (duration: 460.658531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:40:21.420154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:40:20.959125Z","time spent":"460.984435ms","remote":"127.0.0.1:42276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:40:21.420395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.082942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bjnmw\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-09T21:40:21.420451Z","caller":"traceutil/trace.go:171","msg":"trace[2019230906] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bjnmw; range_end:; response_count:1; response_revision:620; }","duration":"112.181523ms","start":"2026-05-09T21:40:21.308257Z","end":"2026-05-09T21:40:21.420438Z","steps":["trace[2019230906] 'agreement among raft nodes before linearized reading' (duration: 111.80889ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:04.124657Z","caller":"traceutil/trace.go:171","msg":"trace[26991007] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"114.450902ms","start":"2026-05-09T21:41:04.009996Z","end":"2026-05-09T21:41:04.124446Z","steps":["trace[26991007] 'process raft request' (duration: 114.306574ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:26.880144Z","caller":"traceutil/trace.go:171","msg":"trace[1947568895] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"188.558803ms","start":"2026-05-09T21:41:26.691551Z","end":"2026-05-09T21:41:26.88011Z","steps":["trace[1947568895] 'process raft request' (duration: 188.336024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:41:50.04909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.060691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f27a6f28-0255-46f3-b221-120792522934\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-09T21:41:50.0492Z","caller":"traceutil/trace.go:171","msg":"trace[1073468936] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f27a6f28-0255-46f3-b221-120792522934; range_end:; response_count:1; response_revision:1833; }","duration":"288.223617ms","start":"2026-05-09T21:41:49.760945Z","end":"2026-05-09T21:41:50.049168Z","steps":["trace[1073468936] 'range keys from in-memory index tree' (duration: 287.807443ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:50.212793Z","caller":"traceutil/trace.go:171","msg":"trace[405375299] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"159.639435ms","start":"2026-05-09T21:41:50.053122Z","end":"2026-05-09T21:41:50.212762Z","steps":["trace[405375299] 'process raft request' (duration: 145.496809ms)","trace[405375299] 'compare' (duration: 13.879368ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:41:50.213178Z","caller":"traceutil/trace.go:171","msg":"trace[2117607093] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"159.816682ms","start":"2026-05-09T21:41:50.05335Z","end":"2026-05-09T21:41:50.213167Z","steps":["trace[2117607093] 'process raft request' (duration: 159.361317ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:41:50.213809Z","caller":"traceutil/trace.go:171","msg":"trace[373820824] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"158.622544ms","start":"2026-05-09T21:41:50.055169Z","end":"2026-05-09T21:41:50.213792Z","steps":["trace[373820824] 'process raft request' (duration: 157.941273ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:03.3902Z","caller":"traceutil/trace.go:171","msg":"trace[646209849] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"138.208458ms","start":"2026-05-09T21:42:03.251962Z","end":"2026-05-09T21:42:03.390171Z","steps":["trace[646209849] 'process raft request' (duration: 138.050874ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:24.522818Z","caller":"traceutil/trace.go:171","msg":"trace[1634695097] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"151.81563ms","start":"2026-05-09T21:42:24.370973Z","end":"2026-05-09T21:42:24.522789Z","steps":["trace[1634695097] 'process raft request' (duration: 151.591395ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:24.531568Z","caller":"traceutil/trace.go:171","msg":"trace[755932107] linearizableReadLoop","detail":"{readStateIndex:2161; appliedIndex:2159; }","duration":"132.124195ms","start":"2026-05-09T21:42:24.399422Z","end":"2026-05-09T21:42:24.531546Z","steps":["trace[755932107] 'read index received' (duration: 123.139079ms)","trace[755932107] 'applied index is now lower than readState.Index' (duration: 8.984016ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:42:24.531614Z","caller":"traceutil/trace.go:171","msg":"trace[1289131052] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"160.250653ms","start":"2026-05-09T21:42:24.371344Z","end":"2026-05-09T21:42:24.531595Z","steps":["trace[1289131052] 'process raft request' (duration: 160.089909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:42:24.531755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.319609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:42:24.531866Z","caller":"traceutil/trace.go:171","msg":"trace[1331709747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2081; }","duration":"132.462563ms","start":"2026-05-09T21:42:24.399382Z","end":"2026-05-09T21:42:24.531844Z","steps":["trace[1331709747] 'agreement among raft nodes before linearized reading' (duration: 132.248648ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:24.767699Z","caller":"traceutil/trace.go:171","msg":"trace[1482884381] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"131.47166ms","start":"2026-05-09T21:42:24.636206Z","end":"2026-05-09T21:42:24.767678Z","steps":["trace[1482884381] 'process raft request' (duration: 131.322757ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:25.057637Z","caller":"traceutil/trace.go:171","msg":"trace[84409662] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"115.571286ms","start":"2026-05-09T21:42:24.942045Z","end":"2026-05-09T21:42:25.057616Z","steps":["trace[84409662] 'process raft request' (duration: 115.428203ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:01.93226Z","caller":"traceutil/trace.go:171","msg":"trace[1170580279] linearizableReadLoop","detail":"{readStateIndex:2816; appliedIndex:2815; }","duration":"124.92403ms","start":"2026-05-09T21:44:01.807308Z","end":"2026-05-09T21:44:01.932232Z","steps":["trace[1170580279] 'read index received' (duration: 41.621746ms)","trace[1170580279] 'applied index is now lower than readState.Index' (duration: 83.300904ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:01.932582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.255455ms","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-05-09T21:44:01.932702Z","caller":"traceutil/trace.go:171","msg":"trace[1528483852] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2713; }","duration":"125.409947ms","start":"2026-05-09T21:44:01.807276Z","end":"2026-05-09T21:44:01.932686Z","steps":["trace[1528483852] 'agreement among raft nodes before linearized reading' (duration: 125.151633ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:07.536692Z","caller":"traceutil/trace.go:171","msg":"trace[914497138] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"113.288ms","start":"2026-05-09T21:44:07.423378Z","end":"2026-05-09T21:44:07.536666Z","steps":["trace[914497138] 'process raft request' (duration: 113.128038ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:16.097931Z","caller":"traceutil/trace.go:171","msg":"trace[1655102770] transaction","detail":"{read_only:false; response_revision:3511; number_of_response:1; }","duration":"140.851768ms","start":"2026-05-09T21:46:15.957061Z","end":"2026-05-09T21:46:16.097913Z","steps":["trace[1655102770] 'process raft request' (duration: 42.032487ms)","trace[1655102770] 'compare' (duration: 98.755579ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:47:47.256533Z","caller":"traceutil/trace.go:171","msg":"trace[2128365652] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"121.934884ms","start":"2026-05-09T21:47:47.134562Z","end":"2026-05-09T21:47:47.256497Z","steps":["trace[2128365652] 'process raft request' (duration: 89.082837ms)","trace[2128365652] 'compare' (duration: 32.668553ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:47:52.746458Z","caller":"traceutil/trace.go:171","msg":"trace[2115997334] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"260.747083ms","start":"2026-05-09T21:47:52.485684Z","end":"2026-05-09T21:47:52.746431Z","steps":["trace[2115997334] 'process raft request' (duration: 260.488887ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:47:52.837755Z","caller":"traceutil/trace.go:171","msg":"trace[1088338052] linearizableReadLoop","detail":"{readStateIndex:4851; appliedIndex:4846; }","duration":"298.430976ms","start":"2026-05-09T21:47:52.539306Z","end":"2026-05-09T21:47:52.837737Z","steps":["trace[1088338052] 'read index received' (duration: 207.033542ms)","trace[1088338052] 'applied index is now lower than readState.Index' (duration: 91.396624ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:47:52.837841Z","caller":"traceutil/trace.go:171","msg":"trace[752061791] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"344.576018ms","start":"2026-05-09T21:47:52.493242Z","end":"2026-05-09T21:47:52.837818Z","steps":["trace[752061791] 'process raft request' (duration: 344.411774ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:47:52.83784Z","caller":"traceutil/trace.go:171","msg":"trace[1202893651] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"346.229077ms","start":"2026-05-09T21:47:52.491575Z","end":"2026-05-09T21:47:52.837804Z","steps":["trace[1202893651] 'process raft request' (duration: 346.041053ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:47:52.837889Z","caller":"traceutil/trace.go:171","msg":"trace[594731579] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"344.070086ms","start":"2026-05-09T21:47:52.493788Z","end":"2026-05-09T21:47:52.837858Z","steps":["trace[594731579] 'process raft request' (duration: 343.896472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:52.837984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:47:52.491567Z","time spent":"346.351831ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1145,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:47:52.838023Z","caller":"traceutil/trace.go:171","msg":"trace[1116212654] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"347.018246ms","start":"2026-05-09T21:47:52.490999Z","end":"2026-05-09T21:47:52.838017Z","steps":["trace[1116212654] 'process raft request' (duration: 346.522584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:52.83802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:47:52.493778Z","time spent":"344.180379ms","remote":"127.0.0.1:42148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":808,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:47:52.838052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:47:52.490949Z","time spent":"347.090267ms","remote":"127.0.0.1:42200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":664,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:47:52.837984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.659672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:47:52.837928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:47:52.493222Z","time spent":"344.66498ms","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T21:47:52.838217Z","caller":"traceutil/trace.go:171","msg":"trace[1006489366] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4673; }","duration":"298.941278ms","start":"2026-05-09T21:47:52.539263Z","end":"2026-05-09T21:47:52.838205Z","steps":["trace[1006489366] 'agreement among raft nodes before linearized reading' (duration: 298.657002ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:47:52.881186Z","caller":"traceutil/trace.go:171","msg":"trace[670545667] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"128.880421ms","start":"2026-05-09T21:47:52.75227Z","end":"2026-05-09T21:47:52.881151Z","steps":["trace[670545667] 'process raft request' (duration: 128.630105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:52.881595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.667427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-09T21:47:52.881801Z","caller":"traceutil/trace.go:171","msg":"trace[734181559] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4677; }","duration":"338.907303ms","start":"2026-05-09T21:47:52.542882Z","end":"2026-05-09T21:47:52.881789Z","steps":["trace[734181559] 'agreement among raft nodes before linearized reading' (duration: 338.607416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:52.881871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:47:52.542871Z","time spent":"338.979956ms","remote":"127.0.0.1:42196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-09T21:47:52.881572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.866176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-09T21:47:52.882024Z","caller":"traceutil/trace.go:171","msg":"trace[341346542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4677; }","duration":"302.361239ms","start":"2026-05-09T21:47:52.579645Z","end":"2026-05-09T21:47:52.882007Z","steps":["trace[341346542] 'agreement among raft nodes before linearized reading' (duration: 301.819625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:52.882088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:47:52.579626Z","time spent":"302.44175ms","remote":"127.0.0.1:42304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-09T21:47:52.881247Z","caller":"traceutil/trace.go:171","msg":"trace[1913712650] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"129.108497ms","start":"2026-05-09T21:47:52.752116Z","end":"2026-05-09T21:47:52.881224Z","steps":["trace[1913712650] 'process raft request' (duration: 107.952936ms)","trace[1913712650] 'compare' (duration: 20.625508ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:47:52.881886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.092384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:47:52.88225Z","caller":"traceutil/trace.go:171","msg":"trace[182284741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4677; }","duration":"139.485612ms","start":"2026-05-09T21:47:52.742748Z","end":"2026-05-09T21:47:52.882234Z","steps":["trace[182284741] 'agreement among raft nodes before linearized reading' (duration: 139.108093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:52.882679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.548299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-05-09T21:47:52.882714Z","caller":"traceutil/trace.go:171","msg":"trace[2120043104] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4677; }","duration":"132.658301ms","start":"2026-05-09T21:47:52.750047Z","end":"2026-05-09T21:47:52.882705Z","steps":["trace[2120043104] 'agreement among raft nodes before linearized reading' (duration: 131.570955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:53.291165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.671553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:47:53.291326Z","caller":"traceutil/trace.go:171","msg":"trace[255859501] linearizableReadLoop","detail":"{readStateIndex:4869; appliedIndex:4867; }","duration":"272.864924ms","start":"2026-05-09T21:47:53.018443Z","end":"2026-05-09T21:47:53.291308Z","steps":["trace[255859501] 'read index received' (duration: 118.17977ms)","trace[255859501] 'applied index is now lower than readState.Index' (duration: 154.684224ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:47:53.291398Z","caller":"traceutil/trace.go:171","msg":"trace[2146641818] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"273.337165ms","start":"2026-05-09T21:47:53.01805Z","end":"2026-05-09T21:47:53.291387Z","steps":["trace[2146641818] 'process raft request' (duration: 273.202862ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:47:53.291503Z","caller":"traceutil/trace.go:171","msg":"trace[383034449] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"273.582401ms","start":"2026-05-09T21:47:53.017879Z","end":"2026-05-09T21:47:53.291461Z","steps":["trace[383034449] 'process raft request' (duration: 118.557309ms)","trace[383034449] 'compare' (duration: 154.340075ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:47:53.291701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.248153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-09T21:47:53.29174Z","caller":"traceutil/trace.go:171","msg":"trace[247193523] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4691; }","duration":"273.311945ms","start":"2026-05-09T21:47:53.018418Z","end":"2026-05-09T21:47:53.29173Z","steps":["trace[247193523] 'agreement among raft nodes before linearized reading' (duration: 273.155981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:53.310085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.274102ms","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-05-09T21:47:53.310137Z","caller":"traceutil/trace.go:171","msg":"trace[499784789] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4692; }","duration":"198.360404ms","start":"2026-05-09T21:47:53.111767Z","end":"2026-05-09T21:47:53.310127Z","steps":["trace[499784789] 'agreement among raft nodes before linearized reading' (duration: 198.276632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:47:53.310933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.446688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195922"} {"level":"info","ts":"2026-05-09T21:47:53.310962Z","caller":"traceutil/trace.go:171","msg":"trace[164876211] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4692; }","duration":"190.52827ms","start":"2026-05-09T21:47:53.120428Z","end":"2026-05-09T21:47:53.310956Z","steps":["trace[164876211] 'agreement among raft nodes before linearized reading' (duration: 189.747041ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:47:53.465659Z","caller":"traceutil/trace.go:171","msg":"trace[1448533284] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4873; }","duration":"103.078405ms","start":"2026-05-09T21:47:53.36256Z","end":"2026-05-09T21:47:53.465639Z","steps":["trace[1448533284] 'read index received' (duration: 90.18309ms)","trace[1448533284] 'applied index is now lower than readState.Index' (duration: 12.894375ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:47:53.465699Z","caller":"traceutil/trace.go:171","msg":"trace[404763627] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"104.404436ms","start":"2026-05-09T21:47:53.361277Z","end":"2026-05-09T21:47:53.465681Z","steps":["trace[404763627] 'process raft request' (duration: 91.510891ms)","trace[404763627] 'compare' (duration: 12.6971ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:47:53.466257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.677729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-05-09T21:47:53.466352Z","caller":"traceutil/trace.go:171","msg":"trace[1029225235] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4696; }","duration":"103.789341ms","start":"2026-05-09T21:47:53.362548Z","end":"2026-05-09T21:47:53.466337Z","steps":["trace[1029225235] 'agreement among raft nodes before linearized reading' (duration: 103.234948ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:48:44.518865Z","caller":"traceutil/trace.go:171","msg":"trace[1821318639] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"109.767484ms","start":"2026-05-09T21:48:44.409077Z","end":"2026-05-09T21:48:44.518845Z","steps":["trace[1821318639] 'process raft request' (duration: 109.624061ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:49:43.506262Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2932} {"level":"info","ts":"2026-05-09T21:49:43.579741Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2932,"took":"72.071262ms","hash":3951616948,"current-db-size-bytes":52875264,"current-db-size":"53 MB","current-db-size-in-use-bytes":29532160,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-09T21:49:43.579875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3951616948,"revision":2932,"compact-revision":-1} {"level":"info","ts":"2026-05-09T21:54:43.51138Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5677} {"level":"info","ts":"2026-05-09T21:54:43.581294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5677,"took":"68.217587ms","hash":1521111113,"current-db-size-bytes":52875264,"current-db-size":"53 MB","current-db-size-in-use-bytes":18272256,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-09T21:54:43.581344Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1521111113,"revision":5677,"compact-revision":2932}