{"level":"warn","ts":"2026-04-02T16:43:25.508448Z","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-02T16:43:25.508571Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.122: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.122:2380","--initial-cluster=instance=https://199.204.45.122:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.122:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.122: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-02T16:43:25.508662Z","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-02T16:43:25.508682Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.122:2380"]} {"level":"info","ts":"2026-04-02T16:43:25.508704Z","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-02T16:43:25.509586Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"]} {"level":"info","ts":"2026-04-02T16:43:25.509692Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.122:2380"],"listen-peer-urls":["https://199.204.45.122:2380"],"advertise-client-urls":["https://199.204.45.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.122: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-02T16:43:25.515202Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.219393ms"} {"level":"info","ts":"2026-04-02T16:43:25.52202Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d2c3f297b56db0c4","cluster-id":"becafec23d27c587"} {"level":"info","ts":"2026-04-02T16:43:25.522139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T16:43:25.522173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 0"} {"level":"info","ts":"2026-04-02T16:43:25.522195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d2c3f297b56db0c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T16:43:25.522208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 1"} {"level":"info","ts":"2026-04-02T16:43:25.522265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"} {"level":"warn","ts":"2026-04-02T16:43:25.52795Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T16:43:25.529473Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T16:43:25.530749Z","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-02T16:43:25.53302Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d2c3f297b56db0c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T16:43:25.533283Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d2c3f297b56db0c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T16:43:25.533276Z","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-02T16:43:25.533417Z","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-02T16:43:25.53343Z","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-02T16:43:25.534876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"} {"level":"info","ts":"2026-04-02T16:43:25.535349Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"becafec23d27c587","local-member-id":"d2c3f297b56db0c4","added-peer-id":"d2c3f297b56db0c4","added-peer-peer-urls":["https://199.204.45.122:2380"]} {"level":"info","ts":"2026-04-02T16:43:25.539031Z","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-02T16:43:25.539197Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.122:2380"} {"level":"info","ts":"2026-04-02T16:43:25.539261Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.122:2380"} {"level":"info","ts":"2026-04-02T16:43:25.539719Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d2c3f297b56db0c4","initial-advertise-peer-urls":["https://199.204.45.122:2380"],"listen-peer-urls":["https://199.204.45.122:2380"],"advertise-client-urls":["https://199.204.45.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T16:43:25.539823Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T16:43:26.32317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T16:43:26.323247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T16:43:26.323288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgPreVoteResp from d2c3f297b56db0c4 at term 1"} {"level":"info","ts":"2026-04-02T16:43:26.323308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became candidate at term 2"} {"level":"info","ts":"2026-04-02T16:43:26.323325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgVoteResp from d2c3f297b56db0c4 at term 2"} {"level":"info","ts":"2026-04-02T16:43:26.323342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became leader at term 2"} {"level":"info","ts":"2026-04-02T16:43:26.323356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d2c3f297b56db0c4 elected leader d2c3f297b56db0c4 at term 2"} {"level":"info","ts":"2026-04-02T16:43:26.334931Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d2c3f297b56db0c4","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.122:2379]}","request-path":"/0/members/d2c3f297b56db0c4/attributes","cluster-id":"becafec23d27c587","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T16:43:26.335043Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:43:26.335104Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:43:26.335225Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:43:26.338119Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T16:43:26.33866Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.122:2379"} {"level":"info","ts":"2026-04-02T16:43:26.341952Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T16:43:26.342113Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T16:43:26.342111Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"becafec23d27c587","local-member-id":"d2c3f297b56db0c4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:43:26.342308Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:43:26.342603Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:43:31.570314Z","caller":"traceutil/trace.go:171","msg":"trace[1985532422] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"189.10085ms","start":"2026-04-02T16:43:31.381171Z","end":"2026-04-02T16:43:31.570271Z","steps":["trace[1985532422] 'process raft request' (duration: 172.499329ms)","trace[1985532422] 'compare' (duration: 16.376526ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:31.574418Z","caller":"traceutil/trace.go:171","msg":"trace[1485880860] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"166.446718ms","start":"2026-04-02T16:43:31.407936Z","end":"2026-04-02T16:43:31.574383Z","steps":["trace[1485880860] 'process raft request' (duration: 166.289894ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:31.574451Z","caller":"traceutil/trace.go:171","msg":"trace[726383245] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:257; }","duration":"165.149677ms","start":"2026-04-02T16:43:31.409275Z","end":"2026-04-02T16:43:31.574424Z","steps":["trace[726383245] 'read index received' (duration: 144.378886ms)","trace[726383245] 'applied index is now lower than readState.Index' (duration: 20.769851ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:31.574532Z","caller":"traceutil/trace.go:171","msg":"trace[707418123] transaction","detail":"{read_only:false; number_of_response:0; response_revision:253; }","duration":"192.694396ms","start":"2026-04-02T16:43:31.381809Z","end":"2026-04-02T16:43:31.574504Z","steps":["trace[707418123] 'process raft request' (duration: 192.327508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:31.574599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.30611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:31.574653Z","caller":"traceutil/trace.go:171","msg":"trace[1182915465] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:258; }","duration":"165.427093ms","start":"2026-04-02T16:43:31.409218Z","end":"2026-04-02T16:43:31.574645Z","steps":["trace[1182915465] 'agreement among raft nodes before linearized reading' (duration: 165.3015ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:31.574851Z","caller":"traceutil/trace.go:171","msg":"trace[1628654373] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"139.656285ms","start":"2026-04-02T16:43:31.435172Z","end":"2026-04-02T16:43:31.574828Z","steps":["trace[1628654373] 'process raft request' (duration: 139.220805ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:31.574912Z","caller":"traceutil/trace.go:171","msg":"trace[449486864] transaction","detail":"{read_only:false; number_of_response:0; response_revision:254; }","duration":"166.891638ms","start":"2026-04-02T16:43:31.408011Z","end":"2026-04-02T16:43:31.574903Z","steps":["trace[449486864] 'process raft request' (duration: 166.285234ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:31.574824Z","caller":"traceutil/trace.go:171","msg":"trace[500670804] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"166.041717ms","start":"2026-04-02T16:43:31.408715Z","end":"2026-04-02T16:43:31.574757Z","steps":["trace[500670804] 'process raft request' (duration: 165.621108ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:31.574939Z","caller":"traceutil/trace.go:171","msg":"trace[952925706] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"166.550309ms","start":"2026-04-02T16:43:31.408367Z","end":"2026-04-02T16:43:31.574917Z","steps":["trace[952925706] 'process raft request' (duration: 165.942865ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:31.574986Z","caller":"traceutil/trace.go:171","msg":"trace[2047187900] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"166.164049ms","start":"2026-04-02T16:43:31.408813Z","end":"2026-04-02T16:43:31.574977Z","steps":["trace[2047187900] 'process raft request' (duration: 165.557025ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.318689Z","caller":"traceutil/trace.go:171","msg":"trace[1870213998] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"146.101638ms","start":"2026-04-02T16:43:57.172551Z","end":"2026-04-02T16:43:57.318653Z","steps":["trace[1870213998] 'process raft request' (duration: 146.046407ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.318774Z","caller":"traceutil/trace.go:171","msg":"trace[1386164236] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"146.198732ms","start":"2026-04-02T16:43:57.172506Z","end":"2026-04-02T16:43:57.318705Z","steps":["trace[1386164236] 'process raft request' (duration: 88.887267ms)","trace[1386164236] 'compare' (duration: 57.033828ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:57.398016Z","caller":"traceutil/trace.go:171","msg":"trace[2023693063] transaction","detail":"{read_only:false; number_of_response:1; response_revision:478; }","duration":"216.486356ms","start":"2026-04-02T16:43:57.181505Z","end":"2026-04-02T16:43:57.397991Z","steps":["trace[2023693063] 'process raft request' (duration: 216.323702ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398058Z","caller":"traceutil/trace.go:171","msg":"trace[1998099145] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"216.950677ms","start":"2026-04-02T16:43:57.181057Z","end":"2026-04-02T16:43:57.398008Z","steps":["trace[1998099145] 'process raft request' (duration: 216.703971ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398461Z","caller":"traceutil/trace.go:171","msg":"trace[66377493] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"216.495566ms","start":"2026-04-02T16:43:57.18194Z","end":"2026-04-02T16:43:57.398435Z","steps":["trace[66377493] 'process raft request' (duration: 215.943873ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398566Z","caller":"traceutil/trace.go:171","msg":"trace[249447475] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"214.91358ms","start":"2026-04-02T16:43:57.183631Z","end":"2026-04-02T16:43:57.398545Z","steps":["trace[249447475] 'process raft request' (duration: 214.820447ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398667Z","caller":"traceutil/trace.go:171","msg":"trace[1516830595] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"213.789822ms","start":"2026-04-02T16:43:57.184861Z","end":"2026-04-02T16:43:57.398651Z","steps":["trace[1516830595] 'process raft request' (duration: 213.641079ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398689Z","caller":"traceutil/trace.go:171","msg":"trace[1569238372] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"215.401301ms","start":"2026-04-02T16:43:57.183146Z","end":"2026-04-02T16:43:57.398548Z","steps":["trace[1569238372] 'process raft request' (duration: 215.179855ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398812Z","caller":"traceutil/trace.go:171","msg":"trace[1037550605] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"187.719608ms","start":"2026-04-02T16:43:57.211047Z","end":"2026-04-02T16:43:57.398767Z","steps":["trace[1037550605] 'process raft request' (duration: 187.551204ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398825Z","caller":"traceutil/trace.go:171","msg":"trace[1585838889] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"161.828766ms","start":"2026-04-02T16:43:57.236964Z","end":"2026-04-02T16:43:57.398793Z","steps":["trace[1585838889] 'process raft request' (duration: 161.761345ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398912Z","caller":"traceutil/trace.go:171","msg":"trace[1562092727] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"189.925849ms","start":"2026-04-02T16:43:57.208974Z","end":"2026-04-02T16:43:57.398899Z","steps":["trace[1562092727] 'process raft request' (duration: 189.570531ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.398943Z","caller":"traceutil/trace.go:171","msg":"trace[1453494719] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"185.535436ms","start":"2026-04-02T16:43:57.213378Z","end":"2026-04-02T16:43:57.398913Z","steps":["trace[1453494719] 'process raft request' (duration: 185.28362ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.39821Z","caller":"traceutil/trace.go:171","msg":"trace[2045169105] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"218.278269ms","start":"2026-04-02T16:43:57.179804Z","end":"2026-04-02T16:43:57.398083Z","steps":["trace[2045169105] 'process raft request' (duration: 217.852259ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.650933Z","caller":"traceutil/trace.go:171","msg":"trace[991673575] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"319.27624ms","start":"2026-04-02T16:43:57.331624Z","end":"2026-04-02T16:43:57.6509Z","steps":["trace[991673575] 'process raft request' (duration: 318.969363ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.651016Z","caller":"traceutil/trace.go:171","msg":"trace[576717906] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"319.035155ms","start":"2026-04-02T16:43:57.331943Z","end":"2026-04-02T16:43:57.650979Z","steps":["trace[576717906] 'process raft request' (duration: 318.84952ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.65108Z","caller":"traceutil/trace.go:171","msg":"trace[1097482170] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"284.915155ms","start":"2026-04-02T16:43:57.366135Z","end":"2026-04-02T16:43:57.65105Z","steps":["trace[1097482170] 'process raft request' (duration: 284.824793ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.651189Z","caller":"traceutil/trace.go:171","msg":"trace[1099497685] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"315.278385ms","start":"2026-04-02T16:43:57.335867Z","end":"2026-04-02T16:43:57.651145Z","steps":["trace[1099497685] 'process raft request' (duration: 314.981808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:57.651549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:57.3316Z","time spent":"319.422304ms","remote":"127.0.0.1:38938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:43:57.651747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:57.331934Z","time spent":"319.163738ms","remote":"127.0.0.1:38938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:43:57.652506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:57.335829Z","time spent":"315.463799ms","remote":"127.0.0.1:38454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:57.691895Z","caller":"traceutil/trace.go:171","msg":"trace[1504783718] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"280.367668ms","start":"2026-04-02T16:43:57.41149Z","end":"2026-04-02T16:43:57.691858Z","steps":["trace[1504783718] 'process raft request' (duration: 280.068091ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.692063Z","caller":"traceutil/trace.go:171","msg":"trace[75310091] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"277.428489ms","start":"2026-04-02T16:43:57.414595Z","end":"2026-04-02T16:43:57.692023Z","steps":["trace[75310091] 'process raft request' (duration: 277.242464ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.692226Z","caller":"traceutil/trace.go:171","msg":"trace[706919720] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"273.086815ms","start":"2026-04-02T16:43:57.419127Z","end":"2026-04-02T16:43:57.692214Z","steps":["trace[706919720] 'process raft request' (duration: 272.773778ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.692289Z","caller":"traceutil/trace.go:171","msg":"trace[1565218593] transaction","detail":"{read_only:false; number_of_response:1; response_revision:491; }","duration":"280.194574ms","start":"2026-04-02T16:43:57.412067Z","end":"2026-04-02T16:43:57.692262Z","steps":["trace[1565218593] 'process raft request' (duration: 279.704153ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.692351Z","caller":"traceutil/trace.go:171","msg":"trace[237432054] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:501; }","duration":"259.010913ms","start":"2026-04-02T16:43:57.433303Z","end":"2026-04-02T16:43:57.692314Z","steps":["trace[237432054] 'read index received' (duration: 217.386607ms)","trace[237432054] 'applied index is now lower than readState.Index' (duration: 41.623315ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:57.692496Z","caller":"traceutil/trace.go:171","msg":"trace[1803328937] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"260.988319ms","start":"2026-04-02T16:43:57.431493Z","end":"2026-04-02T16:43:57.692481Z","steps":["trace[1803328937] 'process raft request' (duration: 260.727273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:57.692521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.202457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:57.692515Z","caller":"traceutil/trace.go:171","msg":"trace[667402845] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"271.785056ms","start":"2026-04-02T16:43:57.420705Z","end":"2026-04-02T16:43:57.69249Z","steps":["trace[667402845] 'process raft request' (duration: 271.322785ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.692566Z","caller":"traceutil/trace.go:171","msg":"trace[1723217014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"259.298389ms","start":"2026-04-02T16:43:57.433252Z","end":"2026-04-02T16:43:57.692551Z","steps":["trace[1723217014] 'agreement among raft nodes before linearized reading' (duration: 259.199667ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.693162Z","caller":"traceutil/trace.go:171","msg":"trace[1853416932] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"271.297654ms","start":"2026-04-02T16:43:57.421604Z","end":"2026-04-02T16:43:57.692902Z","steps":["trace[1853416932] 'process raft request' (duration: 270.487935ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:57.96896Z","caller":"traceutil/trace.go:171","msg":"trace[2132481747] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"122.998511ms","start":"2026-04-02T16:43:57.845928Z","end":"2026-04-02T16:43:57.968927Z","steps":["trace[2132481747] 'process raft request' (duration: 54.024348ms)","trace[2132481747] 'compare' (duration: 68.81446ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:57.969716Z","caller":"traceutil/trace.go:171","msg":"trace[1267116355] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"109.777729ms","start":"2026-04-02T16:43:57.859927Z","end":"2026-04-02T16:43:57.969704Z","steps":["trace[1267116355] 'process raft request' (duration: 109.615505ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:44:04.05852Z","caller":"traceutil/trace.go:171","msg":"trace[1551190256] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"100.369077ms","start":"2026-04-02T16:44:03.958085Z","end":"2026-04-02T16:44:04.058454Z","steps":["trace[1551190256] 'process raft request' (duration: 99.480515ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:44:04.542664Z","caller":"traceutil/trace.go:171","msg":"trace[1147267776] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"415.924279ms","start":"2026-04-02T16:44:04.126707Z","end":"2026-04-02T16:44:04.542631Z","steps":["trace[1147267776] 'read index received' (duration: 415.722035ms)","trace[1147267776] 'applied index is now lower than readState.Index' (duration: 201.404µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:44:04.542793Z","caller":"traceutil/trace.go:171","msg":"trace[631025555] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"419.394072ms","start":"2026-04-02T16:44:04.12339Z","end":"2026-04-02T16:44:04.542784Z","steps":["trace[631025555] 'process raft request' (duration: 419.110595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:04.542896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:44:04.12335Z","time spent":"419.471694ms","remote":"127.0.0.1:38922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T16:44:04.542984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.185287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-02T16:44:04.543028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.668101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m7d42\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-02T16:44:04.543091Z","caller":"traceutil/trace.go:171","msg":"trace[563305006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"416.32836ms","start":"2026-04-02T16:44:04.126734Z","end":"2026-04-02T16:44:04.543063Z","steps":["trace[563305006] 'agreement among raft nodes before linearized reading' (duration: 416.094024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:04.543139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:44:04.126712Z","time spent":"416.417402ms","remote":"127.0.0.1:38684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T16:44:04.543141Z","caller":"traceutil/trace.go:171","msg":"trace[325909090] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m7d42; range_end:; response_count:1; response_revision:582; }","duration":"134.845775ms","start":"2026-04-02T16:44:04.40827Z","end":"2026-04-02T16:44:04.543116Z","steps":["trace[325909090] 'agreement among raft nodes before linearized reading' (duration: 134.595568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:04.543141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.160318ms","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-02T16:44:04.543243Z","caller":"traceutil/trace.go:171","msg":"trace[2011352136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"224.328592ms","start":"2026-04-02T16:44:04.318884Z","end":"2026-04-02T16:44:04.543212Z","steps":["trace[2011352136] 'agreement among raft nodes before linearized reading' (duration: 224.041174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:04.543139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.401651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T16:44:04.543313Z","caller":"traceutil/trace.go:171","msg":"trace[1124212330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"416.589276ms","start":"2026-04-02T16:44:04.126699Z","end":"2026-04-02T16:44:04.543288Z","steps":["trace[1124212330] 'agreement among raft nodes before linearized reading' (duration: 416.120124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:04.543367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:44:04.12664Z","time spent":"416.711879ms","remote":"127.0.0.1:38684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T16:44:48.483586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.002256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T16:44:48.483696Z","caller":"traceutil/trace.go:171","msg":"trace[786671320] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1141; }","duration":"328.379855ms","start":"2026-04-02T16:44:48.155294Z","end":"2026-04-02T16:44:48.483673Z","steps":["trace[786671320] 'count revisions from in-memory index tree' (duration: 327.878354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:48.483742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:44:48.155266Z","time spent":"328.464037ms","remote":"127.0.0.1:38896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":8,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T16:45:36.546973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.822093ms","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-02T16:45:36.547106Z","caller":"traceutil/trace.go:171","msg":"trace[607900030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1815; }","duration":"238.070649ms","start":"2026-04-02T16:45:36.309011Z","end":"2026-04-02T16:45:36.547082Z","steps":["trace[607900030] 'range keys from in-memory index tree' (duration: 237.536857ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:46:25.407803Z","caller":"traceutil/trace.go:171","msg":"trace[494092725] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"114.534108ms","start":"2026-04-02T16:46:25.293227Z","end":"2026-04-02T16:46:25.407761Z","steps":["trace[494092725] 'process raft request' (duration: 114.328903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:46:25.650298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.338998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:46:25.65056Z","caller":"traceutil/trace.go:171","msg":"trace[1862263486] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"238.350466ms","start":"2026-04-02T16:46:25.412178Z","end":"2026-04-02T16:46:25.650528Z","steps":["trace[1862263486] 'process raft request' (duration: 106.455105ms)","trace[1862263486] 'compare' (duration: 131.199835ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:46:25.651151Z","caller":"traceutil/trace.go:171","msg":"trace[110512820] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2206; }","duration":"183.46442ms","start":"2026-04-02T16:46:25.467665Z","end":"2026-04-02T16:46:25.65113Z","steps":["trace[110512820] 'read index received' (duration: 50.973144ms)","trace[110512820] 'applied index is now lower than readState.Index' (duration: 132.490146ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:46:25.651415Z","caller":"traceutil/trace.go:171","msg":"trace[1788379943] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"238.827949ms","start":"2026-04-02T16:46:25.412532Z","end":"2026-04-02T16:46:25.65136Z","steps":["trace[1788379943] 'process raft request' (duration: 237.899836ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:46:25.65145Z","caller":"traceutil/trace.go:171","msg":"trace[1994206190] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"238.90071ms","start":"2026-04-02T16:46:25.412531Z","end":"2026-04-02T16:46:25.651432Z","steps":["trace[1994206190] 'process raft request' (duration: 238.251524ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:46:25.65155Z","caller":"traceutil/trace.go:171","msg":"trace[377447967] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"188.587352ms","start":"2026-04-02T16:46:25.462907Z","end":"2026-04-02T16:46:25.651494Z","steps":["trace[377447967] 'process raft request' (duration: 188.13892ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:46:25.651471Z","caller":"traceutil/trace.go:171","msg":"trace[157444071] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"238.517302ms","start":"2026-04-02T16:46:25.412884Z","end":"2026-04-02T16:46:25.651401Z","steps":["trace[157444071] 'process raft request' (duration: 238.093131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:46:25.651803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.106055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-02T16:46:25.65198Z","caller":"traceutil/trace.go:171","msg":"trace[1689209118] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"184.348581ms","start":"2026-04-02T16:46:25.467607Z","end":"2026-04-02T16:46:25.651956Z","steps":["trace[1689209118] 'agreement among raft nodes before linearized reading' (duration: 183.794098ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:47:40.030618Z","caller":"traceutil/trace.go:171","msg":"trace[1488478699] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"108.46265ms","start":"2026-04-02T16:47:39.92211Z","end":"2026-04-02T16:47:40.030573Z","steps":["trace[1488478699] 'process raft request' (duration: 108.294996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:47:40.316544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.79469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:47:40.316788Z","caller":"traceutil/trace.go:171","msg":"trace[68140986] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"281.804753ms","start":"2026-04-02T16:47:40.034968Z","end":"2026-04-02T16:47:40.316773Z","steps":["trace[68140986] 'process raft request' (duration: 281.69351ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:47:40.316775Z","caller":"traceutil/trace.go:171","msg":"trace[1108904545] transaction","detail":"{read_only:false; response_revision:2732; number_of_response:1; }","duration":"282.022788ms","start":"2026-04-02T16:47:40.034723Z","end":"2026-04-02T16:47:40.316745Z","steps":["trace[1108904545] 'process raft request' (duration: 145.932961ms)","trace[1108904545] 'compare' (duration: 135.591856ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:47:40.317018Z","caller":"traceutil/trace.go:171","msg":"trace[1221616107] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"282.002018ms","start":"2026-04-02T16:47:40.035006Z","end":"2026-04-02T16:47:40.317008Z","steps":["trace[1221616107] 'process raft request' (duration: 281.731741ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:47:40.317226Z","caller":"traceutil/trace.go:171","msg":"trace[889512628] transaction","detail":"{read_only:false; response_revision:2735; number_of_response:1; }","duration":"282.132761ms","start":"2026-04-02T16:47:40.035076Z","end":"2026-04-02T16:47:40.317209Z","steps":["trace[889512628] 'process raft request' (duration: 281.867685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:47:40.317392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.70658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:47:40.317355Z","caller":"traceutil/trace.go:171","msg":"trace[393724948] linearizableReadLoop","detail":"{readStateIndex:2835; appliedIndex:2831; }","duration":"273.351182ms","start":"2026-04-02T16:47:40.043678Z","end":"2026-04-02T16:47:40.317029Z","steps":["trace[393724948] 'read index received' (duration: 136.951098ms)","trace[393724948] 'applied index is now lower than readState.Index' (duration: 136.398844ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:47:40.317442Z","caller":"traceutil/trace.go:171","msg":"trace[271072068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2735; }","duration":"273.772101ms","start":"2026-04-02T16:47:40.04366Z","end":"2026-04-02T16:47:40.317432Z","steps":["trace[271072068] 'agreement among raft nodes before linearized reading' (duration: 273.69805ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:29.62228Z","caller":"traceutil/trace.go:171","msg":"trace[2108902804] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"101.360847ms","start":"2026-04-02T16:51:29.520874Z","end":"2026-04-02T16:51:29.622235Z","steps":["trace[2108902804] 'process raft request' (duration: 78.534535ms)","trace[2108902804] 'compare' (duration: 22.493954ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:51:29.622511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.091025ms","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-04-02T16:51:29.622582Z","caller":"traceutil/trace.go:171","msg":"trace[828195819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4683; }","duration":"105.224218ms","start":"2026-04-02T16:51:29.517341Z","end":"2026-04-02T16:51:29.622565Z","steps":["trace[828195819] 'agreement among raft nodes before linearized reading' (duration: 104.8836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:29.622546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.492073ms","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-04-02T16:51:29.622653Z","caller":"traceutil/trace.go:171","msg":"trace[189512819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4683; }","duration":"102.678097ms","start":"2026-04-02T16:51:29.519952Z","end":"2026-04-02T16:51:29.62263Z","steps":["trace[189512819] 'agreement among raft nodes before linearized reading' (duration: 102.297339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:29.622999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.911476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T16:51:29.623038Z","caller":"traceutil/trace.go:171","msg":"trace[1134791452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4683; }","duration":"106.006858ms","start":"2026-04-02T16:51:29.517023Z","end":"2026-04-02T16:51:29.62303Z","steps":["trace[1134791452] 'agreement among raft nodes before linearized reading' (duration: 105.244249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:29.623182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.529601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-02T16:51:29.623251Z","caller":"traceutil/trace.go:171","msg":"trace[353163033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4683; }","duration":"117.611004ms","start":"2026-04-02T16:51:29.505624Z","end":"2026-04-02T16:51:29.623235Z","steps":["trace[353163033] 'agreement among raft nodes before linearized reading' (duration: 116.63661ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:35.057974Z","caller":"traceutil/trace.go:171","msg":"trace[1249932689] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"123.89115ms","start":"2026-04-02T16:51:34.934052Z","end":"2026-04-02T16:51:35.057943Z","steps":["trace[1249932689] 'process raft request' (duration: 123.730977ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:35.127588Z","caller":"traceutil/trace.go:171","msg":"trace[128938249] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"191.652574ms","start":"2026-04-02T16:51:34.935906Z","end":"2026-04-02T16:51:35.127558Z","steps":["trace[128938249] 'process raft request' (duration: 174.31363ms)","trace[128938249] 'compare' (duration: 17.173279ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:51:54.855971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.618588ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T16:51:54.856389Z","caller":"traceutil/trace.go:171","msg":"trace[1980242482] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"210.224045ms","start":"2026-04-02T16:51:54.646151Z","end":"2026-04-02T16:51:54.856375Z","steps":["trace[1980242482] 'process raft request' (duration: 209.937548ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:55.055932Z","caller":"traceutil/trace.go:171","msg":"trace[2036025337] linearizableReadLoop","detail":"{readStateIndex:5451; appliedIndex:5450; }","duration":"122.132338ms","start":"2026-04-02T16:51:54.933776Z","end":"2026-04-02T16:51:55.055909Z","steps":["trace[2036025337] 'read index received' (duration: 57.518799ms)","trace[2036025337] 'applied index is now lower than readState.Index' (duration: 64.612499ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:51:55.056068Z","caller":"traceutil/trace.go:171","msg":"trace[349843955] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"193.635921ms","start":"2026-04-02T16:51:54.8624Z","end":"2026-04-02T16:51:55.056036Z","steps":["trace[349843955] 'process raft request' (duration: 128.90722ms)","trace[349843955] 'compare' (duration: 64.361152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:51:55.056197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.406754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wqk2q\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-02T16:51:55.056278Z","caller":"traceutil/trace.go:171","msg":"trace[695945777] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wqk2q; range_end:; response_count:1; response_revision:5262; }","duration":"122.531267ms","start":"2026-04-02T16:51:54.93373Z","end":"2026-04-02T16:51:55.056261Z","steps":["trace[695945777] 'agreement among raft nodes before linearized reading' (duration: 122.302692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:55.056422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.47147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-v9qwm\" ","response":"range_response_count:1 size:4040"} {"level":"info","ts":"2026-04-02T16:51:55.056569Z","caller":"traceutil/trace.go:171","msg":"trace[119024049] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-v9qwm; range_end:; response_count:1; response_revision:5262; }","duration":"105.586664ms","start":"2026-04-02T16:51:54.950898Z","end":"2026-04-02T16:51:55.056485Z","steps":["trace[119024049] 'agreement among raft nodes before linearized reading' (duration: 105.286306ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:52:07.304886Z","caller":"traceutil/trace.go:171","msg":"trace[1870060912] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"147.728677ms","start":"2026-04-02T16:52:07.157119Z","end":"2026-04-02T16:52:07.304848Z","steps":["trace[1870060912] 'process raft request' (duration: 76.834608ms)","trace[1870060912] 'compare' (duration: 70.739746ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:52:07.312852Z","caller":"traceutil/trace.go:171","msg":"trace[1545733947] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"155.331619ms","start":"2026-04-02T16:52:07.157485Z","end":"2026-04-02T16:52:07.312816Z","steps":["trace[1545733947] 'process raft request' (duration: 155.272728ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:52:07.312859Z","caller":"traceutil/trace.go:171","msg":"trace[775709614] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"155.575455ms","start":"2026-04-02T16:52:07.157261Z","end":"2026-04-02T16:52:07.312837Z","steps":["trace[775709614] 'process raft request' (duration: 155.453562ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:52:07.31318Z","caller":"traceutil/trace.go:171","msg":"trace[1210941761] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"155.856162ms","start":"2026-04-02T16:52:07.157236Z","end":"2026-04-02T16:52:07.313092Z","steps":["trace[1210941761] 'process raft request' (duration: 155.34585ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:52:07.356535Z","caller":"traceutil/trace.go:171","msg":"trace[159081439] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"120.95016ms","start":"2026-04-02T16:52:07.235566Z","end":"2026-04-02T16:52:07.356516Z","steps":["trace[159081439] 'process raft request' (duration: 120.827547ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:53:26.366675Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2983} {"level":"info","ts":"2026-04-02T16:53:26.451674Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2983,"took":"83.240062ms","hash":2811266194,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":33648640,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-02T16:53:26.451758Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2811266194,"revision":2983,"compact-revision":-1} {"level":"info","ts":"2026-04-02T16:57:51.602989Z","caller":"traceutil/trace.go:171","msg":"trace[612830534] transaction","detail":"{read_only:false; response_revision:8079; number_of_response:1; }","duration":"224.035291ms","start":"2026-04-02T16:57:51.378925Z","end":"2026-04-02T16:57:51.60296Z","steps":["trace[612830534] 'process raft request' (duration: 223.842427ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:51.786804Z","caller":"traceutil/trace.go:171","msg":"trace[1104286904] linearizableReadLoop","detail":"{readStateIndex:8355; appliedIndex:8354; }","duration":"147.755003ms","start":"2026-04-02T16:57:51.639005Z","end":"2026-04-02T16:57:51.78676Z","steps":["trace[1104286904] 'read index received' (duration: 147.406613ms)","trace[1104286904] 'applied index is now lower than readState.Index' (duration: 345.85µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:57:51.786925Z","caller":"traceutil/trace.go:171","msg":"trace[1384068222] transaction","detail":"{read_only:false; response_revision:8080; number_of_response:1; }","duration":"179.403267ms","start":"2026-04-02T16:57:51.607454Z","end":"2026-04-02T16:57:51.786857Z","steps":["trace[1384068222] 'process raft request' (duration: 178.985977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:57:51.78708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.03493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T16:57:51.787126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.386524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T16:57:51.787121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.040027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-02T16:57:51.787178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.24168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T16:57:51.787198Z","caller":"traceutil/trace.go:171","msg":"trace[1972223555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8080; }","duration":"147.502096ms","start":"2026-04-02T16:57:51.639677Z","end":"2026-04-02T16:57:51.787179Z","steps":["trace[1972223555] 'agreement among raft nodes before linearized reading' (duration: 147.285611ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:51.787211Z","caller":"traceutil/trace.go:171","msg":"trace[830677238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8080; }","duration":"137.183501ms","start":"2026-04-02T16:57:51.650007Z","end":"2026-04-02T16:57:51.787191Z","steps":["trace[830677238] 'agreement among raft nodes before linearized reading' (duration: 136.969146ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:51.787202Z","caller":"traceutil/trace.go:171","msg":"trace[1500291042] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:8080; }","duration":"148.206893ms","start":"2026-04-02T16:57:51.638967Z","end":"2026-04-02T16:57:51.787174Z","steps":["trace[1500291042] 'agreement among raft nodes before linearized reading' (duration: 147.982068ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:51.787235Z","caller":"traceutil/trace.go:171","msg":"trace[1153108892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8080; }","duration":"139.370103ms","start":"2026-04-02T16:57:51.647851Z","end":"2026-04-02T16:57:51.787221Z","steps":["trace[1153108892] 'agreement among raft nodes before linearized reading' (duration: 139.171919ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:58:26.382625Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6097} {"level":"info","ts":"2026-04-02T16:58:26.497394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6097,"took":"113.113476ms","hash":3486877443,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":22990848,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-02T16:58:26.497468Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3486877443,"revision":6097,"compact-revision":2983} {"level":"info","ts":"2026-04-02T16:58:33.113189Z","caller":"traceutil/trace.go:171","msg":"trace[1377324716] transaction","detail":"{read_only:false; response_revision:8357; number_of_response:1; }","duration":"178.135037ms","start":"2026-04-02T16:58:32.935022Z","end":"2026-04-02T16:58:33.113157Z","steps":["trace[1377324716] 'process raft request' (duration: 171.817317ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:58:33.123303Z","caller":"traceutil/trace.go:171","msg":"trace[914772649] transaction","detail":"{read_only:false; response_revision:8358; number_of_response:1; }","duration":"163.791114ms","start":"2026-04-02T16:58:32.959494Z","end":"2026-04-02T16:58:33.123285Z","steps":["trace[914772649] 'process raft request' (duration: 163.681602ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:59:35.439147Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002431.wal"} {"level":"info","ts":"2026-04-02T17:01:06.918713Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d2c3f297b56db0c4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-02T17:01:06.940071Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-02T17:01:06.940209Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-02T17:03:26.388945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8276} {"level":"info","ts":"2026-04-02T17:03:26.468928Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8276,"took":"77.896599ms","hash":2627709131,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":24834048,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-02T17:03:26.469009Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2627709131,"revision":8276,"compact-revision":6097} {"level":"info","ts":"2026-04-02T17:08:26.39506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10671} {"level":"info","ts":"2026-04-02T17:08:26.470392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10671,"took":"73.108066ms","hash":108598909,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":20377600,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-02T17:08:26.470532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":108598909,"revision":10671,"compact-revision":8276}