{"level":"warn","ts":"2026-04-09T22:28:59.311894Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T22:28:59.312002Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33: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.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33: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-04-09T22:28:59.312082Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T22:28:59.312094Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-09T22:28:59.312117Z","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-04-09T22:28:59.312751Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-04-09T22:28:59.312843Z","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.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33: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-04-09T22:28:59.316669Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.597683ms"} {"level":"info","ts":"2026-04-09T22:28:59.327126Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-04-09T22:28:59.327235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T22:28:59.327268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-04-09T22:28:59.327301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T22:28:59.327319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-04-09T22:28:59.327372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-04-09T22:28:59.334664Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T22:28:59.33776Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T22:28:59.338892Z","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-04-09T22:28:59.342105Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T22:28:59.342502Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T22:28:59.342484Z","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-04-09T22:28:59.342715Z","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-04-09T22:28:59.34274Z","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-04-09T22:28:59.34555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-04-09T22:28:59.345678Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-09T22:28:59.349427Z","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-04-09T22:28:59.349512Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-09T22:28:59.349579Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-09T22:28:59.349902Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T22:28:59.349936Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T22:28:59.827927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T22:28:59.827988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T22:28:59.828022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-04-09T22:28:59.828042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-04-09T22:28:59.828054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-09T22:28:59.828069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-04-09T22:28:59.82813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-09T22:28:59.82934Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:28:59.829635Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T22:28:59.829844Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T22:28:59.829876Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T22:28:59.830344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T22:28:59.830366Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T22:28:59.831427Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:28:59.831499Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:28:59.831518Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:28:59.833303Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T22:28:59.833957Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"warn","ts":"2026-04-09T22:29:05.614596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.288576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T22:29:05.614747Z","caller":"traceutil/trace.go:171","msg":"trace[1851137649] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"183.281418ms","start":"2026-04-09T22:29:05.431428Z","end":"2026-04-09T22:29:05.614709Z","steps":["trace[1851137649] 'process raft request' (duration: 30.467842ms)","trace[1851137649] 'compare' (duration: 151.970091ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:29:06.02629Z","caller":"traceutil/trace.go:171","msg":"trace[631478581] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"405.04072ms","start":"2026-04-09T22:29:05.62122Z","end":"2026-04-09T22:29:06.026261Z","steps":["trace[631478581] 'process raft request' (duration: 404.856276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:06.026427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:29:05.621203Z","time spent":"405.159901ms","remote":"127.0.0.1:47368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-09T22:29:06.064484Z","caller":"traceutil/trace.go:171","msg":"trace[1846212041] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:251; }","duration":"375.674435ms","start":"2026-04-09T22:29:05.688778Z","end":"2026-04-09T22:29:06.064453Z","steps":["trace[1846212041] 'read index received' (duration: 337.282842ms)","trace[1846212041] 'applied index is now lower than readState.Index' (duration: 38.390653ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:29:06.064617Z","caller":"traceutil/trace.go:171","msg":"trace[1250785438] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"433.196951ms","start":"2026-04-09T22:29:05.631355Z","end":"2026-04-09T22:29:06.064552Z","steps":["trace[1250785438] 'process raft request' (duration: 432.951417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:06.064686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.879728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T22:29:06.06471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:29:05.631336Z","time spent":"433.329394ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-09T22:29:06.064727Z","caller":"traceutil/trace.go:171","msg":"trace[1371043487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:243; }","duration":"375.981821ms","start":"2026-04-09T22:29:05.688734Z","end":"2026-04-09T22:29:06.064715Z","steps":["trace[1371043487] 'agreement among raft nodes before linearized reading' (duration: 375.843219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:06.064779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:29:05.688711Z","time spent":"376.058452ms","remote":"127.0.0.1:47368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-09T22:29:06.067362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.831573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:29:06.067482Z","caller":"traceutil/trace.go:171","msg":"trace[2036264984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:244; }","duration":"377.995435ms","start":"2026-04-09T22:29:05.689461Z","end":"2026-04-09T22:29:06.067456Z","steps":["trace[2036264984] 'agreement among raft nodes before linearized reading' (duration: 377.784252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:06.067572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:29:05.689453Z","time spent":"378.082716ms","remote":"127.0.0.1:47368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T22:29:06.067635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.155113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:29:06.067714Z","caller":"traceutil/trace.go:171","msg":"trace[1131993569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:244; }","duration":"288.278844ms","start":"2026-04-09T22:29:05.779417Z","end":"2026-04-09T22:29:06.067696Z","steps":["trace[1131993569] 'agreement among raft nodes before linearized reading' (duration: 288.141612ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.715214Z","caller":"traceutil/trace.go:171","msg":"trace[946281874] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:495; }","duration":"169.658842ms","start":"2026-04-09T22:29:29.545536Z","end":"2026-04-09T22:29:29.715195Z","steps":["trace[946281874] 'read index received' (duration: 169.495199ms)","trace[946281874] 'applied index is now lower than readState.Index' (duration: 162.863µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:29:29.7153Z","caller":"traceutil/trace.go:171","msg":"trace[1872801540] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"192.691973ms","start":"2026-04-09T22:29:29.522583Z","end":"2026-04-09T22:29:29.715275Z","steps":["trace[1872801540] 'process raft request' (duration: 192.302415ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.715378Z","caller":"traceutil/trace.go:171","msg":"trace[1304770497] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"184.127967ms","start":"2026-04-09T22:29:29.531234Z","end":"2026-04-09T22:29:29.715362Z","steps":["trace[1304770497] 'process raft request' (duration: 183.895002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:29.715449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.869415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-04-09T22:29:29.715462Z","caller":"traceutil/trace.go:171","msg":"trace[2018152703] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"192.659323ms","start":"2026-04-09T22:29:29.522793Z","end":"2026-04-09T22:29:29.715452Z","steps":["trace[2018152703] 'process raft request' (duration: 192.242046ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.715495Z","caller":"traceutil/trace.go:171","msg":"trace[1248983253] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:480; }","duration":"169.976168ms","start":"2026-04-09T22:29:29.545509Z","end":"2026-04-09T22:29:29.715485Z","steps":["trace[1248983253] 'agreement among raft nodes before linearized reading' (duration: 169.835275ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.71555Z","caller":"traceutil/trace.go:171","msg":"trace[903382511] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"192.738334ms","start":"2026-04-09T22:29:29.522805Z","end":"2026-04-09T22:29:29.715544Z","steps":["trace[903382511] 'process raft request' (duration: 192.263585ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.715468Z","caller":"traceutil/trace.go:171","msg":"trace[99426330] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"180.107973ms","start":"2026-04-09T22:29:29.535326Z","end":"2026-04-09T22:29:29.715434Z","steps":["trace[99426330] 'process raft request' (duration: 179.837778ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.715678Z","caller":"traceutil/trace.go:171","msg":"trace[828647298] transaction","detail":"{read_only:false; number_of_response:1; response_revision:478; }","duration":"188.303923ms","start":"2026-04-09T22:29:29.526986Z","end":"2026-04-09T22:29:29.71529Z","steps":["trace[828647298] 'process raft request' (duration: 188.10743ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.723008Z","caller":"traceutil/trace.go:171","msg":"trace[1450834505] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"177.189599ms","start":"2026-04-09T22:29:29.545794Z","end":"2026-04-09T22:29:29.722983Z","steps":["trace[1450834505] 'process raft request' (duration: 176.574908ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.723072Z","caller":"traceutil/trace.go:171","msg":"trace[1828794087] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"171.803119ms","start":"2026-04-09T22:29:29.551252Z","end":"2026-04-09T22:29:29.723055Z","steps":["trace[1828794087] 'process raft request' (duration: 171.497074ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:29.724367Z","caller":"traceutil/trace.go:171","msg":"trace[1526752337] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"160.668966ms","start":"2026-04-09T22:29:29.56367Z","end":"2026-04-09T22:29:29.724339Z","steps":["trace[1526752337] 'process raft request' (duration: 159.130578ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:36.077033Z","caller":"traceutil/trace.go:171","msg":"trace[1571498680] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"286.521623ms","start":"2026-04-09T22:29:35.79048Z","end":"2026-04-09T22:29:36.077002Z","steps":["trace[1571498680] 'process raft request' (duration: 271.893266ms)","trace[1571498680] 'compare' (duration: 14.259561ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:29:36.438116Z","caller":"traceutil/trace.go:171","msg":"trace[1830285172] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"267.986743ms","start":"2026-04-09T22:29:36.170102Z","end":"2026-04-09T22:29:36.438089Z","steps":["trace[1830285172] 'read index received' (duration: 267.849011ms)","trace[1830285172] 'applied index is now lower than readState.Index' (duration: 136.762µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:29:36.438264Z","caller":"traceutil/trace.go:171","msg":"trace[1807321074] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"306.446789ms","start":"2026-04-09T22:29:36.131807Z","end":"2026-04-09T22:29:36.438254Z","steps":["trace[1807321074] 'process raft request' (duration: 306.155214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:36.438377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:29:36.131769Z","time spent":"306.526621ms","remote":"127.0.0.1:47346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-09T22:29:36.438476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.128595ms","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-04-09T22:29:36.438568Z","caller":"traceutil/trace.go:171","msg":"trace[183824755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"232.262349ms","start":"2026-04-09T22:29:36.206284Z","end":"2026-04-09T22:29:36.438546Z","steps":["trace[183824755] 'agreement among raft nodes before linearized reading' (duration: 232.034824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:36.438671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.180686ms","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-04-09T22:29:36.438722Z","caller":"traceutil/trace.go:171","msg":"trace[1721480720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"215.265017ms","start":"2026-04-09T22:29:36.223444Z","end":"2026-04-09T22:29:36.438709Z","steps":["trace[1721480720] 'agreement among raft nodes before linearized reading' (duration: 215.134955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:36.438773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.668806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-knv57\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-09T22:29:36.438893Z","caller":"traceutil/trace.go:171","msg":"trace[1930196464] range","detail":"{range_begin:/registry/pods/kube-system/cilium-knv57; range_end:; response_count:1; response_revision:578; }","duration":"268.823329ms","start":"2026-04-09T22:29:36.170057Z","end":"2026-04-09T22:29:36.43888Z","steps":["trace[1930196464] 'agreement among raft nodes before linearized reading' (duration: 268.657916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:36.438865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.954058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-09T22:29:36.439039Z","caller":"traceutil/trace.go:171","msg":"trace[154022692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"217.145861ms","start":"2026-04-09T22:29:36.221852Z","end":"2026-04-09T22:29:36.438998Z","steps":["trace[154022692] 'agreement among raft nodes before linearized reading' (duration: 216.768114ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:36.60611Z","caller":"traceutil/trace.go:171","msg":"trace[1777557731] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"162.563901ms","start":"2026-04-09T22:29:36.443525Z","end":"2026-04-09T22:29:36.606089Z","steps":["trace[1777557731] 'process raft request' (duration: 154.432961ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:36.606167Z","caller":"traceutil/trace.go:171","msg":"trace[563832299] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:601; }","duration":"159.958833ms","start":"2026-04-09T22:29:36.446184Z","end":"2026-04-09T22:29:36.606143Z","steps":["trace[563832299] 'read index received' (duration: 22.597494ms)","trace[563832299] 'applied index is now lower than readState.Index' (duration: 137.360369ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:29:36.606261Z","caller":"traceutil/trace.go:171","msg":"trace[1852991011] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"162.497129ms","start":"2026-04-09T22:29:36.443756Z","end":"2026-04-09T22:29:36.606253Z","steps":["trace[1852991011] 'process raft request' (duration: 162.223655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:36.60629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.081865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-09T22:29:36.606325Z","caller":"traceutil/trace.go:171","msg":"trace[120176264] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:582; }","duration":"160.152637ms","start":"2026-04-09T22:29:36.446161Z","end":"2026-04-09T22:29:36.606314Z","steps":["trace[120176264] 'agreement among raft nodes before linearized reading' (duration: 160.066565ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:36.606298Z","caller":"traceutil/trace.go:171","msg":"trace[200364105] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"155.313408ms","start":"2026-04-09T22:29:36.450947Z","end":"2026-04-09T22:29:36.606261Z","steps":["trace[200364105] 'process raft request' (duration: 155.144865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:29:51.976935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.692184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T22:29:51.976988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.076539ms","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-04-09T22:29:51.977027Z","caller":"traceutil/trace.go:171","msg":"trace[681292923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"197.824077ms","start":"2026-04-09T22:29:51.779184Z","end":"2026-04-09T22:29:51.977008Z","steps":["trace[681292923] 'range keys from in-memory index tree' (duration: 197.634563ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:29:51.977066Z","caller":"traceutil/trace.go:171","msg":"trace[866558919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:739; }","duration":"121.189722ms","start":"2026-04-09T22:29:51.855859Z","end":"2026-04-09T22:29:51.977048Z","steps":["trace[866558919] 'range keys from in-memory index tree' (duration: 120.913697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:30:25.182296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.343358ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T22:30:25.182381Z","caller":"traceutil/trace.go:171","msg":"trace[496606958] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"282.942801ms","start":"2026-04-09T22:30:24.899424Z","end":"2026-04-09T22:30:25.182367Z","steps":["trace[496606958] 'process raft request' (duration: 120.343219ms)","trace[496606958] 'compare' (duration: 162.170775ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:30:47.652207Z","caller":"traceutil/trace.go:171","msg":"trace[193035669] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"164.890154ms","start":"2026-04-09T22:30:47.487288Z","end":"2026-04-09T22:30:47.652178Z","steps":["trace[193035669] 'process raft request' (duration: 164.736731ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:30:47.720855Z","caller":"traceutil/trace.go:171","msg":"trace[44668882] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"178.786568ms","start":"2026-04-09T22:30:47.54205Z","end":"2026-04-09T22:30:47.720837Z","steps":["trace[44668882] 'process raft request' (duration: 162.733034ms)","trace[44668882] 'compare' (duration: 15.975842ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:17.637657Z","caller":"traceutil/trace.go:171","msg":"trace[1033974480] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"128.065661ms","start":"2026-04-09T22:31:17.509568Z","end":"2026-04-09T22:31:17.637633Z","steps":["trace[1033974480] 'process raft request' (duration: 127.648213ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:18.39528Z","caller":"traceutil/trace.go:171","msg":"trace[1077455786] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1245; }","duration":"102.473242ms","start":"2026-04-09T22:31:18.292784Z","end":"2026-04-09T22:31:18.395257Z","steps":["trace[1077455786] 'read index received' (duration: 3.744777ms)","trace[1077455786] 'applied index is now lower than readState.Index' (duration: 98.726095ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:31:18.395402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.598624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-09T22:31:18.395379Z","caller":"traceutil/trace.go:171","msg":"trace[845420475] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"137.267839ms","start":"2026-04-09T22:31:18.258079Z","end":"2026-04-09T22:31:18.395347Z","steps":["trace[845420475] 'process raft request' (duration: 38.501633ms)","trace[845420475] 'compare' (duration: 98.577702ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:18.395428Z","caller":"traceutil/trace.go:171","msg":"trace[2124234032] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1197; }","duration":"102.678976ms","start":"2026-04-09T22:31:18.292741Z","end":"2026-04-09T22:31:18.39542Z","steps":["trace[2124234032] 'agreement among raft nodes before linearized reading' (duration: 102.594905ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:18.690655Z","caller":"traceutil/trace.go:171","msg":"trace[1572728604] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"274.461727ms","start":"2026-04-09T22:31:18.416166Z","end":"2026-04-09T22:31:18.690627Z","steps":["trace[1572728604] 'process raft request' (duration: 274.230893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:31.04018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.594974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-04-09T22:31:31.040332Z","caller":"traceutil/trace.go:171","msg":"trace[1220272756] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1295; }","duration":"188.868618ms","start":"2026-04-09T22:31:30.851438Z","end":"2026-04-09T22:31:31.040307Z","steps":["trace[1220272756] 'range keys from in-memory index tree' (duration: 188.179016ms)"],"step_count":1}