{"level":"warn","ts":"2026-03-23T05:15:47.98292Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-23T05:15:47.983057Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.152: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.19.213.152:2380","--initial-cluster=instance=https://199.19.213.152:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.152:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.152: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-03-23T05:15:47.983173Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-23T05:15:47.983194Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.152:2380"]} {"level":"info","ts":"2026-03-23T05:15:47.983229Z","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-03-23T05:15:47.984416Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"]} {"level":"info","ts":"2026-03-23T05:15:47.984529Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.152:2380"],"listen-peer-urls":["https://199.19.213.152:2380"],"advertise-client-urls":["https://199.19.213.152:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.152: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-03-23T05:15:47.989675Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.85525ms"} {"level":"info","ts":"2026-03-23T05:15:47.998173Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"68d6d88687e6b830","cluster-id":"8a5d84e8c26d99a1"} {"level":"info","ts":"2026-03-23T05:15:47.998282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=()"} {"level":"info","ts":"2026-03-23T05:15:47.998311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became follower at term 0"} {"level":"info","ts":"2026-03-23T05:15:47.998347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 68d6d88687e6b830 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-23T05:15:47.998361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became follower at term 1"} {"level":"info","ts":"2026-03-23T05:15:47.998414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=(7554463497277847600)"} {"level":"warn","ts":"2026-03-23T05:15:48.004048Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-23T05:15:48.005631Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-23T05:15:48.00844Z","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-03-23T05:15:48.010325Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"68d6d88687e6b830","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-23T05:15:48.010504Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"68d6d88687e6b830","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-23T05:15:48.010687Z","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-03-23T05:15:48.010773Z","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-03-23T05:15:48.01079Z","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-03-23T05:15:48.01158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=(7554463497277847600)"} {"level":"info","ts":"2026-03-23T05:15:48.014995Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8a5d84e8c26d99a1","local-member-id":"68d6d88687e6b830","added-peer-id":"68d6d88687e6b830","added-peer-peer-urls":["https://199.19.213.152:2380"]} {"level":"info","ts":"2026-03-23T05:15:48.016147Z","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-03-23T05:15:48.016358Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"68d6d88687e6b830","initial-advertise-peer-urls":["https://199.19.213.152:2380"],"listen-peer-urls":["https://199.19.213.152:2380"],"advertise-client-urls":["https://199.19.213.152:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-23T05:15:48.016393Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-23T05:15:48.016518Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.152:2380"} {"level":"info","ts":"2026-03-23T05:15:48.016538Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.152:2380"} {"level":"info","ts":"2026-03-23T05:15:48.499122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 is starting a new election at term 1"} {"level":"info","ts":"2026-03-23T05:15:48.49918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-23T05:15:48.499216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 received MsgPreVoteResp from 68d6d88687e6b830 at term 1"} {"level":"info","ts":"2026-03-23T05:15:48.499232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became candidate at term 2"} {"level":"info","ts":"2026-03-23T05:15:48.499248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 received MsgVoteResp from 68d6d88687e6b830 at term 2"} {"level":"info","ts":"2026-03-23T05:15:48.499262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became leader at term 2"} {"level":"info","ts":"2026-03-23T05:15:48.499278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 68d6d88687e6b830 elected leader 68d6d88687e6b830 at term 2"} {"level":"info","ts":"2026-03-23T05:15:48.500975Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"68d6d88687e6b830","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.152:2379]}","request-path":"/0/members/68d6d88687e6b830/attributes","cluster-id":"8a5d84e8c26d99a1","publish-timeout":"7s"} {"level":"info","ts":"2026-03-23T05:15:48.501115Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-23T05:15:48.501251Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-23T05:15:48.501278Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-23T05:15:48.501535Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-23T05:15:48.501595Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-23T05:15:48.502324Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8a5d84e8c26d99a1","local-member-id":"68d6d88687e6b830","cluster-version":"3.5"} {"level":"info","ts":"2026-03-23T05:15:48.502486Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-23T05:15:48.502544Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-23T05:15:48.50326Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-23T05:15:48.50437Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.152:2379"} {"level":"warn","ts":"2026-03-23T05:16:05.222579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.352502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-23T05:16:05.222748Z","caller":"traceutil/trace.go:171","msg":"trace[390807851] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:432; }","duration":"119.892083ms","start":"2026-03-23T05:16:05.102834Z","end":"2026-03-23T05:16:05.222727Z","steps":["trace[390807851] 'read index received' (duration: 6.174847ms)","trace[390807851] 'applied index is now lower than readState.Index' (duration: 113.715606ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:05.222808Z","caller":"traceutil/trace.go:171","msg":"trace[1842900462] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"218.867926ms","start":"2026-03-23T05:16:05.003895Z","end":"2026-03-23T05:16:05.222763Z","steps":["trace[1842900462] 'process raft request' (duration: 105.270293ms)","trace[1842900462] 'compare' (duration: 112.209168ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:05.222886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.026917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-03-23T05:16:05.222943Z","caller":"traceutil/trace.go:171","msg":"trace[1221374523] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:419; }","duration":"120.16204ms","start":"2026-03-23T05:16:05.102768Z","end":"2026-03-23T05:16:05.22293Z","steps":["trace[1221374523] 'agreement among raft nodes before linearized reading' (duration: 120.031257ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:05.655982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.582324ms","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-03-23T05:16:05.656088Z","caller":"traceutil/trace.go:171","msg":"trace[1786274484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"296.754957ms","start":"2026-03-23T05:16:05.359312Z","end":"2026-03-23T05:16:05.656067Z","steps":["trace[1786274484] 'range keys from in-memory index tree' (duration: 296.372877ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:05.833753Z","caller":"traceutil/trace.go:171","msg":"trace[2082482780] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"173.824788ms","start":"2026-03-23T05:16:05.65989Z","end":"2026-03-23T05:16:05.833714Z","steps":["trace[2082482780] 'process raft request' (duration: 173.656943ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:20.680302Z","caller":"traceutil/trace.go:171","msg":"trace[1594947736] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"137.227475ms","start":"2026-03-23T05:16:20.543038Z","end":"2026-03-23T05:16:20.680265Z","steps":["trace[1594947736] 'process raft request' (duration: 136.96986ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:20.852687Z","caller":"traceutil/trace.go:171","msg":"trace[341878577] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"129.792163ms","start":"2026-03-23T05:16:20.722866Z","end":"2026-03-23T05:16:20.852658Z","steps":["trace[341878577] 'process raft request' (duration: 128.195319ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:20.861103Z","caller":"traceutil/trace.go:171","msg":"trace[1114753358] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"127.078244ms","start":"2026-03-23T05:16:20.734008Z","end":"2026-03-23T05:16:20.861086Z","steps":["trace[1114753358] 'process raft request' (duration: 126.982212ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.054354Z","caller":"traceutil/trace.go:171","msg":"trace[1114420130] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"127.333554ms","start":"2026-03-23T05:16:22.926993Z","end":"2026-03-23T05:16:23.054326Z","steps":["trace[1114420130] 'process raft request' (duration: 126.797914ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.12729Z","caller":"traceutil/trace.go:171","msg":"trace[1919439060] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"186.332141ms","start":"2026-03-23T05:16:22.940936Z","end":"2026-03-23T05:16:23.127268Z","steps":["trace[1919439060] 'process raft request' (duration: 186.29249ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.127358Z","caller":"traceutil/trace.go:171","msg":"trace[520467352] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"187.578636ms","start":"2026-03-23T05:16:22.939757Z","end":"2026-03-23T05:16:23.127335Z","steps":["trace[520467352] 'process raft request' (duration: 187.32022ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.127442Z","caller":"traceutil/trace.go:171","msg":"trace[1944123524] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"187.604297ms","start":"2026-03-23T05:16:22.939806Z","end":"2026-03-23T05:16:23.12741Z","steps":["trace[1944123524] 'process raft request' (duration: 187.381081ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.197253Z","caller":"traceutil/trace.go:171","msg":"trace[1802664485] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:581; }","duration":"115.006542ms","start":"2026-03-23T05:16:23.082223Z","end":"2026-03-23T05:16:23.197229Z","steps":["trace[1802664485] 'read index received' (duration: 44.825337ms)","trace[1802664485] 'applied index is now lower than readState.Index' (duration: 70.179925ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:23.197396Z","caller":"traceutil/trace.go:171","msg":"trace[920755784] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"128.734732ms","start":"2026-03-23T05:16:23.068628Z","end":"2026-03-23T05:16:23.197363Z","steps":["trace[920755784] 'process raft request' (duration: 128.365323ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:23.197636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.225196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-23T05:16:23.197693Z","caller":"traceutil/trace.go:171","msg":"trace[692569699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"115.487162ms","start":"2026-03-23T05:16:23.082191Z","end":"2026-03-23T05:16:23.197678Z","steps":["trace[692569699] 'agreement among raft nodes before linearized reading' (duration: 115.125265ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.324071Z","caller":"traceutil/trace.go:171","msg":"trace[290879235] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"169.887831ms","start":"2026-03-23T05:16:23.154164Z","end":"2026-03-23T05:16:23.324052Z","steps":["trace[290879235] 'process raft request' (duration: 169.755958ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.324089Z","caller":"traceutil/trace.go:171","msg":"trace[1479807095] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"191.804104ms","start":"2026-03-23T05:16:23.132254Z","end":"2026-03-23T05:16:23.324058Z","steps":["trace[1479807095] 'process raft request' (duration: 162.166848ms)","trace[1479807095] 'compare' (duration: 29.3408ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:23.33004Z","caller":"traceutil/trace.go:171","msg":"trace[921207942] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"115.641483ms","start":"2026-03-23T05:16:23.214378Z","end":"2026-03-23T05:16:23.330019Z","steps":["trace[921207942] 'process raft request' (duration: 115.556772ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.330136Z","caller":"traceutil/trace.go:171","msg":"trace[662102973] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"126.940082ms","start":"2026-03-23T05:16:23.20316Z","end":"2026-03-23T05:16:23.3301Z","steps":["trace[662102973] 'process raft request' (duration: 126.32978ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.5436Z","caller":"traceutil/trace.go:171","msg":"trace[1160125295] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"129.070878ms","start":"2026-03-23T05:16:23.414505Z","end":"2026-03-23T05:16:23.543576Z","steps":["trace[1160125295] 'process raft request' (duration: 88.48149ms)","trace[1160125295] 'compare' (duration: 40.062537ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:23.543668Z","caller":"traceutil/trace.go:171","msg":"trace[853877603] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"118.195217ms","start":"2026-03-23T05:16:23.425447Z","end":"2026-03-23T05:16:23.543642Z","steps":["trace[853877603] 'process raft request' (duration: 117.904911ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.774885Z","caller":"traceutil/trace.go:171","msg":"trace[1181680412] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"190.535377ms","start":"2026-03-23T05:16:23.584321Z","end":"2026-03-23T05:16:23.774856Z","steps":["trace[1181680412] 'process raft request' (duration: 122.177562ms)","trace[1181680412] 'compare' (duration: 68.218023ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:23.775699Z","caller":"traceutil/trace.go:171","msg":"trace[507597595] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:597; }","duration":"146.814814ms","start":"2026-03-23T05:16:23.628864Z","end":"2026-03-23T05:16:23.775679Z","steps":["trace[507597595] 'read index received' (duration: 77.640221ms)","trace[507597595] 'applied index is now lower than readState.Index' (duration: 69.173553ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:23.775791Z","caller":"traceutil/trace.go:171","msg":"trace[593361508] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"146.769363ms","start":"2026-03-23T05:16:23.629003Z","end":"2026-03-23T05:16:23.775773Z","steps":["trace[593361508] 'process raft request' (duration: 146.6327ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.775847Z","caller":"traceutil/trace.go:171","msg":"trace[1326865128] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"155.179931ms","start":"2026-03-23T05:16:23.620644Z","end":"2026-03-23T05:16:23.775824Z","steps":["trace[1326865128] 'process raft request' (duration: 154.646139ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:23.775889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.006788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-23T05:16:23.775947Z","caller":"traceutil/trace.go:171","msg":"trace[2134336645] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:582; }","duration":"147.091809ms","start":"2026-03-23T05:16:23.628834Z","end":"2026-03-23T05:16:23.775926Z","steps":["trace[2134336645] 'agreement among raft nodes before linearized reading' (duration: 146.991947ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.777948Z","caller":"traceutil/trace.go:171","msg":"trace[1771083874] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"147.692473ms","start":"2026-03-23T05:16:23.628033Z","end":"2026-03-23T05:16:23.775725Z","steps":["trace[1771083874] 'process raft request' (duration: 147.56113ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.964646Z","caller":"traceutil/trace.go:171","msg":"trace[1640658764] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"118.371603ms","start":"2026-03-23T05:16:23.846251Z","end":"2026-03-23T05:16:23.964623Z","steps":["trace[1640658764] 'process raft request' (duration: 118.311432ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:23.964729Z","caller":"traceutil/trace.go:171","msg":"trace[2108294252] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"118.457145ms","start":"2026-03-23T05:16:23.846227Z","end":"2026-03-23T05:16:23.964684Z","steps":["trace[2108294252] 'process raft request' (duration: 51.303055ms)","trace[2108294252] 'compare' (duration: 66.871113ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:24.225658Z","caller":"traceutil/trace.go:171","msg":"trace[670756321] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"171.308976ms","start":"2026-03-23T05:16:24.054319Z","end":"2026-03-23T05:16:24.225628Z","steps":["trace[670756321] 'read index received' (duration: 127.771225ms)","trace[670756321] 'applied index is now lower than readState.Index' (duration: 43.536601ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:24.225804Z","caller":"traceutil/trace.go:171","msg":"trace[1586876651] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"171.850488ms","start":"2026-03-23T05:16:24.053915Z","end":"2026-03-23T05:16:24.225766Z","steps":["trace[1586876651] 'process raft request' (duration: 128.101583ms)","trace[1586876651] 'compare' (duration: 43.48109ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:24.226062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.699944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" ","response":"range_response_count:1 size:3264"} {"level":"info","ts":"2026-03-23T05:16:24.226163Z","caller":"traceutil/trace.go:171","msg":"trace[167976628] range","detail":"{range_begin:/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5; range_end:; response_count:1; response_revision:596; }","duration":"171.824417ms","start":"2026-03-23T05:16:24.054311Z","end":"2026-03-23T05:16:24.226135Z","steps":["trace[167976628] 'agreement among raft nodes before linearized reading' (duration: 171.586212ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:24.254706Z","caller":"traceutil/trace.go:171","msg":"trace[478085203] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"188.988717ms","start":"2026-03-23T05:16:24.065695Z","end":"2026-03-23T05:16:24.254684Z","steps":["trace[478085203] 'process raft request' (duration: 188.389634ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:24.260077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.340067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-03-23T05:16:24.260185Z","caller":"traceutil/trace.go:171","msg":"trace[1249462836] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:597; }","duration":"138.473329ms","start":"2026-03-23T05:16:24.121674Z","end":"2026-03-23T05:16:24.260147Z","steps":["trace[1249462836] 'agreement among raft nodes before linearized reading' (duration: 133.019674ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:27.556099Z","caller":"traceutil/trace.go:171","msg":"trace[1138905222] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"185.199462ms","start":"2026-03-23T05:16:27.370881Z","end":"2026-03-23T05:16:27.556081Z","steps":["trace[1138905222] 'read index received' (duration: 185.044199ms)","trace[1138905222] 'applied index is now lower than readState.Index' (duration: 154.723µs)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:27.556188Z","caller":"traceutil/trace.go:171","msg":"trace[747324885] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"193.506889ms","start":"2026-03-23T05:16:27.362636Z","end":"2026-03-23T05:16:27.556143Z","steps":["trace[747324885] 'process raft request' (duration: 193.332956ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:27.556256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.367165ms","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-03-23T05:16:27.556277Z","caller":"traceutil/trace.go:171","msg":"trace[1321914838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"185.435827ms","start":"2026-03-23T05:16:27.370835Z","end":"2026-03-23T05:16:27.556271Z","steps":["trace[1321914838] 'agreement among raft nodes before linearized reading' (duration: 185.317714ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:28.800782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.404617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-23T05:16:28.80092Z","caller":"traceutil/trace.go:171","msg":"trace[438293640] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"266.312303ms","start":"2026-03-23T05:16:28.534588Z","end":"2026-03-23T05:16:28.8009Z","steps":["trace[438293640] 'read index received' (duration: 39.491µs)","trace[438293640] 'applied index is now lower than readState.Index' (duration: 266.271542ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:28.801128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.530747ms","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-03-23T05:16:28.801166Z","caller":"traceutil/trace.go:171","msg":"trace[1461368376] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"266.609808ms","start":"2026-03-23T05:16:28.534546Z","end":"2026-03-23T05:16:28.801156Z","steps":["trace[1461368376] 'agreement among raft nodes before linearized reading' (duration: 266.406494ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:28.801146Z","caller":"traceutil/trace.go:171","msg":"trace[14868068] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"301.226517ms","start":"2026-03-23T05:16:28.499877Z","end":"2026-03-23T05:16:28.801104Z","steps":["trace[14868068] 'process raft request' (duration: 22.403032ms)","trace[14868068] 'compare' (duration: 278.243183ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:28.801382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:28.499843Z","time spent":"301.43142ms","remote":"127.0.0.1:34388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":688,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-23T05:16:29.22922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.478008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-23T05:16:29.229372Z","caller":"traceutil/trace.go:171","msg":"trace[1809274903] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"423.071703ms","start":"2026-03-23T05:16:28.806274Z","end":"2026-03-23T05:16:29.229346Z","steps":["trace[1809274903] 'process raft request' (duration: 287.34156ms)","trace[1809274903] 'compare' (duration: 135.270233ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:29.229444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:28.806238Z","time spent":"423.175085ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-23T05:16:29.777315Z","caller":"traceutil/trace.go:171","msg":"trace[1718029654] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"470.541817ms","start":"2026-03-23T05:16:29.306744Z","end":"2026-03-23T05:16:29.777286Z","steps":["trace[1718029654] 'read index received' (duration: 470.123108ms)","trace[1718029654] 'applied index is now lower than readState.Index' (duration: 417.219µs)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:29.777631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.868423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-23T05:16:29.777763Z","caller":"traceutil/trace.go:171","msg":"trace[1269047414] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"471.404883ms","start":"2026-03-23T05:16:29.306335Z","end":"2026-03-23T05:16:29.77774Z","steps":["trace[1269047414] 'process raft request' (duration: 470.545087ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:29.777924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:29.306314Z","time spent":"471.528916ms","remote":"127.0.0.1:34478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-23T05:16:29.777937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.306944ms","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-03-23T05:16:29.777958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.911677ms","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-03-23T05:16:29.77802Z","caller":"traceutil/trace.go:171","msg":"trace[291371309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"218.461617ms","start":"2026-03-23T05:16:29.55954Z","end":"2026-03-23T05:16:29.778002Z","steps":["trace[291371309] 'agreement among raft nodes before linearized reading' (duration: 218.217522ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:29.778028Z","caller":"traceutil/trace.go:171","msg":"trace[1332846723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"168.03147ms","start":"2026-03-23T05:16:29.609981Z","end":"2026-03-23T05:16:29.778012Z","steps":["trace[1332846723] 'agreement among raft nodes before linearized reading' (duration: 167.814634ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:29.778428Z","caller":"traceutil/trace.go:171","msg":"trace[2092597148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"470.996695ms","start":"2026-03-23T05:16:29.306686Z","end":"2026-03-23T05:16:29.777682Z","steps":["trace[2092597148] 'agreement among raft nodes before linearized reading' (duration: 470.863413ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:29.778487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:29.306664Z","time spent":"471.808841ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-23T05:16:30.319498Z","caller":"traceutil/trace.go:171","msg":"trace[1873504579] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"536.842064ms","start":"2026-03-23T05:16:29.782633Z","end":"2026-03-23T05:16:30.319475Z","steps":["trace[1873504579] 'process raft request' (duration: 531.05383ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:30.31965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:29.782613Z","time spent":"536.958797ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-23T05:16:30.324309Z","caller":"traceutil/trace.go:171","msg":"trace[496482431] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"319.813917ms","start":"2026-03-23T05:16:30.004469Z","end":"2026-03-23T05:16:30.324283Z","steps":["trace[496482431] 'read index received' (duration: 309.256567ms)","trace[496482431] 'applied index is now lower than readState.Index' (duration: 10.55593ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:30.32433Z","caller":"traceutil/trace.go:171","msg":"trace[1151752333] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"539.439706ms","start":"2026-03-23T05:16:29.78487Z","end":"2026-03-23T05:16:30.324309Z","steps":["trace[1151752333] 'process raft request' (duration: 539.08998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:30.324549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.085803ms","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-03-23T05:16:30.324594Z","caller":"traceutil/trace.go:171","msg":"trace[237176617] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:615; }","duration":"320.176854ms","start":"2026-03-23T05:16:30.004409Z","end":"2026-03-23T05:16:30.324586Z","steps":["trace[237176617] 'agreement among raft nodes before linearized reading' (duration: 319.958209ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:30.324618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:30.004386Z","time spent":"320.227315ms","remote":"127.0.0.1:34558","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-03-23T05:16:30.324685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.430925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-03-23T05:16:30.324697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:29.784849Z","time spent":"539.689102ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-23T05:16:30.324763Z","caller":"traceutil/trace.go:171","msg":"trace[1776912124] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"132.558777ms","start":"2026-03-23T05:16:30.192186Z","end":"2026-03-23T05:16:30.324745Z","steps":["trace[1776912124] 'agreement among raft nodes before linearized reading' (duration: 132.353393ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:30.545085Z","caller":"traceutil/trace.go:171","msg":"trace[1037513981] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"215.335535ms","start":"2026-03-23T05:16:30.329721Z","end":"2026-03-23T05:16:30.545057Z","steps":["trace[1037513981] 'process raft request' (duration: 157.220634ms)","trace[1037513981] 'compare' (duration: 57.999648ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:31.434941Z","caller":"traceutil/trace.go:171","msg":"trace[1294560576] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"200.975637ms","start":"2026-03-23T05:16:31.23394Z","end":"2026-03-23T05:16:31.434916Z","steps":["trace[1294560576] 'read index received' (duration: 200.752552ms)","trace[1294560576] 'applied index is now lower than readState.Index' (duration: 222.275µs)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:31.435106Z","caller":"traceutil/trace.go:171","msg":"trace[389635582] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"311.738061ms","start":"2026-03-23T05:16:31.123231Z","end":"2026-03-23T05:16:31.434969Z","steps":["trace[389635582] 'process raft request' (duration: 311.523066ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:31.435178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.216821ms","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-03-23T05:16:31.435222Z","caller":"traceutil/trace.go:171","msg":"trace[1807355043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"201.312982ms","start":"2026-03-23T05:16:31.233897Z","end":"2026-03-23T05:16:31.43521Z","steps":["trace[1807355043] 'agreement among raft nodes before linearized reading' (duration: 201.149589ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:31.43521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.579065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-23T05:16:31.435285Z","caller":"traceutil/trace.go:171","msg":"trace[760394122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"127.689866ms","start":"2026-03-23T05:16:31.307574Z","end":"2026-03-23T05:16:31.435264Z","steps":["trace[760394122] 'agreement among raft nodes before linearized reading' (duration: 127.534353ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:16:31.435423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-23T05:16:31.123211Z","time spent":"312.060236ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-23T05:16:36.514299Z","caller":"traceutil/trace.go:171","msg":"trace[2142507054] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"162.830279ms","start":"2026-03-23T05:16:36.351444Z","end":"2026-03-23T05:16:36.514274Z","steps":["trace[2142507054] 'process raft request' (duration: 162.612505ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:36.692319Z","caller":"traceutil/trace.go:171","msg":"trace[679388873] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"172.217665ms","start":"2026-03-23T05:16:36.520073Z","end":"2026-03-23T05:16:36.69229Z","steps":["trace[679388873] 'process raft request' (duration: 158.69592ms)","trace[679388873] 'compare' (duration: 13.343482ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:16:36.692533Z","caller":"traceutil/trace.go:171","msg":"trace[1615471413] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"168.22338ms","start":"2026-03-23T05:16:36.524299Z","end":"2026-03-23T05:16:36.692523Z","steps":["trace[1615471413] 'process raft request' (duration: 167.929275ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:16:36.734589Z","caller":"traceutil/trace.go:171","msg":"trace[39946230] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:671; }","duration":"111.619148ms","start":"2026-03-23T05:16:36.622927Z","end":"2026-03-23T05:16:36.734546Z","steps":["trace[39946230] 'read index received' (duration: 55.836919ms)","trace[39946230] 'applied index is now lower than readState.Index' (duration: 55.780779ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:16:36.734807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.852112ms","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-03-23T05:16:36.734842Z","caller":"traceutil/trace.go:171","msg":"trace[709703735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:652; }","duration":"111.935943ms","start":"2026-03-23T05:16:36.622896Z","end":"2026-03-23T05:16:36.734832Z","steps":["trace[709703735] 'agreement among raft nodes before linearized reading' (duration: 111.76283ms)"],"step_count":1} {"level":"warn","ts":"2026-03-23T05:17:59.348065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.442333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-23T05:17:59.348185Z","caller":"traceutil/trace.go:171","msg":"trace[1729414491] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1051; }","duration":"131.584438ms","start":"2026-03-23T05:17:59.216591Z","end":"2026-03-23T05:17:59.348175Z","steps":["trace[1729414491] 'read index received' (duration: 41.885369ms)","trace[1729414491] 'applied index is now lower than readState.Index' (duration: 89.698599ms)"],"step_count":2} {"level":"info","ts":"2026-03-23T05:17:59.348239Z","caller":"traceutil/trace.go:171","msg":"trace[636527043] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"217.1615ms","start":"2026-03-23T05:17:59.131071Z","end":"2026-03-23T05:17:59.348233Z","steps":["trace[636527043] 'process raft request' (duration: 47.500284ms)","trace[636527043] 'compare' (duration: 169.352482ms)"],"step_count":2} {"level":"warn","ts":"2026-03-23T05:17:59.348559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.948153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-23T05:17:59.348556Z","caller":"traceutil/trace.go:171","msg":"trace[777645062] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"216.944988ms","start":"2026-03-23T05:17:59.131587Z","end":"2026-03-23T05:17:59.348532Z","steps":["trace[777645062] 'process raft request' (duration: 216.561093ms)"],"step_count":1} {"level":"info","ts":"2026-03-23T05:17:59.348677Z","caller":"traceutil/trace.go:171","msg":"trace[2062043120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1012; }","duration":"132.096605ms","start":"2026-03-23T05:17:59.216541Z","end":"2026-03-23T05:17:59.348638Z","steps":["trace[2062043120] 'agreement among raft nodes before linearized reading' (duration: 131.717151ms)"],"step_count":1}