{"level":"warn","ts":"2026-10-17T09:57:55.313467Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T09:57:55.313636Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.102: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://162.253.55.102:2380","--initial-cluster=instance=https://162.253.55.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.102:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-17T09:57:55.313734Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T09:57:55.313785Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.102:2380"]} {"level":"info","ts":"2026-10-17T09:57:55.313821Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-17T09:57:55.314462Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"]} {"level":"info","ts":"2026-10-17T09:57:55.314602Z","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://162.253.55.102:2380"],"listen-peer-urls":["https://162.253.55.102:2380"],"advertise-client-urls":["https://162.253.55.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.102:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-17T09:57:55.320179Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.267699ms"} {"level":"info","ts":"2026-10-17T09:57:55.337738Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2af340d70e332c3","cluster-id":"da2a6dcf93591a68"} {"level":"info","ts":"2026-10-17T09:57:55.337866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T09:57:55.337894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became follower at term 0"} {"level":"info","ts":"2026-10-17T09:57:55.337912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2af340d70e332c3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T09:57:55.337923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became follower at term 1"} {"level":"info","ts":"2026-10-17T09:57:55.337966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=(16334331605829235395)"} {"level":"warn","ts":"2026-10-17T09:57:55.347617Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T09:57:55.349199Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T09:57:55.35056Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-17T09:57:55.353035Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2af340d70e332c3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T09:57:55.35811Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2af340d70e332c3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T09:57:55.358425Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-17T09:57:55.358668Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-17T09:57:55.3587Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-17T09:57:55.365689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=(16334331605829235395)"} {"level":"info","ts":"2026-10-17T09:57:55.365844Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"da2a6dcf93591a68","local-member-id":"e2af340d70e332c3","added-peer-id":"e2af340d70e332c3","added-peer-peer-urls":["https://162.253.55.102:2380"]} {"level":"info","ts":"2026-10-17T09:57:55.366196Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-17T09:57:55.366267Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.102:2380"} {"level":"info","ts":"2026-10-17T09:57:55.366299Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.102:2380"} {"level":"info","ts":"2026-10-17T09:57:55.366511Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2af340d70e332c3","initial-advertise-peer-urls":["https://162.253.55.102:2380"],"listen-peer-urls":["https://162.253.55.102:2380"],"advertise-client-urls":["https://162.253.55.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T09:57:55.366555Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T09:57:55.538391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T09:57:55.538526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T09:57:55.538567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 received MsgPreVoteResp from e2af340d70e332c3 at term 1"} {"level":"info","ts":"2026-10-17T09:57:55.538598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became candidate at term 2"} {"level":"info","ts":"2026-10-17T09:57:55.538621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 received MsgVoteResp from e2af340d70e332c3 at term 2"} {"level":"info","ts":"2026-10-17T09:57:55.538643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became leader at term 2"} {"level":"info","ts":"2026-10-17T09:57:55.538669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2af340d70e332c3 elected leader e2af340d70e332c3 at term 2"} {"level":"info","ts":"2026-10-17T09:57:55.539837Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T09:57:55.541121Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T09:57:55.541106Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2af340d70e332c3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.102:2379]}","request-path":"/0/members/e2af340d70e332c3/attributes","cluster-id":"da2a6dcf93591a68","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T09:57:55.541288Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T09:57:55.541721Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T09:57:55.54186Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T09:57:55.545117Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"da2a6dcf93591a68","local-member-id":"e2af340d70e332c3","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T09:57:55.545354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T09:57:55.545528Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T09:57:55.545624Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T09:57:55.554498Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.102:2379"} {"level":"info","ts":"2026-10-17T09:58:22.32937Z","caller":"traceutil/trace.go:171","msg":"trace[1916893199] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"198.616701ms","start":"2026-10-17T09:58:22.130733Z","end":"2026-10-17T09:58:22.329349Z","steps":["trace[1916893199] 'process raft request' (duration: 198.496009ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:22.634224Z","caller":"traceutil/trace.go:171","msg":"trace[296320342] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"232.292513ms","start":"2026-10-17T09:58:22.401915Z","end":"2026-10-17T09:58:22.634208Z","steps":["trace[296320342] 'process raft request' (duration: 213.781506ms)","trace[296320342] 'compare' (duration: 18.283413ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T09:58:40.983601Z","caller":"traceutil/trace.go:171","msg":"trace[1728172118] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"163.04387ms","start":"2026-10-17T09:58:40.82052Z","end":"2026-10-17T09:58:40.983564Z","steps":["trace[1728172118] 'process raft request' (duration: 162.757815ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.984172Z","caller":"traceutil/trace.go:171","msg":"trace[644401644] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"153.722239ms","start":"2026-10-17T09:58:40.830437Z","end":"2026-10-17T09:58:40.984159Z","steps":["trace[644401644] 'process raft request' (duration: 153.587447ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.984264Z","caller":"traceutil/trace.go:171","msg":"trace[471221592] transaction","detail":"{read_only:false; number_of_response:1; response_revision:565; }","duration":"153.237722ms","start":"2026-10-17T09:58:40.831013Z","end":"2026-10-17T09:58:40.984251Z","steps":["trace[471221592] 'process raft request' (duration: 153.054679ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.983707Z","caller":"traceutil/trace.go:171","msg":"trace[1656594317] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"161.712138ms","start":"2026-10-17T09:58:40.821944Z","end":"2026-10-17T09:58:40.983656Z","steps":["trace[1656594317] 'process raft request' (duration: 161.528905ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.983844Z","caller":"traceutil/trace.go:171","msg":"trace[1030662394] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"161.143269ms","start":"2026-10-17T09:58:40.822674Z","end":"2026-10-17T09:58:40.983817Z","steps":["trace[1030662394] 'process raft request' (duration: 160.891795ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.983912Z","caller":"traceutil/trace.go:171","msg":"trace[1957051012] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"156.640476ms","start":"2026-10-17T09:58:40.827263Z","end":"2026-10-17T09:58:40.983903Z","steps":["trace[1957051012] 'process raft request' (duration: 156.372292ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.984017Z","caller":"traceutil/trace.go:171","msg":"trace[823838600] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"154.879148ms","start":"2026-10-17T09:58:40.829113Z","end":"2026-10-17T09:58:40.983992Z","steps":["trace[823838600] 'process raft request' (duration: 154.743655ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.984078Z","caller":"traceutil/trace.go:171","msg":"trace[1531485437] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"153.826321ms","start":"2026-10-17T09:58:40.830241Z","end":"2026-10-17T09:58:40.984068Z","steps":["trace[1531485437] 'process raft request' (duration: 153.722889ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.98474Z","caller":"traceutil/trace.go:171","msg":"trace[2112049030] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:582; }","duration":"129.078642ms","start":"2026-10-17T09:58:40.855559Z","end":"2026-10-17T09:58:40.984638Z","steps":["trace[2112049030] 'read index received' (duration: 127.893153ms)","trace[2112049030] 'applied index is now lower than readState.Index' (duration: 1.184599ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T09:58:40.984067Z","caller":"traceutil/trace.go:171","msg":"trace[655597706] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"153.921882ms","start":"2026-10-17T09:58:40.830124Z","end":"2026-10-17T09:58:40.984046Z","steps":["trace[655597706] 'process raft request' (duration: 153.77033ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.985038Z","caller":"traceutil/trace.go:171","msg":"trace[402497267] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"146.689126ms","start":"2026-10-17T09:58:40.838337Z","end":"2026-10-17T09:58:40.985026Z","steps":["trace[402497267] 'process raft request' (duration: 145.936024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:58:40.985043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.464928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-10-17T09:58:40.985185Z","caller":"traceutil/trace.go:171","msg":"trace[2103883498] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:568; }","duration":"129.662011ms","start":"2026-10-17T09:58:40.855507Z","end":"2026-10-17T09:58:40.985169Z","steps":["trace[2103883498] 'agreement among raft nodes before linearized reading' (duration: 129.364846ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.985194Z","caller":"traceutil/trace.go:171","msg":"trace[1722495640] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"152.986437ms","start":"2026-10-17T09:58:40.8322Z","end":"2026-10-17T09:58:40.985187Z","steps":["trace[1722495640] 'process raft request' (duration: 151.9429ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:40.989547Z","caller":"traceutil/trace.go:171","msg":"trace[1885701396] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"139.962667ms","start":"2026-10-17T09:58:40.845115Z","end":"2026-10-17T09:58:40.985078Z","steps":["trace[1885701396] 'process raft request' (duration: 139.383748ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:41.185623Z","caller":"traceutil/trace.go:171","msg":"trace[147624759] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"158.067154ms","start":"2026-10-17T09:58:41.027529Z","end":"2026-10-17T09:58:41.185596Z","steps":["trace[147624759] 'process raft request' (duration: 140.122516ms)","trace[147624759] 'compare' (duration: 17.824436ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T09:58:41.1866Z","caller":"traceutil/trace.go:171","msg":"trace[1422043059] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"123.668352ms","start":"2026-10-17T09:58:41.062914Z","end":"2026-10-17T09:58:41.186582Z","steps":["trace[1422043059] 'process raft request' (duration: 123.356787ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:41.18662Z","caller":"traceutil/trace.go:171","msg":"trace[325646444] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"153.641293ms","start":"2026-10-17T09:58:41.032925Z","end":"2026-10-17T09:58:41.186567Z","steps":["trace[325646444] 'process raft request' (duration: 153.274857ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:41.186716Z","caller":"traceutil/trace.go:171","msg":"trace[1475374682] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"157.820509ms","start":"2026-10-17T09:58:41.028885Z","end":"2026-10-17T09:58:41.186706Z","steps":["trace[1475374682] 'process raft request' (duration: 157.20621ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:41.186797Z","caller":"traceutil/trace.go:171","msg":"trace[1934550267] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"118.199085ms","start":"2026-10-17T09:58:41.068585Z","end":"2026-10-17T09:58:41.186784Z","steps":["trace[1934550267] 'process raft request' (duration: 117.829079ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:41.186886Z","caller":"traceutil/trace.go:171","msg":"trace[252636084] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"115.614313ms","start":"2026-10-17T09:58:41.071264Z","end":"2026-10-17T09:58:41.186878Z","steps":["trace[252636084] 'process raft request' (duration: 115.206327ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:47.463187Z","caller":"traceutil/trace.go:171","msg":"trace[1139638866] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"145.908877ms","start":"2026-10-17T09:58:47.317189Z","end":"2026-10-17T09:58:47.463098Z","steps":["trace[1139638866] 'process raft request' (duration: 144.844091ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:58:47.771307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.582619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-17T09:58:47.77141Z","caller":"traceutil/trace.go:171","msg":"trace[572429309] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"235.26575ms","start":"2026-10-17T09:58:47.536128Z","end":"2026-10-17T09:58:47.771394Z","steps":["trace[572429309] 'process raft request' (duration: 84.01071ms)","trace[572429309] 'compare' (duration: 150.445107ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T09:58:48.29599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.014651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-17T09:58:48.296346Z","caller":"traceutil/trace.go:171","msg":"trace[2136268662] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"444.779555ms","start":"2026-10-17T09:58:47.851503Z","end":"2026-10-17T09:58:48.296282Z","steps":["trace[2136268662] 'process raft request' (duration: 50.396889ms)","trace[2136268662] 'compare' (duration: 393.873569ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T09:58:48.296375Z","caller":"traceutil/trace.go:171","msg":"trace[1070555777] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"444.39102ms","start":"2026-10-17T09:58:47.851966Z","end":"2026-10-17T09:58:48.296357Z","steps":["trace[1070555777] 'process raft request' (duration: 444.196357ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:48.296381Z","caller":"traceutil/trace.go:171","msg":"trace[807795696] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"444.170527ms","start":"2026-10-17T09:58:47.852191Z","end":"2026-10-17T09:58:48.296362Z","steps":["trace[807795696] 'process raft request' (duration: 444.089725ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:58:48.296545Z","caller":"traceutil/trace.go:171","msg":"trace[1623445685] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:683; }","duration":"410.80239ms","start":"2026-10-17T09:58:47.885719Z","end":"2026-10-17T09:58:48.296521Z","steps":["trace[1623445685] 'read index received' (duration: 16.119879ms)","trace[1623445685] 'applied index is now lower than readState.Index' (duration: 394.681431ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T09:58:48.296492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T09:58:47.852182Z","time spent":"444.280118ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-17T09:58:48.296656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T09:58:47.851942Z","time spent":"444.475901ms","remote":"127.0.0.1:57940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T09:58:48.296754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.015273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-17T09:58:48.296795Z","caller":"traceutil/trace.go:171","msg":"trace[83742853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:661; }","duration":"411.103995ms","start":"2026-10-17T09:58:47.885682Z","end":"2026-10-17T09:58:48.296786Z","steps":["trace[83742853] 'agreement among raft nodes before linearized reading' (duration: 410.933893ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:58:48.296824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T09:58:47.885667Z","time spent":"411.149446ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-17T09:58:48.296558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T09:58:47.851473Z","time spent":"444.935158ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T09:58:48.296974Z","caller":"traceutil/trace.go:171","msg":"trace[962250764] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"443.031469ms","start":"2026-10-17T09:58:47.853928Z","end":"2026-10-17T09:58:48.29696Z","steps":["trace[962250764] 'process raft request' (duration: 442.389249ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:58:48.297116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T09:58:47.853898Z","time spent":"443.15015ms","remote":"127.0.0.1:57880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T09:58:48.523877Z","caller":"traceutil/trace.go:171","msg":"trace[1409974653] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"290.827774ms","start":"2026-10-17T09:58:48.233027Z","end":"2026-10-17T09:58:48.523854Z","steps":["trace[1409974653] 'process raft request' (duration: 280.011898ms)","trace[1409974653] 'compare' (duration: 10.730565ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T09:58:48.556971Z","caller":"traceutil/trace.go:171","msg":"trace[676148806] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"255.742364ms","start":"2026-10-17T09:58:48.301212Z","end":"2026-10-17T09:58:48.556955Z","steps":["trace[676148806] 'process raft request' (duration: 255.570662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.225046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.411317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.225161Z","caller":"traceutil/trace.go:171","msg":"trace[396576416] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:815; }","duration":"169.591699ms","start":"2026-10-17T09:59:04.055546Z","end":"2026-10-17T09:59:04.225137Z","steps":["trace[396576416] 'count revisions from in-memory index tree' (duration: 169.357245ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.225288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.344806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.225406Z","caller":"traceutil/trace.go:171","msg":"trace[651871349] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:815; }","duration":"169.505558ms","start":"2026-10-17T09:59:04.055872Z","end":"2026-10-17T09:59:04.225377Z","steps":["trace[651871349] 'range keys from in-memory index tree' (duration: 169.226024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.225739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.12667ms","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-10-17T09:59:04.225781Z","caller":"traceutil/trace.go:171","msg":"trace[212301132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"183.206672ms","start":"2026-10-17T09:59:04.042565Z","end":"2026-10-17T09:59:04.225771Z","steps":["trace[212301132] 'range keys from in-memory index tree' (duration: 182.949738ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.225086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.230439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.225953Z","caller":"traceutil/trace.go:171","msg":"trace[344811120] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:815; }","duration":"188.105941ms","start":"2026-10-17T09:59:04.037833Z","end":"2026-10-17T09:59:04.225938Z","steps":["trace[344811120] 'range keys from in-memory index tree' (duration: 187.190338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.226062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.694965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.226169Z","caller":"traceutil/trace.go:171","msg":"trace[269908222] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:815; }","duration":"170.746826ms","start":"2026-10-17T09:59:04.055355Z","end":"2026-10-17T09:59:04.226102Z","steps":["trace[269908222] 'range keys from in-memory index tree' (duration: 170.631734ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.225042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.63636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.226242Z","caller":"traceutil/trace.go:171","msg":"trace[583885413] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:815; }","duration":"187.906699ms","start":"2026-10-17T09:59:04.038319Z","end":"2026-10-17T09:59:04.226225Z","steps":["trace[583885413] 'range keys from in-memory index tree' (duration: 186.57378ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.225126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.352051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.226598Z","caller":"traceutil/trace.go:171","msg":"trace[1634828572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:815; }","duration":"188.830481ms","start":"2026-10-17T09:59:04.037729Z","end":"2026-10-17T09:59:04.22656Z","steps":["trace[1634828572] 'count revisions from in-memory index tree' (duration: 187.207559ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:59:04.369694Z","caller":"traceutil/trace.go:171","msg":"trace[943757922] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"132.142321ms","start":"2026-10-17T09:59:04.237531Z","end":"2026-10-17T09:59:04.369673Z","steps":["trace[943757922] 'read index received' (duration: 131.910337ms)","trace[943757922] 'applied index is now lower than readState.Index' (duration: 230.934µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T09:59:04.37023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.583397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.370292Z","caller":"traceutil/trace.go:171","msg":"trace[1167206137] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"139.250521ms","start":"2026-10-17T09:59:04.231008Z","end":"2026-10-17T09:59:04.370258Z","steps":["trace[1167206137] 'process raft request' (duration: 138.50302ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:59:04.370315Z","caller":"traceutil/trace.go:171","msg":"trace[502814877] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:816; }","duration":"132.693579ms","start":"2026-10-17T09:59:04.237601Z","end":"2026-10-17T09:59:04.370294Z","steps":["trace[502814877] 'agreement among raft nodes before linearized reading' (duration: 132.520096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.371266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.81418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.371411Z","caller":"traceutil/trace.go:171","msg":"trace[206905454] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:816; }","duration":"133.890765ms","start":"2026-10-17T09:59:04.237481Z","end":"2026-10-17T09:59:04.371371Z","steps":["trace[206905454] 'agreement among raft nodes before linearized reading' (duration: 132.8165ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.372132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.049697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-78mx8\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-10-17T09:59:04.372441Z","caller":"traceutil/trace.go:171","msg":"trace[663983725] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-78mx8; range_end:; response_count:1; response_revision:816; }","duration":"134.416603ms","start":"2026-10-17T09:59:04.238009Z","end":"2026-10-17T09:59:04.372426Z","steps":["trace[663983725] 'agreement among raft nodes before linearized reading' (duration: 133.926746ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.372466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.943202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T09:59:04.372608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.9475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.372819Z","caller":"traceutil/trace.go:171","msg":"trace[1633750053] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:816; }","duration":"135.181283ms","start":"2026-10-17T09:59:04.237614Z","end":"2026-10-17T09:59:04.372796Z","steps":["trace[1633750053] 'agreement among raft nodes before linearized reading' (duration: 134.932399ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.372647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.840361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.372911Z","caller":"traceutil/trace.go:171","msg":"trace[1917235589] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:816; }","duration":"114.125795ms","start":"2026-10-17T09:59:04.258768Z","end":"2026-10-17T09:59:04.372894Z","steps":["trace[1917235589] 'agreement among raft nodes before linearized reading' (duration: 113.816721ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T09:59:04.372696Z","caller":"traceutil/trace.go:171","msg":"trace[2099207530] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:816; }","duration":"114.40524ms","start":"2026-10-17T09:59:04.258236Z","end":"2026-10-17T09:59:04.372642Z","steps":["trace[2099207530] 'agreement among raft nodes before linearized reading' (duration: 113.930413ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T09:59:04.373299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.967267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T09:59:04.373349Z","caller":"traceutil/trace.go:171","msg":"trace[392245761] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:816; }","duration":"115.051778ms","start":"2026-10-17T09:59:04.258282Z","end":"2026-10-17T09:59:04.373334Z","steps":["trace[392245761] 'agreement among raft nodes before linearized reading' (duration: 114.956017ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:11.629766Z","caller":"traceutil/trace.go:171","msg":"trace[1711054143] transaction","detail":"{read_only:false; response_revision:1718; number_of_response:1; }","duration":"117.26512ms","start":"2026-10-17T10:00:11.51248Z","end":"2026-10-17T10:00:11.629745Z","steps":["trace[1711054143] 'process raft request' (duration: 107.026304ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:26.720746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.281928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:00:26.720933Z","caller":"traceutil/trace.go:171","msg":"trace[1814681625] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"556.860924ms","start":"2026-10-17T10:00:26.164038Z","end":"2026-10-17T10:00:26.720899Z","steps":["trace[1814681625] 'process raft request' (duration: 396.330983ms)","trace[1814681625] 'compare' (duration: 159.903964ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:00:26.72097Z","caller":"traceutil/trace.go:171","msg":"trace[403012439] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"157.398317ms","start":"2026-10-17T10:00:26.563555Z","end":"2026-10-17T10:00:26.720954Z","steps":["trace[403012439] 'process raft request' (duration: 157.312416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:26.721096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:26.164008Z","time spent":"557.001795ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:00:26.721152Z","caller":"traceutil/trace.go:171","msg":"trace[967965688] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1984; }","duration":"348.131491ms","start":"2026-10-17T10:00:26.373011Z","end":"2026-10-17T10:00:26.721142Z","steps":["trace[967965688] 'read index received' (duration: 187.403737ms)","trace[967965688] 'applied index is now lower than readState.Index' (duration: 160.726794ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:00:26.721372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.365603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:00:26.721399Z","caller":"traceutil/trace.go:171","msg":"trace[1334422304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1911; }","duration":"348.435854ms","start":"2026-10-17T10:00:26.372954Z","end":"2026-10-17T10:00:26.72139Z","steps":["trace[1334422304] 'agreement among raft nodes before linearized reading' (duration: 348.388853ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:26.721422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:26.372935Z","time spent":"348.481005ms","remote":"127.0.0.1:57704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:00:26.721513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.239372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-17T10:00:26.721551Z","caller":"traceutil/trace.go:171","msg":"trace[2060829899] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1911; }","duration":"348.316352ms","start":"2026-10-17T10:00:26.373221Z","end":"2026-10-17T10:00:26.721537Z","steps":["trace[2060829899] 'agreement among raft nodes before linearized reading' (duration: 348.185891ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:26.721582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:26.373197Z","time spent":"348.377844ms","remote":"127.0.0.1:60090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-17T10:00:26.72161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.034312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78a41882-0148-461f-a1c0-775d0235719a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T10:00:26.721702Z","caller":"traceutil/trace.go:171","msg":"trace[313152906] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-78a41882-0148-461f-a1c0-775d0235719a; range_end:; response_count:1; response_revision:1911; }","duration":"204.159593ms","start":"2026-10-17T10:00:26.517516Z","end":"2026-10-17T10:00:26.721676Z","steps":["trace[313152906] 'agreement among raft nodes before linearized reading' (duration: 203.94266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:26.721721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.81914ms","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-10-17T10:00:26.721816Z","caller":"traceutil/trace.go:171","msg":"trace[452485376] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1911; }","duration":"292.966572ms","start":"2026-10-17T10:00:26.428831Z","end":"2026-10-17T10:00:26.721798Z","steps":["trace[452485376] 'agreement among raft nodes before linearized reading' (duration: 292.72767ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:26.983051Z","caller":"traceutil/trace.go:171","msg":"trace[241615245] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"252.723009ms","start":"2026-10-17T10:00:26.730284Z","end":"2026-10-17T10:00:26.983007Z","steps":["trace[241615245] 'process raft request' (duration: 199.677903ms)","trace[241615245] 'compare' (duration: 52.821783ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:00:27.366212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.792444ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:00:27.366369Z","caller":"traceutil/trace.go:171","msg":"trace[1371801398] linearizableReadLoop","detail":"{readStateIndex:1990; appliedIndex:1987; }","duration":"495.330679ms","start":"2026-10-17T10:00:26.871021Z","end":"2026-10-17T10:00:27.366352Z","steps":["trace[1371801398] 'read index received' (duration: 58.9071ms)","trace[1371801398] 'applied index is now lower than readState.Index' (duration: 436.422489ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:00:27.366469Z","caller":"traceutil/trace.go:171","msg":"trace[49991383] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"572.007806ms","start":"2026-10-17T10:00:26.794413Z","end":"2026-10-17T10:00:27.366421Z","steps":["trace[49991383] 'process raft request' (duration: 571.886244ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:27.366461Z","caller":"traceutil/trace.go:171","msg":"trace[1981749799] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"579.811132ms","start":"2026-10-17T10:00:26.786611Z","end":"2026-10-17T10:00:27.366422Z","steps":["trace[1981749799] 'process raft request' (duration: 307.728004ms)","trace[1981749799] 'compare' (duration: 271.603042ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:00:27.366585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.566471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T10:00:27.36662Z","caller":"traceutil/trace.go:171","msg":"trace[1253616256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1915; }","duration":"495.642413ms","start":"2026-10-17T10:00:26.870968Z","end":"2026-10-17T10:00:27.366611Z","steps":["trace[1253616256] 'agreement among raft nodes before linearized reading' (duration: 495.469451ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:27.366622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:26.794399Z","time spent":"572.139487ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:00:27.36665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:26.870937Z","time spent":"495.705493ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-17T10:00:27.36672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:26.786589Z","time spent":"580.017984ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:00:27.366823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.238386ms","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-10-17T10:00:27.366853Z","caller":"traceutil/trace.go:171","msg":"trace[1642355775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"289.320157ms","start":"2026-10-17T10:00:27.077525Z","end":"2026-10-17T10:00:27.366845Z","steps":["trace[1642355775] 'agreement among raft nodes before linearized reading' (duration: 289.243727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:27.366974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.169918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T10:00:27.367Z","caller":"traceutil/trace.go:171","msg":"trace[371397761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1915; }","duration":"262.255009ms","start":"2026-10-17T10:00:27.104739Z","end":"2026-10-17T10:00:27.366994Z","steps":["trace[371397761] 'agreement among raft nodes before linearized reading' (duration: 262.183088ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:27.630249Z","caller":"traceutil/trace.go:171","msg":"trace[1536213939] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1990; }","duration":"257.341755ms","start":"2026-10-17T10:00:27.372883Z","end":"2026-10-17T10:00:27.630225Z","steps":["trace[1536213939] 'read index received' (duration: 186.582715ms)","trace[1536213939] 'applied index is now lower than readState.Index' (duration: 70.75815ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:00:27.630266Z","caller":"traceutil/trace.go:171","msg":"trace[1607007024] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"258.825861ms","start":"2026-10-17T10:00:27.371399Z","end":"2026-10-17T10:00:27.630225Z","steps":["trace[1607007024] 'process raft request' (duration: 187.93015ms)","trace[1607007024] 'compare' (duration: 70.682159ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:00:27.630373Z","caller":"traceutil/trace.go:171","msg":"trace[1272997841] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"258.783881ms","start":"2026-10-17T10:00:27.371578Z","end":"2026-10-17T10:00:27.630362Z","steps":["trace[1272997841] 'process raft request' (duration: 258.559858ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:27.630531Z","caller":"traceutil/trace.go:171","msg":"trace[317094907] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"257.677998ms","start":"2026-10-17T10:00:27.372841Z","end":"2026-10-17T10:00:27.630519Z","steps":["trace[317094907] 'process raft request' (duration: 257.348235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:27.630548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.647308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:00:27.630616Z","caller":"traceutil/trace.go:171","msg":"trace[706115463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1918; }","duration":"257.750189ms","start":"2026-10-17T10:00:27.372848Z","end":"2026-10-17T10:00:27.630599Z","steps":["trace[706115463] 'agreement among raft nodes before linearized reading' (duration: 257.640738ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:39.938452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.781446ms","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-10-17T10:00:39.938462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.084053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:00:39.938526Z","caller":"traceutil/trace.go:171","msg":"trace[2028775035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2014; }","duration":"242.884057ms","start":"2026-10-17T10:00:39.695625Z","end":"2026-10-17T10:00:39.938509Z","steps":["trace[2028775035] 'range keys from in-memory index tree' (duration: 242.649394ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:39.938562Z","caller":"traceutil/trace.go:171","msg":"trace[34020888] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2014; }","duration":"406.249774ms","start":"2026-10-17T10:00:39.532274Z","end":"2026-10-17T10:00:39.938523Z","steps":["trace[34020888] 'count revisions from in-memory index tree' (duration: 405.964612ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:39.938612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:39.532249Z","time spent":"406.351695ms","remote":"127.0.0.1:57762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:00:39.938675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.395673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-17T10:00:39.938692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.159538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T10:00:39.938741Z","caller":"traceutil/trace.go:171","msg":"trace[1556447340] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2014; }","duration":"252.249688ms","start":"2026-10-17T10:00:39.686479Z","end":"2026-10-17T10:00:39.938729Z","steps":["trace[1556447340] 'range keys from in-memory index tree' (duration: 252.049806ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:39.938739Z","caller":"traceutil/trace.go:171","msg":"trace[19846342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2014; }","duration":"257.510705ms","start":"2026-10-17T10:00:39.681211Z","end":"2026-10-17T10:00:39.938721Z","steps":["trace[19846342] 'range keys from in-memory index tree' (duration: 257.247133ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:39.93874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.682584ms","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-10-17T10:00:39.938792Z","caller":"traceutil/trace.go:171","msg":"trace[1918870799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2014; }","duration":"254.736655ms","start":"2026-10-17T10:00:39.684041Z","end":"2026-10-17T10:00:39.938778Z","steps":["trace[1918870799] 'range keys from in-memory index tree' (duration: 254.519303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:57.172339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.561963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:00:57.172436Z","caller":"traceutil/trace.go:171","msg":"trace[1657142415] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"232.896845ms","start":"2026-10-17T10:00:56.939522Z","end":"2026-10-17T10:00:57.172419Z","steps":["trace[1657142415] 'read index received' (duration: 15.07419ms)","trace[1657142415] 'applied index is now lower than readState.Index' (duration: 217.821195ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:00:57.172522Z","caller":"traceutil/trace.go:171","msg":"trace[2145585618] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"256.09266ms","start":"2026-10-17T10:00:56.916419Z","end":"2026-10-17T10:00:57.172511Z","steps":["trace[2145585618] 'process raft request' (duration: 38.237114ms)","trace[2145585618] 'compare' (duration: 217.468382ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:00:57.172805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.355731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-17T10:00:57.172861Z","caller":"traceutil/trace.go:171","msg":"trace[1215236434] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2127; }","duration":"116.450522ms","start":"2026-10-17T10:00:57.056392Z","end":"2026-10-17T10:00:57.172843Z","steps":["trace[1215236434] 'agreement among raft nodes before linearized reading' (duration: 116.160189ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:57.17281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.282309ms","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-10-17T10:00:57.172941Z","caller":"traceutil/trace.go:171","msg":"trace[1081279856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2127; }","duration":"233.45888ms","start":"2026-10-17T10:00:56.939471Z","end":"2026-10-17T10:00:57.17293Z","steps":["trace[1081279856] 'agreement among raft nodes before linearized reading' (duration: 233.261138ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:57.588186Z","caller":"traceutil/trace.go:171","msg":"trace[1250582020] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"205.565015ms","start":"2026-10-17T10:00:57.382591Z","end":"2026-10-17T10:00:57.588156Z","steps":["trace[1250582020] 'process raft request' (duration: 205.422763ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:58.236512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.691793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:00:58.236653Z","caller":"traceutil/trace.go:171","msg":"trace[1935617689] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"768.929682ms","start":"2026-10-17T10:00:57.467692Z","end":"2026-10-17T10:00:58.236622Z","steps":["trace[1935617689] 'process raft request' (duration: 148.013096ms)","trace[1935617689] 'compare' (duration: 620.593482ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:00:58.236924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:00:57.467661Z","time spent":"769.054643ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:00:58.237342Z","caller":"traceutil/trace.go:171","msg":"trace[634727354] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"183.489879ms","start":"2026-10-17T10:00:58.053832Z","end":"2026-10-17T10:00:58.237322Z","steps":["trace[634727354] 'process raft request' (duration: 183.396728ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.237392Z","caller":"traceutil/trace.go:171","msg":"trace[1599451370] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"183.678041ms","start":"2026-10-17T10:00:58.053687Z","end":"2026-10-17T10:00:58.237365Z","steps":["trace[1599451370] 'read index received' (duration: 58.94µs)","trace[1599451370] 'applied index is now lower than readState.Index' (duration: 183.617181ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:00:58.237588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.894283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:00:58.237634Z","caller":"traceutil/trace.go:171","msg":"trace[868903836] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2131; }","duration":"183.980944ms","start":"2026-10-17T10:00:58.05364Z","end":"2026-10-17T10:00:58.237621Z","steps":["trace[868903836] 'agreement among raft nodes before linearized reading' (duration: 183.885903ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:58.237784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.31728ms","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-10-17T10:00:58.237841Z","caller":"traceutil/trace.go:171","msg":"trace[1257866979] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2131; }","duration":"171.417162ms","start":"2026-10-17T10:00:58.066412Z","end":"2026-10-17T10:00:58.23783Z","steps":["trace[1257866979] 'agreement among raft nodes before linearized reading' (duration: 171.203759ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:58.23783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.781657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T10:00:58.237903Z","caller":"traceutil/trace.go:171","msg":"trace[1182938172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2131; }","duration":"140.955749ms","start":"2026-10-17T10:00:58.096931Z","end":"2026-10-17T10:00:58.237886Z","steps":["trace[1182938172] 'agreement among raft nodes before linearized reading' (duration: 140.774707ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:00:58.237839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.835377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T10:00:58.237965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.017312ms","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-10-17T10:00:58.23805Z","caller":"traceutil/trace.go:171","msg":"trace[1533859040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2131; }","duration":"161.142492ms","start":"2026-10-17T10:00:58.076862Z","end":"2026-10-17T10:00:58.238004Z","steps":["trace[1533859040] 'agreement among raft nodes before linearized reading' (duration: 160.857289ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.238011Z","caller":"traceutil/trace.go:171","msg":"trace[402654363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2131; }","duration":"138.028278ms","start":"2026-10-17T10:00:58.099968Z","end":"2026-10-17T10:00:58.237996Z","steps":["trace[402654363] 'agreement among raft nodes before linearized reading' (duration: 137.647144ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.464746Z","caller":"traceutil/trace.go:171","msg":"trace[2000739035] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"221.140906ms","start":"2026-10-17T10:00:58.243582Z","end":"2026-10-17T10:00:58.464723Z","steps":["trace[2000739035] 'process raft request' (duration: 221.022315ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.470268Z","caller":"traceutil/trace.go:171","msg":"trace[906126445] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"226.492513ms","start":"2026-10-17T10:00:58.243734Z","end":"2026-10-17T10:00:58.470227Z","steps":["trace[906126445] 'process raft request' (duration: 226.326052ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.47056Z","caller":"traceutil/trace.go:171","msg":"trace[882847589] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"226.585244ms","start":"2026-10-17T10:00:58.243959Z","end":"2026-10-17T10:00:58.470544Z","steps":["trace[882847589] 'process raft request' (duration: 226.22507ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.470671Z","caller":"traceutil/trace.go:171","msg":"trace[553089110] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"226.535224ms","start":"2026-10-17T10:00:58.244124Z","end":"2026-10-17T10:00:58.47066Z","steps":["trace[553089110] 'process raft request' (duration: 226.315572ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:00:58.471117Z","caller":"traceutil/trace.go:171","msg":"trace[1913584687] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"172.161109ms","start":"2026-10-17T10:00:58.298934Z","end":"2026-10-17T10:00:58.471095Z","steps":["trace[1913584687] 'process raft request' (duration: 171.686564ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:02:13.184462Z","caller":"traceutil/trace.go:171","msg":"trace[495237797] linearizableReadLoop","detail":"{readStateIndex:2735; appliedIndex:2734; }","duration":"350.405873ms","start":"2026-10-17T10:02:12.834035Z","end":"2026-10-17T10:02:13.184441Z","steps":["trace[495237797] 'read index received' (duration: 350.217477ms)","trace[495237797] 'applied index is now lower than readState.Index' (duration: 187.536µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:02:13.184601Z","caller":"traceutil/trace.go:171","msg":"trace[433039383] transaction","detail":"{read_only:false; response_revision:2635; number_of_response:1; }","duration":"352.656727ms","start":"2026-10-17T10:02:12.831915Z","end":"2026-10-17T10:02:13.184572Z","steps":["trace[433039383] 'process raft request' (duration: 352.38724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:02:13.184717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.664971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T10:02:13.184758Z","caller":"traceutil/trace.go:171","msg":"trace[1795900730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2635; }","duration":"350.739612ms","start":"2026-10-17T10:02:12.834007Z","end":"2026-10-17T10:02:13.184746Z","steps":["trace[1795900730] 'agreement among raft nodes before linearized reading' (duration: 350.579728ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:02:13.18476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.259199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-17T10:02:13.184794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:02:12.83398Z","time spent":"350.805895ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-17T10:02:13.184813Z","caller":"traceutil/trace.go:171","msg":"trace[1381235133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2635; }","duration":"350.389213ms","start":"2026-10-17T10:02:12.83441Z","end":"2026-10-17T10:02:13.1848Z","steps":["trace[1381235133] 'agreement among raft nodes before linearized reading' (duration: 350.249779ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:02:13.184844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:02:12.834388Z","time spent":"350.448384ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T10:02:13.18476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:02:12.8319Z","time spent":"352.77182ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:02:13.18494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.859139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T10:02:13.18502Z","caller":"traceutil/trace.go:171","msg":"trace[1775220132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2635; }","duration":"348.974802ms","start":"2026-10-17T10:02:12.836028Z","end":"2026-10-17T10:02:13.185003Z","steps":["trace[1775220132] 'agreement among raft nodes before linearized reading' (duration: 348.759356ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:02:13.185065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:02:12.836016Z","time spent":"349.041144ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-17T10:02:13.185282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.557269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-17T10:02:13.185356Z","caller":"traceutil/trace.go:171","msg":"trace[1784295121] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2635; }","duration":"138.626211ms","start":"2026-10-17T10:02:13.046717Z","end":"2026-10-17T10:02:13.185343Z","steps":["trace[1784295121] 'agreement among raft nodes before linearized reading' (duration: 137.973473ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:02:45.728226Z","caller":"traceutil/trace.go:171","msg":"trace[1795401985] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"187.80662ms","start":"2026-10-17T10:02:45.540393Z","end":"2026-10-17T10:02:45.7282Z","steps":["trace[1795401985] 'process raft request' (duration: 124.976717ms)","trace[1795401985] 'compare' (duration: 62.639588ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:04.854793Z","caller":"traceutil/trace.go:171","msg":"trace[1081067972] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"102.376518ms","start":"2026-10-17T10:07:04.752392Z","end":"2026-10-17T10:07:04.854769Z","steps":["trace[1081067972] 'process raft request' (duration: 102.245146ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:04.856481Z","caller":"traceutil/trace.go:171","msg":"trace[381778100] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"103.885201ms","start":"2026-10-17T10:07:04.752571Z","end":"2026-10-17T10:07:04.856456Z","steps":["trace[381778100] 'process raft request' (duration: 103.698948ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:04.85667Z","caller":"traceutil/trace.go:171","msg":"trace[476421175] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"104.022703ms","start":"2026-10-17T10:07:04.752626Z","end":"2026-10-17T10:07:04.856649Z","steps":["trace[476421175] 'process raft request' (duration: 103.79447ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:09.899354Z","caller":"traceutil/trace.go:171","msg":"trace[381447399] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"293.365448ms","start":"2026-10-17T10:07:09.605948Z","end":"2026-10-17T10:07:09.899314Z","steps":["trace[381447399] 'process raft request' (duration: 256.629062ms)","trace[381447399] 'compare' (duration: 36.294839ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:09.8995Z","caller":"traceutil/trace.go:171","msg":"trace[1164329472] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"250.263239ms","start":"2026-10-17T10:07:09.649221Z","end":"2026-10-17T10:07:09.899484Z","steps":["trace[1164329472] 'process raft request' (duration: 250.077296ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:09.8994Z","caller":"traceutil/trace.go:171","msg":"trace[1482214735] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"255.697429ms","start":"2026-10-17T10:07:09.64368Z","end":"2026-10-17T10:07:09.899378Z","steps":["trace[1482214735] 'process raft request' (duration: 255.553626ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:09.899806Z","caller":"traceutil/trace.go:171","msg":"trace[1531674690] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5165; }","duration":"194.184141ms","start":"2026-10-17T10:07:09.705159Z","end":"2026-10-17T10:07:09.899343Z","steps":["trace[1531674690] 'read index received' (duration: 157.352884ms)","trace[1531674690] 'applied index is now lower than readState.Index' (duration: 36.830197ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:07:09.899877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.655159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7b6db7cbbb-gfx6w\" ","response":"range_response_count:1 size:11257"} {"level":"info","ts":"2026-10-17T10:07:09.899929Z","caller":"traceutil/trace.go:171","msg":"trace[174268834] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7b6db7cbbb-gfx6w; range_end:; response_count:1; response_revision:4972; }","duration":"194.76489ms","start":"2026-10-17T10:07:09.705151Z","end":"2026-10-17T10:07:09.899916Z","steps":["trace[174268834] 'agreement among raft nodes before linearized reading' (duration: 194.515817ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:09.900003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.077038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bb97316-ef64-4ec4-9758-c3a1f3490c0f\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-10-17T10:07:09.900036Z","caller":"traceutil/trace.go:171","msg":"trace[990247776] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bb97316-ef64-4ec4-9758-c3a1f3490c0f; range_end:; response_count:1; response_revision:4972; }","duration":"113.15813ms","start":"2026-10-17T10:07:09.786866Z","end":"2026-10-17T10:07:09.900024Z","steps":["trace[990247776] 'agreement among raft nodes before linearized reading' (duration: 113.051638ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:10.124591Z","caller":"traceutil/trace.go:171","msg":"trace[464652302] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"126.714207ms","start":"2026-10-17T10:07:09.99785Z","end":"2026-10-17T10:07:10.124564Z","steps":["trace[464652302] 'process raft request' (duration: 65.080469ms)","trace[464652302] 'compare' (duration: 61.537266ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:10.159832Z","caller":"traceutil/trace.go:171","msg":"trace[497349700] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"161.771667ms","start":"2026-10-17T10:07:09.998031Z","end":"2026-10-17T10:07:10.159803Z","steps":["trace[497349700] 'process raft request' (duration: 161.529294ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:10.534733Z","caller":"traceutil/trace.go:171","msg":"trace[1337884381] linearizableReadLoop","detail":"{readStateIndex:5172; appliedIndex:5171; }","duration":"162.745302ms","start":"2026-10-17T10:07:10.371968Z","end":"2026-10-17T10:07:10.534713Z","steps":["trace[1337884381] 'read index received' (duration: 162.581069ms)","trace[1337884381] 'applied index is now lower than readState.Index' (duration: 163.753µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:10.534931Z","caller":"traceutil/trace.go:171","msg":"trace[911286544] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"200.550552ms","start":"2026-10-17T10:07:10.334373Z","end":"2026-10-17T10:07:10.534923Z","steps":["trace[911286544] 'process raft request' (duration: 200.220737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:10.535067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.097726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:07:10.535084Z","caller":"traceutil/trace.go:171","msg":"trace[1630295145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4976; }","duration":"163.166517ms","start":"2026-10-17T10:07:10.371912Z","end":"2026-10-17T10:07:10.535079Z","steps":["trace[1630295145] 'agreement among raft nodes before linearized reading' (duration: 163.121976ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:24.508067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.27318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:07:24.508151Z","caller":"traceutil/trace.go:171","msg":"trace[103514931] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5161; }","duration":"135.414581ms","start":"2026-10-17T10:07:24.372718Z","end":"2026-10-17T10:07:24.508133Z","steps":["trace[103514931] 'range keys from in-memory index tree' (duration: 135.186729ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:24.959515Z","caller":"traceutil/trace.go:171","msg":"trace[1602620377] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"142.085698ms","start":"2026-10-17T10:07:24.817375Z","end":"2026-10-17T10:07:24.95946Z","steps":["trace[1602620377] 'read index received' (duration: 98.056033ms)","trace[1602620377] 'applied index is now lower than readState.Index' (duration: 44.028255ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:07:24.959572Z","caller":"traceutil/trace.go:171","msg":"trace[2133536285] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"148.733924ms","start":"2026-10-17T10:07:24.810787Z","end":"2026-10-17T10:07:24.959521Z","steps":["trace[2133536285] 'process raft request' (duration: 104.71612ms)","trace[2133536285] 'compare' (duration: 43.783491ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:07:24.959795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.384922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-10-17T10:07:24.959873Z","caller":"traceutil/trace.go:171","msg":"trace[1095828175] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5164; }","duration":"142.526035ms","start":"2026-10-17T10:07:24.817326Z","end":"2026-10-17T10:07:24.959852Z","steps":["trace[1095828175] 'agreement among raft nodes before linearized reading' (duration: 142.305422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:07:24.959883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.503728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-17T10:07:24.959941Z","caller":"traceutil/trace.go:171","msg":"trace[415345723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5164; }","duration":"102.616919ms","start":"2026-10-17T10:07:24.857307Z","end":"2026-10-17T10:07:24.959924Z","steps":["trace[415345723] 'agreement among raft nodes before linearized reading' (duration: 102.348435ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:07:55.656719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-10-17T10:07:55.765192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"107.136083ms","hash":1808796580,"current-db-size-bytes":53538816,"current-db-size":"54 MB","current-db-size-in-use-bytes":28475392,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T10:07:55.765258Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1808796580,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-10-17T10:08:02.729485Z","caller":"traceutil/trace.go:171","msg":"trace[165041238] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"105.044398ms","start":"2026-10-17T10:08:02.624389Z","end":"2026-10-17T10:08:02.729434Z","steps":["trace[165041238] 'process raft request' (duration: 104.839625ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:12:55.664024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5453} {"level":"info","ts":"2026-10-17T10:12:55.745667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5453,"took":"80.116822ms","hash":2696946540,"current-db-size-bytes":53538816,"current-db-size":"54 MB","current-db-size-in-use-bytes":18714624,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-17T10:12:55.745736Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2696946540,"revision":5453,"compact-revision":2868}