{"level":"warn","ts":"2026-10-15T06:29:18.927423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:29:18.927521Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-10-15T06:29:18.927589Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:29:18.927602Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-10-15T06:29:18.927623Z","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-10-15T06:29:18.928475Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-10-15T06:29:18.928555Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-10-15T06:29:18.931332Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.557827ms"} {"level":"info","ts":"2026-10-15T06:29:18.940365Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-10-15T06:29:18.940534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T06:29:18.940558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-10-15T06:29:18.940566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T06:29:18.940571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-10-15T06:29:18.94062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-10-15T06:29:18.946696Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T06:29:18.948404Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T06:29:18.949949Z","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-10-15T06:29:18.951849Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T06:29:18.952088Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T06:29:18.95208Z","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-10-15T06:29:18.952178Z","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-10-15T06:29:18.952191Z","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-10-15T06:29:18.954768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-10-15T06:29:18.954908Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-10-15T06:29:18.955838Z","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-10-15T06:29:18.95604Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T06:29:18.956087Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T06:29:18.956133Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-10-15T06:29:18.956198Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-10-15T06:29:19.74171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T06:29:19.741751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T06:29:19.741765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-10-15T06:29:19.741776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-10-15T06:29:19.741781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-10-15T06:29:19.741797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-10-15T06:29:19.741804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-10-15T06:29:19.74303Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:29:19.74393Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T06:29:19.744084Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:29:19.744143Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:29:19.745023Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:29:19.745149Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:29:19.745186Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:29:19.746365Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T06:29:19.747421Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-10-15T06:29:19.755245Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T06:29:19.755302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T06:29:40.665972Z","caller":"traceutil/trace.go:171","msg":"trace[1859787541] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"103.349309ms","start":"2026-10-15T06:29:40.562593Z","end":"2026-10-15T06:29:40.665943Z","steps":["trace[1859787541] 'process raft request' (duration: 103.191616ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:09.017737Z","caller":"traceutil/trace.go:171","msg":"trace[1463975651] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"279.156079ms","start":"2026-10-15T06:30:08.738531Z","end":"2026-10-15T06:30:09.017687Z","steps":["trace[1463975651] 'process raft request' (duration: 278.532216ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:09.017859Z","caller":"traceutil/trace.go:171","msg":"trace[732481250] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"264.435836ms","start":"2026-10-15T06:30:08.753382Z","end":"2026-10-15T06:30:09.017818Z","steps":["trace[732481250] 'read index received' (duration: 263.479104ms)","trace[732481250] 'applied index is now lower than readState.Index' (duration: 950.842µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:30:09.018331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.865539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-15T06:30:09.018526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.135001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fjtth\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-15T06:30:09.018588Z","caller":"traceutil/trace.go:171","msg":"trace[1825835280] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fjtth; range_end:; response_count:1; response_revision:604; }","duration":"265.241464ms","start":"2026-10-15T06:30:08.753329Z","end":"2026-10-15T06:30:09.01857Z","steps":["trace[1825835280] 'agreement among raft nodes before linearized reading' (duration: 264.633141ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:09.018657Z","caller":"traceutil/trace.go:171","msg":"trace[1245926391] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"185.119985ms","start":"2026-10-15T06:30:08.833394Z","end":"2026-10-15T06:30:09.018514Z","steps":["trace[1245926391] 'agreement among raft nodes before linearized reading' (duration: 184.643044ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:09.187633Z","caller":"traceutil/trace.go:171","msg":"trace[651301661] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"163.747845ms","start":"2026-10-15T06:30:09.023847Z","end":"2026-10-15T06:30:09.187595Z","steps":["trace[651301661] 'process raft request' (duration: 105.141038ms)","trace[651301661] 'compare' (duration: 58.520425ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:30:09.2038Z","caller":"traceutil/trace.go:171","msg":"trace[1857162663] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"164.88487ms","start":"2026-10-15T06:30:09.03888Z","end":"2026-10-15T06:30:09.203765Z","steps":["trace[1857162663] 'process raft request' (duration: 164.42984ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:09.204513Z","caller":"traceutil/trace.go:171","msg":"trace[1656389748] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"107.139393ms","start":"2026-10-15T06:30:09.097359Z","end":"2026-10-15T06:30:09.204498Z","steps":["trace[1656389748] 'process raft request' (duration: 106.07785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:09.505734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.171349ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:30:09.505841Z","caller":"traceutil/trace.go:171","msg":"trace[1372203691] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"287.595894ms","start":"2026-10-15T06:30:09.218231Z","end":"2026-10-15T06:30:09.505827Z","steps":["trace[1372203691] 'read index received' (duration: 135.745261ms)","trace[1372203691] 'applied index is now lower than readState.Index' (duration: 151.849413ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:30:09.505892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.669395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:09.505914Z","caller":"traceutil/trace.go:171","msg":"trace[350411610] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:608; }","duration":"287.719887ms","start":"2026-10-15T06:30:09.218184Z","end":"2026-10-15T06:30:09.505904Z","steps":["trace[350411610] 'agreement among raft nodes before linearized reading' (duration: 287.679996ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:09.505889Z","caller":"traceutil/trace.go:171","msg":"trace[1341843363] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"293.785871ms","start":"2026-10-15T06:30:09.212069Z","end":"2026-10-15T06:30:09.505855Z","steps":["trace[1341843363] 'process raft request' (duration: 141.976398ms)","trace[1341843363] 'compare' (duration: 151.032406ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:30:10.134009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.236776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:30:10.134096Z","caller":"traceutil/trace.go:171","msg":"trace[816103416] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"519.889426ms","start":"2026-10-15T06:30:09.614193Z","end":"2026-10-15T06:30:10.134082Z","steps":["trace[816103416] 'read index received' (duration: 320.385635ms)","trace[816103416] 'applied index is now lower than readState.Index' (duration: 199.502791ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:30:10.134288Z","caller":"traceutil/trace.go:171","msg":"trace[927585740] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"531.424228ms","start":"2026-10-15T06:30:09.60278Z","end":"2026-10-15T06:30:10.134204Z","steps":["trace[927585740] 'process raft request' (duration: 331.920997ms)","trace[927585740] 'compare' (duration: 199.139544ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:30:10.134433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:30:09.602761Z","time spent":"531.574082ms","remote":"127.0.0.1:49254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:30:10.134606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.407047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-15T06:30:10.134863Z","caller":"traceutil/trace.go:171","msg":"trace[1364446259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"520.687393ms","start":"2026-10-15T06:30:09.614152Z","end":"2026-10-15T06:30:10.134839Z","steps":["trace[1364446259] 'agreement among raft nodes before linearized reading' (duration: 520.300745ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:10.134935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:30:09.614119Z","time spent":"520.798256ms","remote":"127.0.0.1:49254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T06:30:10.156551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.693023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:10.156613Z","caller":"traceutil/trace.go:171","msg":"trace[1015745956] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"261.735287ms","start":"2026-10-15T06:30:09.894851Z","end":"2026-10-15T06:30:10.156587Z","steps":["trace[1015745956] 'process raft request' (duration: 260.948339ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:10.156655Z","caller":"traceutil/trace.go:171","msg":"trace[361434210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"167.842485ms","start":"2026-10-15T06:30:09.988793Z","end":"2026-10-15T06:30:10.156636Z","steps":["trace[361434210] 'agreement among raft nodes before linearized reading' (duration: 167.63442ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:25.4371Z","caller":"traceutil/trace.go:171","msg":"trace[2102552179] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"176.497365ms","start":"2026-10-15T06:30:25.260573Z","end":"2026-10-15T06:30:25.43707Z","steps":["trace[2102552179] 'process raft request' (duration: 176.346612ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:04.402248Z","caller":"traceutil/trace.go:171","msg":"trace[1364188262] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"157.098999ms","start":"2026-10-15T06:31:04.245129Z","end":"2026-10-15T06:31:04.402228Z","steps":["trace[1364188262] 'process raft request' (duration: 156.987097ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:22.09482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.267499ms","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-10-15T06:31:22.094896Z","caller":"traceutil/trace.go:171","msg":"trace[227672341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1115; }","duration":"111.414682ms","start":"2026-10-15T06:31:21.983464Z","end":"2026-10-15T06:31:22.094879Z","steps":["trace[227672341] 'range keys from in-memory index tree' (duration: 111.070394ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:22.204064Z","caller":"traceutil/trace.go:171","msg":"trace[1114347810] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"105.729933ms","start":"2026-10-15T06:31:22.098314Z","end":"2026-10-15T06:31:22.204044Z","steps":["trace[1114347810] 'process raft request' (duration: 105.59229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:22.543537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.491191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:31:22.543724Z","caller":"traceutil/trace.go:171","msg":"trace[1451365083] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"444.870133ms","start":"2026-10-15T06:31:22.098796Z","end":"2026-10-15T06:31:22.543666Z","steps":["trace[1451365083] 'process raft request' (duration: 283.166027ms)","trace[1451365083] 'compare' (duration: 161.319448ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:22.543854Z","caller":"traceutil/trace.go:171","msg":"trace[1008242275] linearizableReadLoop","detail":"{readStateIndex:1163; appliedIndex:1162; }","duration":"327.197958ms","start":"2026-10-15T06:31:22.216602Z","end":"2026-10-15T06:31:22.5438Z","steps":["trace[1008242275] 'read index received' (duration: 165.329798ms)","trace[1008242275] 'applied index is now lower than readState.Index' (duration: 161.86543ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:22.543948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:22.098786Z","time spent":"445.038947ms","remote":"127.0.0.1:49254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:31:22.544005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.383462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:22.544084Z","caller":"traceutil/trace.go:171","msg":"trace[469814578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1118; }","duration":"327.478504ms","start":"2026-10-15T06:31:22.216579Z","end":"2026-10-15T06:31:22.544057Z","steps":["trace[469814578] 'agreement among raft nodes before linearized reading' (duration: 327.368321ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:22.544134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:22.216568Z","time spent":"327.554696ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T06:31:23.37025Z","caller":"traceutil/trace.go:171","msg":"trace[2110749572] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"326.368139ms","start":"2026-10-15T06:31:23.043846Z","end":"2026-10-15T06:31:23.370214Z","steps":["trace[2110749572] 'process raft request' (duration: 265.562467ms)","trace[2110749572] 'compare' (duration: 60.330301ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:23.370384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:23.043821Z","time spent":"326.491911ms","remote":"127.0.0.1:49052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:31:23.37054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.618111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:23.370641Z","caller":"traceutil/trace.go:171","msg":"trace[120498049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1122; }","duration":"153.773135ms","start":"2026-10-15T06:31:23.216853Z","end":"2026-10-15T06:31:23.370626Z","steps":["trace[120498049] 'agreement among raft nodes before linearized reading' (duration: 153.604851ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:23.370389Z","caller":"traceutil/trace.go:171","msg":"trace[443963187] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"153.295384ms","start":"2026-10-15T06:31:23.216901Z","end":"2026-10-15T06:31:23.370196Z","steps":["trace[443963187] 'read index received' (duration: 92.547374ms)","trace[443963187] 'applied index is now lower than readState.Index' (duration: 60.74704ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:24.104004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.129499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:31:24.104113Z","caller":"traceutil/trace.go:171","msg":"trace[1691785612] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1173; }","duration":"233.309812ms","start":"2026-10-15T06:31:23.870783Z","end":"2026-10-15T06:31:24.104093Z","steps":["trace[1691785612] 'read index received' (duration: 95.089761ms)","trace[1691785612] 'applied index is now lower than readState.Index' (duration: 138.218551ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:24.104226Z","caller":"traceutil/trace.go:171","msg":"trace[1061336274] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"315.675725ms","start":"2026-10-15T06:31:23.788517Z","end":"2026-10-15T06:31:24.104193Z","steps":["trace[1061336274] 'process raft request' (duration: 177.27276ms)","trace[1061336274] 'compare' (duration: 138.016207ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:24.104239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.460606ms","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-10-15T06:31:24.104276Z","caller":"traceutil/trace.go:171","msg":"trace[1778893956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1127; }","duration":"233.533198ms","start":"2026-10-15T06:31:23.870733Z","end":"2026-10-15T06:31:24.104267Z","steps":["trace[1778893956] 'agreement among raft nodes before linearized reading' (duration: 233.406295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:24.104313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:23.788492Z","time spent":"315.779717ms","remote":"127.0.0.1:49166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5456,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:31:36.372169Z","caller":"traceutil/trace.go:171","msg":"trace[159451199] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"155.896853ms","start":"2026-10-15T06:31:36.216233Z","end":"2026-10-15T06:31:36.37213Z","steps":["trace[159451199] 'read index received' (duration: 155.656507ms)","trace[159451199] 'applied index is now lower than readState.Index' (duration: 239.426µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:36.372209Z","caller":"traceutil/trace.go:171","msg":"trace[1299405386] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"182.879917ms","start":"2026-10-15T06:31:36.189297Z","end":"2026-10-15T06:31:36.372177Z","steps":["trace[1299405386] 'process raft request' (duration: 182.669012ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:36.372335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.085807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:36.37237Z","caller":"traceutil/trace.go:171","msg":"trace[1075757600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"156.210871ms","start":"2026-10-15T06:31:36.216149Z","end":"2026-10-15T06:31:36.37236Z","steps":["trace[1075757600] 'agreement among raft nodes before linearized reading' (duration: 156.134328ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:36.372448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.32801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:36.372503Z","caller":"traceutil/trace.go:171","msg":"trace[936995137] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1222; }","duration":"129.459843ms","start":"2026-10-15T06:31:36.243028Z","end":"2026-10-15T06:31:36.372488Z","steps":["trace[936995137] 'agreement among raft nodes before linearized reading' (duration: 129.363401ms)"],"step_count":1}