{"level":"warn","ts":"2026-02-04T01:49:42.405403Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-04T01:49:42.405498Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.6: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.6:2380","--initial-cluster=instance=https://199.204.45.6:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.6:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.6: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-02-04T01:49:42.405693Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-04T01:49:42.405746Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.6:2380"]}
{"level":"info","ts":"2026-02-04T01:49:42.405815Z","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-02-04T01:49:42.406637Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.6:2379"]}
{"level":"info","ts":"2026-02-04T01:49:42.40681Z","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":2,"max-cpu-available":2,"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.6:2380"],"listen-peer-urls":["https://199.204.45.6:2380"],"advertise-client-urls":["https://199.204.45.6:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.6:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.6: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-02-04T01:49:42.413667Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.560032ms"}
{"level":"info","ts":"2026-02-04T01:49:42.424337Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4ec288cbdba84d36","cluster-id":"9b45faacd38a820f"}
{"level":"info","ts":"2026-02-04T01:49:42.424438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-04T01:49:42.424523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became follower at term 0"}
{"level":"info","ts":"2026-02-04T01:49:42.424559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4ec288cbdba84d36 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-04T01:49:42.424581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became follower at term 1"}
{"level":"info","ts":"2026-02-04T01:49:42.424666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 switched to configuration voters=(5675248889585225014)"}
{"level":"warn","ts":"2026-02-04T01:49:42.435942Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-04T01:49:42.451625Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-04T01:49:42.452926Z","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-02-04T01:49:42.456427Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4ec288cbdba84d36","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-04T01:49:42.458542Z","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-02-04T01:49:42.459396Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4ec288cbdba84d36","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-04T01:49:42.459559Z","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-02-04T01:49:42.462555Z","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-02-04T01:49:42.462571Z","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-02-04T01:49:42.462699Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4ec288cbdba84d36","initial-advertise-peer-urls":["https://199.204.45.6:2380"],"listen-peer-urls":["https://199.204.45.6:2380"],"advertise-client-urls":["https://199.204.45.6:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.6:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-04T01:49:42.462736Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-04T01:49:42.459736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 switched to configuration voters=(5675248889585225014)"}
{"level":"info","ts":"2026-02-04T01:49:42.462872Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9b45faacd38a820f","local-member-id":"4ec288cbdba84d36","added-peer-id":"4ec288cbdba84d36","added-peer-peer-urls":["https://199.204.45.6:2380"]}
{"level":"info","ts":"2026-02-04T01:49:42.459853Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.6:2380"}
{"level":"info","ts":"2026-02-04T01:49:42.462894Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.6:2380"}
{"level":"info","ts":"2026-02-04T01:49:42.525148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-04T01:49:42.525791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-04T01:49:42.525869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 received MsgPreVoteResp from 4ec288cbdba84d36 at term 1"}
{"level":"info","ts":"2026-02-04T01:49:42.525934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became candidate at term 2"}
{"level":"info","ts":"2026-02-04T01:49:42.525987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 received MsgVoteResp from 4ec288cbdba84d36 at term 2"}
{"level":"info","ts":"2026-02-04T01:49:42.526044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4ec288cbdba84d36 became leader at term 2"}
{"level":"info","ts":"2026-02-04T01:49:42.526094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4ec288cbdba84d36 elected leader 4ec288cbdba84d36 at term 2"}
{"level":"info","ts":"2026-02-04T01:49:42.52699Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T01:49:42.52775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4ec288cbdba84d36","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.6:2379]}","request-path":"/0/members/4ec288cbdba84d36/attributes","cluster-id":"9b45faacd38a820f","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-04T01:49:42.527835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T01:49:42.532792Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.6:2379"}
{"level":"info","ts":"2026-02-04T01:49:42.533192Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9b45faacd38a820f","local-member-id":"4ec288cbdba84d36","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T01:49:42.533303Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T01:49:42.533329Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T01:49:42.537907Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T01:49:42.540307Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-04T01:49:42.540324Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-04T01:49:42.54504Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-04T01:49:45.148012Z","caller":"traceutil/trace.go:171","msg":"trace[854818903] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"103.557683ms","start":"2026-02-04T01:49:45.044434Z","end":"2026-02-04T01:49:45.147992Z","steps":["trace[854818903] 'read index received'  (duration: 39.131456ms)","trace[854818903] 'applied index is now lower than readState.Index'  (duration: 64.425427ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:45.14812Z","caller":"traceutil/trace.go:171","msg":"trace[376354512] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"111.25931ms","start":"2026-02-04T01:49:45.036849Z","end":"2026-02-04T01:49:45.148109Z","steps":["trace[376354512] 'process raft request'  (duration: 46.706423ms)","trace[376354512] 'compare'  (duration: 64.341956ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T01:49:45.148308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.833665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-04T01:49:45.148434Z","caller":"traceutil/trace.go:171","msg":"trace[155544007] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:4; }","duration":"103.965985ms","start":"2026-02-04T01:49:45.044414Z","end":"2026-02-04T01:49:45.14838Z","steps":["trace[155544007] 'agreement among raft nodes before linearized reading'  (duration: 103.765194ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.157542Z","caller":"traceutil/trace.go:171","msg":"trace[1040650958] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"104.554279ms","start":"2026-02-04T01:49:45.05298Z","end":"2026-02-04T01:49:45.157534Z","steps":["trace[1040650958] 'process raft request'  (duration: 104.289147ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.157933Z","caller":"traceutil/trace.go:171","msg":"trace[789170783] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"103.943615ms","start":"2026-02-04T01:49:45.053983Z","end":"2026-02-04T01:49:45.157927Z","steps":["trace[789170783] 'process raft request'  (duration: 103.456552ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.158045Z","caller":"traceutil/trace.go:171","msg":"trace[2018325191] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"104.019146ms","start":"2026-02-04T01:49:45.054019Z","end":"2026-02-04T01:49:45.158038Z","steps":["trace[2018325191] 'process raft request'  (duration: 103.439872ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.158191Z","caller":"traceutil/trace.go:171","msg":"trace[1897326676] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"103.201309ms","start":"2026-02-04T01:49:45.054984Z","end":"2026-02-04T01:49:45.158185Z","steps":["trace[1897326676] 'process raft request'  (duration: 102.492784ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.158325Z","caller":"traceutil/trace.go:171","msg":"trace[205293588] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"103.18242ms","start":"2026-02-04T01:49:45.055137Z","end":"2026-02-04T01:49:45.158319Z","steps":["trace[205293588] 'process raft request'  (duration: 102.478204ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.266929Z","caller":"traceutil/trace.go:171","msg":"trace[1017219871] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"103.021657ms","start":"2026-02-04T01:49:45.163892Z","end":"2026-02-04T01:49:45.266914Z","steps":["trace[1017219871] 'process raft request'  (duration: 95.652772ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.271487Z","caller":"traceutil/trace.go:171","msg":"trace[77616637] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"100.117796ms","start":"2026-02-04T01:49:45.171357Z","end":"2026-02-04T01:49:45.271475Z","steps":["trace[77616637] 'process raft request'  (duration: 99.106939ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.273826Z","caller":"traceutil/trace.go:171","msg":"trace[406979160] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:15; }","duration":"102.333223ms","start":"2026-02-04T01:49:45.171485Z","end":"2026-02-04T01:49:45.273818Z","steps":["trace[406979160] 'read index received'  (duration: 88.116426ms)","trace[406979160] 'applied index is now lower than readState.Index'  (duration: 14.216267ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:45.273934Z","caller":"traceutil/trace.go:171","msg":"trace[1726296690] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"102.515415ms","start":"2026-02-04T01:49:45.171413Z","end":"2026-02-04T01:49:45.273928Z","steps":["trace[1726296690] 'process raft request'  (duration: 99.082099ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.274766Z","caller":"traceutil/trace.go:171","msg":"trace[995822243] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"103.298671ms","start":"2026-02-04T01:49:45.171458Z","end":"2026-02-04T01:49:45.274756Z","steps":["trace[995822243] 'process raft request'  (duration: 102.218573ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.274851Z","caller":"traceutil/trace.go:171","msg":"trace[1337767983] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"103.32368ms","start":"2026-02-04T01:49:45.171519Z","end":"2026-02-04T01:49:45.274843Z","steps":["trace[1337767983] 'process raft request'  (duration: 102.180962ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.276009Z","caller":"traceutil/trace.go:171","msg":"trace[19313251] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"104.335709ms","start":"2026-02-04T01:49:45.171663Z","end":"2026-02-04T01:49:45.275999Z","steps":["trace[19313251] 'process raft request'  (duration: 102.055991ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.276101Z","caller":"traceutil/trace.go:171","msg":"trace[301329726] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"104.394049ms","start":"2026-02-04T01:49:45.171701Z","end":"2026-02-04T01:49:45.276095Z","steps":["trace[301329726] 'process raft request'  (duration: 102.034081ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.276392Z","caller":"traceutil/trace.go:171","msg":"trace[255942603] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"104.637222ms","start":"2026-02-04T01:49:45.171746Z","end":"2026-02-04T01:49:45.276383Z","steps":["trace[255942603] 'process raft request'  (duration: 102.004911ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.276525Z","caller":"traceutil/trace.go:171","msg":"trace[496456705] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"104.943374ms","start":"2026-02-04T01:49:45.171576Z","end":"2026-02-04T01:49:45.276519Z","steps":["trace[496456705] 'process raft request'  (duration: 102.190803ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.2769Z","caller":"traceutil/trace.go:171","msg":"trace[1589707875] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"102.260973ms","start":"2026-02-04T01:49:45.174629Z","end":"2026-02-04T01:49:45.27689Z","steps":["trace[1589707875] 'process raft request'  (duration: 99.15849ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:49:45.277166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.613245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-98mr9\" ","response":"range_response_count:1 size:861"}
{"level":"info","ts":"2026-02-04T01:49:45.277199Z","caller":"traceutil/trace.go:171","msg":"trace[519121660] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-98mr9; range_end:; response_count:1; response_revision:25; }","duration":"106.679185ms","start":"2026-02-04T01:49:45.170511Z","end":"2026-02-04T01:49:45.27719Z","steps":["trace[519121660] 'agreement among raft nodes before linearized reading'  (duration: 106.611425ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:49:45.300057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.532453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-04T01:49:45.300116Z","caller":"traceutil/trace.go:171","msg":"trace[619725333] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:26; }","duration":"127.621013ms","start":"2026-02-04T01:49:45.172481Z","end":"2026-02-04T01:49:45.300102Z","steps":["trace[619725333] 'agreement among raft nodes before linearized reading'  (duration: 127.475902ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.536414Z","caller":"traceutil/trace.go:171","msg":"trace[1570182661] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"232.545367ms","start":"2026-02-04T01:49:45.303855Z","end":"2026-02-04T01:49:45.5364Z","steps":["trace[1570182661] 'process raft request'  (duration: 232.515817ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.5367Z","caller":"traceutil/trace.go:171","msg":"trace[242317095] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"233.313864ms","start":"2026-02-04T01:49:45.303354Z","end":"2026-02-04T01:49:45.536668Z","steps":["trace[242317095] 'process raft request'  (duration: 162.80042ms)","trace[242317095] 'compare'  (duration: 70.13239ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:45.538914Z","caller":"traceutil/trace.go:171","msg":"trace[2131217502] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"209.659053ms","start":"2026-02-04T01:49:45.329247Z","end":"2026-02-04T01:49:45.538906Z","steps":["trace[2131217502] 'process raft request'  (duration: 209.510172ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.539096Z","caller":"traceutil/trace.go:171","msg":"trace[2043870731] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"209.802794ms","start":"2026-02-04T01:49:45.329287Z","end":"2026-02-04T01:49:45.53909Z","steps":["trace[2043870731] 'process raft request'  (duration: 209.540892ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.539401Z","caller":"traceutil/trace.go:171","msg":"trace[1702343787] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"206.122867ms","start":"2026-02-04T01:49:45.333265Z","end":"2026-02-04T01:49:45.539388Z","steps":["trace[1702343787] 'process raft request'  (duration: 206.075057ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.540317Z","caller":"traceutil/trace.go:171","msg":"trace[1215630487] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"207.88742ms","start":"2026-02-04T01:49:45.332423Z","end":"2026-02-04T01:49:45.54031Z","steps":["trace[1215630487] 'process raft request'  (duration: 206.486999ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.540456Z","caller":"traceutil/trace.go:171","msg":"trace[108561739] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"209.986386ms","start":"2026-02-04T01:49:45.330462Z","end":"2026-02-04T01:49:45.540448Z","steps":["trace[108561739] 'process raft request'  (duration: 208.397213ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.540425Z","caller":"traceutil/trace.go:171","msg":"trace[1208390337] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"207.265596ms","start":"2026-02-04T01:49:45.333056Z","end":"2026-02-04T01:49:45.540322Z","steps":["trace[1208390337] 'process raft request'  (duration: 206.233358ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.540633Z","caller":"traceutil/trace.go:171","msg":"trace[669725484] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"208.772797ms","start":"2026-02-04T01:49:45.331855Z","end":"2026-02-04T01:49:45.540628Z","steps":["trace[669725484] 'process raft request'  (duration: 207.029634ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.54078Z","caller":"traceutil/trace.go:171","msg":"trace[2021263487] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"207.639918ms","start":"2026-02-04T01:49:45.333106Z","end":"2026-02-04T01:49:45.540746Z","steps":["trace[2021263487] 'process raft request'  (duration: 206.212158ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.708701Z","caller":"traceutil/trace.go:171","msg":"trace[1949810210] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"113.738229ms","start":"2026-02-04T01:49:45.594936Z","end":"2026-02-04T01:49:45.708675Z","steps":["trace[1949810210] 'process raft request'  (duration: 58.645023ms)","trace[1949810210] 'compare'  (duration: 54.845744ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:45.709343Z","caller":"traceutil/trace.go:171","msg":"trace[1708736265] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"108.119466ms","start":"2026-02-04T01:49:45.601209Z","end":"2026-02-04T01:49:45.709328Z","steps":["trace[1708736265] 'process raft request'  (duration: 107.348ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.710957Z","caller":"traceutil/trace.go:171","msg":"trace[2104116106] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"109.498377ms","start":"2026-02-04T01:49:45.601437Z","end":"2026-02-04T01:49:45.710936Z","steps":["trace[2104116106] 'process raft request'  (duration: 107.253999ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.947976Z","caller":"traceutil/trace.go:171","msg":"trace[245002674] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"151.286593ms","start":"2026-02-04T01:49:45.796668Z","end":"2026-02-04T01:49:45.947954Z","steps":["trace[245002674] 'process raft request'  (duration: 151.164002ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:45.948481Z","caller":"traceutil/trace.go:171","msg":"trace[2069277498] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"152.714674ms","start":"2026-02-04T01:49:45.795756Z","end":"2026-02-04T01:49:45.948471Z","steps":["trace[2069277498] 'process raft request'  (duration: 123.891646ms)","trace[2069277498] 'compare'  (duration: 28.082391ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:45.948669Z","caller":"traceutil/trace.go:171","msg":"trace[1565865694] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"152.373741ms","start":"2026-02-04T01:49:45.796288Z","end":"2026-02-04T01:49:45.948661Z","steps":["trace[1565865694] 'process raft request'  (duration: 151.519984ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.097705Z","caller":"traceutil/trace.go:171","msg":"trace[877825176] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"109.021754ms","start":"2026-02-04T01:49:45.988636Z","end":"2026-02-04T01:49:46.097657Z","steps":["trace[877825176] 'process raft request'  (duration: 108.983124ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.100181Z","caller":"traceutil/trace.go:171","msg":"trace[1554074246] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"146.559178ms","start":"2026-02-04T01:49:45.953612Z","end":"2026-02-04T01:49:46.100171Z","steps":["trace[1554074246] 'process raft request'  (duration: 143.839618ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.100481Z","caller":"traceutil/trace.go:171","msg":"trace[974103334] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"144.07528ms","start":"2026-02-04T01:49:45.956397Z","end":"2026-02-04T01:49:46.100472Z","steps":["trace[974103334] 'process raft request'  (duration: 141.138118ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.100699Z","caller":"traceutil/trace.go:171","msg":"trace[812445806] linearizableReadLoop","detail":"{readStateIndex:63; appliedIndex:60; }","duration":"144.345642ms","start":"2026-02-04T01:49:45.95633Z","end":"2026-02-04T01:49:46.100675Z","steps":["trace[812445806] 'read index received'  (duration: 29.156051ms)","trace[812445806] 'applied index is now lower than readState.Index'  (duration: 115.187501ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T01:49:46.100822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.468593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-04T01:49:46.101349Z","caller":"traceutil/trace.go:171","msg":"trace[451801811] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:61; }","duration":"145.008357ms","start":"2026-02-04T01:49:45.956325Z","end":"2026-02-04T01:49:46.101333Z","steps":["trace[451801811] 'agreement among raft nodes before linearized reading'  (duration: 144.443613ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:49:46.10342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.175067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-04T01:49:46.103466Z","caller":"traceutil/trace.go:171","msg":"trace[1080868911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:61; }","duration":"133.263988ms","start":"2026-02-04T01:49:45.97019Z","end":"2026-02-04T01:49:46.103454Z","steps":["trace[1080868911] 'agreement among raft nodes before linearized reading'  (duration: 133.197987ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.108571Z","caller":"traceutil/trace.go:171","msg":"trace[1504994470] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"155.183893ms","start":"2026-02-04T01:49:45.953374Z","end":"2026-02-04T01:49:46.108558Z","steps":["trace[1504994470] 'process raft request'  (duration: 96.569076ms)","trace[1504994470] 'compare'  (duration: 47.343653ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:46.230053Z","caller":"traceutil/trace.go:171","msg":"trace[1422816958] linearizableReadLoop","detail":"{readStateIndex:69; appliedIndex:65; }","duration":"119.107608ms","start":"2026-02-04T01:49:46.110923Z","end":"2026-02-04T01:49:46.23003Z","steps":["trace[1422816958] 'read index received'  (duration: 31.522405ms)","trace[1422816958] 'applied index is now lower than readState.Index'  (duration: 87.584243ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:46.230221Z","caller":"traceutil/trace.go:171","msg":"trace[1813134084] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"121.421255ms","start":"2026-02-04T01:49:46.108787Z","end":"2026-02-04T01:49:46.230208Z","steps":["trace[1813134084] 'process raft request'  (duration: 118.900116ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.230725Z","caller":"traceutil/trace.go:171","msg":"trace[797375653] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"120.095866ms","start":"2026-02-04T01:49:46.110617Z","end":"2026-02-04T01:49:46.230713Z","steps":["trace[797375653] 'process raft request'  (duration: 119.33442ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.23076Z","caller":"traceutil/trace.go:171","msg":"trace[1208454120] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"119.991234ms","start":"2026-02-04T01:49:46.110762Z","end":"2026-02-04T01:49:46.230753Z","steps":["trace[1208454120] 'process raft request'  (duration: 119.231899ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:49:46.230846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.910423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-04T01:49:46.232562Z","caller":"traceutil/trace.go:171","msg":"trace[1714215631] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:65; }","duration":"121.661007ms","start":"2026-02-04T01:49:46.110888Z","end":"2026-02-04T01:49:46.232549Z","steps":["trace[1714215631] 'agreement among raft nodes before linearized reading'  (duration: 119.907093ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:49:46.589195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.862965ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5563806078150416690 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-scheduler-instance.1890e809c49cc4ef\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-scheduler-instance.1890e809c49cc4ef\" value_size:639 lease:5563806078150416563 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-04T01:49:46.589458Z","caller":"traceutil/trace.go:171","msg":"trace[50673186] linearizableReadLoop","detail":"{readStateIndex:127; appliedIndex:126; }","duration":"157.522075ms","start":"2026-02-04T01:49:46.431919Z","end":"2026-02-04T01:49:46.589441Z","steps":["trace[50673186] 'read index received'  (duration: 9.857364ms)","trace[50673186] 'applied index is now lower than readState.Index'  (duration: 147.663331ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T01:49:46.589675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.746337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-04T01:49:46.589757Z","caller":"traceutil/trace.go:171","msg":"trace[847470662] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:0; response_revision:122; }","duration":"157.843528ms","start":"2026-02-04T01:49:46.431902Z","end":"2026-02-04T01:49:46.589745Z","steps":["trace[847470662] 'agreement among raft nodes before linearized reading'  (duration: 157.635486ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:46.589694Z","caller":"traceutil/trace.go:171","msg":"trace[1710537872] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"159.647021ms","start":"2026-02-04T01:49:46.429822Z","end":"2026-02-04T01:49:46.589469Z","steps":["trace[1710537872] 'process raft request'  (duration: 11.98407ms)","trace[1710537872] 'compare'  (duration: 146.783155ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:46.590492Z","caller":"traceutil/trace.go:171","msg":"trace[26760642] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"102.323573ms","start":"2026-02-04T01:49:46.488154Z","end":"2026-02-04T01:49:46.590477Z","steps":["trace[26760642] 'process raft request'  (duration: 102.266563ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:49:46.944527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.874337ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5563806078150416723 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:certificates.k8s.io:kubelet-serving-approver\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:certificates.k8s.io:kubelet-serving-approver\" value_size:587 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-04T01:49:46.945067Z","caller":"traceutil/trace.go:171","msg":"trace[2081349244] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"145.724527ms","start":"2026-02-04T01:49:46.799326Z","end":"2026-02-04T01:49:46.945051Z","steps":["trace[2081349244] 'process raft request'  (duration: 42.264395ms)","trace[2081349244] 'compare'  (duration: 102.587295ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:49:48.240285Z","caller":"traceutil/trace.go:171","msg":"trace[1994218553] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"100.631303ms","start":"2026-02-04T01:49:48.127185Z","end":"2026-02-04T01:49:48.227817Z","steps":["trace[1994218553] 'process raft request'  (duration: 97.006917ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:49:48.405448Z","caller":"traceutil/trace.go:171","msg":"trace[632786655] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"169.508603ms","start":"2026-02-04T01:49:48.235919Z","end":"2026-02-04T01:49:48.405427Z","steps":["trace[632786655] 'process raft request'  (duration: 92.561143ms)","trace[632786655] 'compare'  (duration: 76.833689ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:50:09.890428Z","caller":"traceutil/trace.go:171","msg":"trace[557240165] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"137.271913ms","start":"2026-02-04T01:50:09.753138Z","end":"2026-02-04T01:50:09.89041Z","steps":["trace[557240165] 'process raft request'  (duration: 137.176052ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:09.891727Z","caller":"traceutil/trace.go:171","msg":"trace[1996153413] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"138.097708ms","start":"2026-02-04T01:50:09.753617Z","end":"2026-02-04T01:50:09.891715Z","steps":["trace[1996153413] 'process raft request'  (duration: 137.959948ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:13.432335Z","caller":"traceutil/trace.go:171","msg":"trace[1215376019] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"129.901247ms","start":"2026-02-04T01:50:13.302408Z","end":"2026-02-04T01:50:13.432309Z","steps":["trace[1215376019] 'process raft request'  (duration: 129.771657ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:16.699399Z","caller":"traceutil/trace.go:171","msg":"trace[957828416] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"208.865088ms","start":"2026-02-04T01:50:16.49052Z","end":"2026-02-04T01:50:16.699385Z","steps":["trace[957828416] 'process raft request'  (duration: 208.790398ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:17.104709Z","caller":"traceutil/trace.go:171","msg":"trace[572444795] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"182.877718ms","start":"2026-02-04T01:50:16.921813Z","end":"2026-02-04T01:50:17.104691Z","steps":["trace[572444795] 'process raft request'  (duration: 182.694136ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:17.115821Z","caller":"traceutil/trace.go:171","msg":"trace[1038490236] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"154.266546ms","start":"2026-02-04T01:50:16.961541Z","end":"2026-02-04T01:50:17.115807Z","steps":["trace[1038490236] 'process raft request'  (duration: 150.781096ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.071547Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5563806078150417708,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-04T01:50:24.072853Z","caller":"traceutil/trace.go:171","msg":"trace[909384414] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"501.38411ms","start":"2026-02-04T01:50:23.571421Z","end":"2026-02-04T01:50:24.072805Z","steps":["trace[909384414] 'read index received'  (duration: 500.240844ms)","trace[909384414] 'applied index is now lower than readState.Index'  (duration: 1.142326ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:50:24.074002Z","caller":"traceutil/trace.go:171","msg":"trace[2010547247] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"651.545812ms","start":"2026-02-04T01:50:23.422443Z","end":"2026-02-04T01:50:24.073989Z","steps":["trace[2010547247] 'process raft request'  (duration: 649.768453ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.074246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:23.422428Z","time spent":"651.591922ms","remote":"127.0.0.1:33714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16795,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-xr482\" mod_revision:511 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-xr482\" value_size:16746 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-xr482\" > >"}
{"level":"warn","ts":"2026-02-04T01:50:24.074648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.23496ms","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-02-04T01:50:24.074878Z","caller":"traceutil/trace.go:171","msg":"trace[2016181029] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:613; }","duration":"503.426372ms","start":"2026-02-04T01:50:23.571369Z","end":"2026-02-04T01:50:24.074796Z","steps":["trace[2016181029] 'agreement among raft nodes before linearized reading'  (duration: 503.194251ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.074976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:23.571352Z","time spent":"503.614173ms","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-04T01:50:24.076172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.566167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.07636Z","caller":"traceutil/trace.go:171","msg":"trace[1002135313] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:613; }","duration":"101.625818ms","start":"2026-02-04T01:50:23.974588Z","end":"2026-02-04T01:50:24.076214Z","steps":["trace[1002135313] 'agreement among raft nodes before linearized reading'  (duration: 101.556018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.076933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.347158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.076988Z","caller":"traceutil/trace.go:171","msg":"trace[1704765064] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:613; }","duration":"105.407758ms","start":"2026-02-04T01:50:23.971566Z","end":"2026-02-04T01:50:24.076974Z","steps":["trace[1704765064] 'agreement among raft nodes before linearized reading'  (duration: 105.339368ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.077366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.803071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.077471Z","caller":"traceutil/trace.go:171","msg":"trace[720719285] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:613; }","duration":"105.842871ms","start":"2026-02-04T01:50:23.971545Z","end":"2026-02-04T01:50:24.077388Z","steps":["trace[720719285] 'agreement among raft nodes before linearized reading'  (duration: 105.72274ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.078549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.381263ms","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":"warn","ts":"2026-02-04T01:50:24.075592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.439052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-04T01:50:24.080254Z","caller":"traceutil/trace.go:171","msg":"trace[1496198158] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"460.086087ms","start":"2026-02-04T01:50:23.620118Z","end":"2026-02-04T01:50:24.080204Z","steps":["trace[1496198158] 'agreement among raft nodes before linearized reading'  (duration: 455.394962ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.080356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.074762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-04T01:50:24.08036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:23.620089Z","time spent":"460.227229ms","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-04T01:50:24.084352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.951691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.084495Z","caller":"traceutil/trace.go:171","msg":"trace[1061877819] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:613; }","duration":"106.098952ms","start":"2026-02-04T01:50:23.978381Z","end":"2026-02-04T01:50:24.08448Z","steps":["trace[1061877819] 'agreement among raft nodes before linearized reading'  (duration: 105.930461ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:24.078581Z","caller":"traceutil/trace.go:171","msg":"trace[1362824147] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:613; }","duration":"117.424063ms","start":"2026-02-04T01:50:23.961149Z","end":"2026-02-04T01:50:24.078573Z","steps":["trace[1362824147] 'agreement among raft nodes before linearized reading'  (duration: 117.371243ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:24.080403Z","caller":"traceutil/trace.go:171","msg":"trace[918299002] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:613; }","duration":"119.250383ms","start":"2026-02-04T01:50:23.961135Z","end":"2026-02-04T01:50:24.080386Z","steps":["trace[918299002] 'agreement among raft nodes before linearized reading'  (duration: 119.064582ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.08596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.843753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.087262Z","caller":"traceutil/trace.go:171","msg":"trace[1576809463] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:613; }","duration":"126.144569ms","start":"2026-02-04T01:50:23.961108Z","end":"2026-02-04T01:50:24.087252Z","steps":["trace[1576809463] 'agreement among raft nodes before linearized reading'  (duration: 124.830833ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.087451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.785681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.087526Z","caller":"traceutil/trace.go:171","msg":"trace[1553467529] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:613; }","duration":"135.840062ms","start":"2026-02-04T01:50:23.951652Z","end":"2026-02-04T01:50:24.087492Z","steps":["trace[1553467529] 'agreement among raft nodes before linearized reading'  (duration: 135.777611ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.087676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.025813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.087744Z","caller":"traceutil/trace.go:171","msg":"trace[295193327] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:613; }","duration":"136.077953ms","start":"2026-02-04T01:50:23.951637Z","end":"2026-02-04T01:50:24.087715Z","steps":["trace[295193327] 'agreement among raft nodes before linearized reading'  (duration: 136.022032ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.087879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.241343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:24.08794Z","caller":"traceutil/trace.go:171","msg":"trace[863781101] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:613; }","duration":"136.311485ms","start":"2026-02-04T01:50:23.951605Z","end":"2026-02-04T01:50:24.087917Z","steps":["trace[863781101] 'agreement among raft nodes before linearized reading'  (duration: 136.247754ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.08817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.79293ms","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-02-04T01:50:24.088265Z","caller":"traceutil/trace.go:171","msg":"trace[246268985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"460.90105ms","start":"2026-02-04T01:50:23.627358Z","end":"2026-02-04T01:50:24.088259Z","steps":["trace[246268985] 'agreement among raft nodes before linearized reading'  (duration: 460.708749ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:24.088308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:23.627353Z","time spent":"460.948332ms","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-04T01:50:24.71752Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5563806078150417711,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T01:50:25.138807Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.014682426s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-04T01:50:25.139041Z","caller":"traceutil/trace.go:171","msg":"trace[1482140514] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"923.457525ms","start":"2026-02-04T01:50:24.215569Z","end":"2026-02-04T01:50:25.139027Z","steps":["trace[1482140514] 'read index received'  (duration: 923.327015ms)","trace[1482140514] 'applied index is now lower than readState.Index'  (duration: 130.1µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:50:25.139213Z","caller":"traceutil/trace.go:171","msg":"trace[1572550433] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.031718678s","start":"2026-02-04T01:50:24.107489Z","end":"2026-02-04T01:50:25.139207Z","steps":["trace[1572550433] 'process raft request'  (duration: 1.031443447s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:25.139273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:24.107478Z","time spent":"1.031748408s","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:607 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-04T01:50:25.139362Z","caller":"traceutil/trace.go:171","msg":"trace[866799169] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.023780295s","start":"2026-02-04T01:50:24.115577Z","end":"2026-02-04T01:50:25.139357Z","steps":["trace[866799169] 'process raft request'  (duration: 1.023432533s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:25.139385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:24.115563Z","time spent":"1.023808285s","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:605 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-04T01:50:25.13949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.919588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-04T01:50:25.139511Z","caller":"traceutil/trace.go:171","msg":"trace[260531820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"923.957878ms","start":"2026-02-04T01:50:24.215548Z","end":"2026-02-04T01:50:25.139506Z","steps":["trace[260531820] 'agreement among raft nodes before linearized reading'  (duration: 923.882177ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:25.139527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:24.215537Z","time spent":"923.985668ms","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T01:50:25.139607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.783416ms","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-02-04T01:50:25.139624Z","caller":"traceutil/trace.go:171","msg":"trace[1393027029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"923.807487ms","start":"2026-02-04T01:50:24.215812Z","end":"2026-02-04T01:50:25.13962Z","steps":["trace[1393027029] 'agreement among raft nodes before linearized reading'  (duration: 923.769047ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:50:25.139635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T01:50:24.215808Z","time spent":"923.824167ms","remote":"127.0.0.1:33824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-04T01:50:25.361494Z","caller":"traceutil/trace.go:171","msg":"trace[2046950048] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"213.937345ms","start":"2026-02-04T01:50:25.147541Z","end":"2026-02-04T01:50:25.361479Z","steps":["trace[2046950048] 'read index received'  (duration: 170.870325ms)","trace[2046950048] 'applied index is now lower than readState.Index'  (duration: 43.06631ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T01:50:25.361587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.029635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:50:25.361608Z","caller":"traceutil/trace.go:171","msg":"trace[1495246792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"214.076445ms","start":"2026-02-04T01:50:25.147525Z","end":"2026-02-04T01:50:25.361601Z","steps":["trace[1495246792] 'agreement among raft nodes before linearized reading'  (duration: 214.017795ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:25.361811Z","caller":"traceutil/trace.go:171","msg":"trace[2097975301] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"217.758226ms","start":"2026-02-04T01:50:25.144044Z","end":"2026-02-04T01:50:25.361803Z","steps":["trace[2097975301] 'process raft request'  (duration: 174.360515ms)","trace[2097975301] 'compare'  (duration: 42.965479ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T01:50:25.361905Z","caller":"traceutil/trace.go:171","msg":"trace[441813730] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"217.423474ms","start":"2026-02-04T01:50:25.144474Z","end":"2026-02-04T01:50:25.361898Z","steps":["trace[441813730] 'process raft request'  (duration: 216.979202ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T01:50:29.568485Z","caller":"traceutil/trace.go:171","msg":"trace[144045222] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"105.291024ms","start":"2026-02-04T01:50:29.463063Z","end":"2026-02-04T01:50:29.568354Z","steps":["trace[144045222] 'process raft request'  (duration: 103.839976ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:51:52.75783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.24258ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5563806078150418671 > lease_revoke:<id:4d369c265750a03c>","response":"size:28"}
{"level":"warn","ts":"2026-02-04T01:51:53.34337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.651871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T01:51:53.343482Z","caller":"traceutil/trace.go:171","msg":"trace[388083687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1013; }","duration":"191.807025ms","start":"2026-02-04T01:51:53.151648Z","end":"2026-02-04T01:51:53.343455Z","steps":["trace[388083687] 'range keys from in-memory index tree'  (duration: 191.57971ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T01:52:01.732783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.188888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" ","response":"range_response_count:1 size:726"}
{"level":"info","ts":"2026-02-04T01:52:01.732859Z","caller":"traceutil/trace.go:171","msg":"trace[1354445240] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver; range_end:; response_count:1; response_revision:1040; }","duration":"129.29183ms","start":"2026-02-04T01:52:01.603548Z","end":"2026-02-04T01:52:01.73284Z","steps":["trace[1354445240] 'range keys from in-memory index tree'  (duration: 129.118517ms)"],"step_count":1}