{"level":"warn","ts":"2026-08-24T15:15:48.076088Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:15:48.076205Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.171: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.171:2380","--initial-cluster=instance=https://199.19.213.171:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.171:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.171: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-08-24T15:15:48.076283Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:15:48.076296Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.171:2380"]} {"level":"info","ts":"2026-08-24T15:15:48.076317Z","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-08-24T15:15:48.077169Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"]} {"level":"info","ts":"2026-08-24T15:15:48.077258Z","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.171:2380"],"listen-peer-urls":["https://199.19.213.171:2380"],"advertise-client-urls":["https://199.19.213.171:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.171: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-08-24T15:15:48.081111Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.564568ms"} {"level":"info","ts":"2026-08-24T15:15:48.087285Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"837e89131cc6bd81","cluster-id":"8af92e75ab8f3e69"} {"level":"info","ts":"2026-08-24T15:15:48.087362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:15:48.087385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became follower at term 0"} {"level":"info","ts":"2026-08-24T15:15:48.0874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 837e89131cc6bd81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:15:48.087415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became follower at term 1"} {"level":"info","ts":"2026-08-24T15:15:48.087471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=(9475161381214272897)"} {"level":"warn","ts":"2026-08-24T15:15:48.093649Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:15:48.094829Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:15:48.095853Z","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-08-24T15:15:48.098042Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"837e89131cc6bd81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:15:48.098482Z","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-08-24T15:15:48.098539Z","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-08-24T15:15:48.098549Z","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-08-24T15:15:48.098462Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"837e89131cc6bd81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:15:48.099093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 switched to configuration voters=(9475161381214272897)"} {"level":"info","ts":"2026-08-24T15:15:48.100145Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8af92e75ab8f3e69","local-member-id":"837e89131cc6bd81","added-peer-id":"837e89131cc6bd81","added-peer-peer-urls":["https://199.19.213.171:2380"]} {"level":"info","ts":"2026-08-24T15:15:48.102324Z","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-08-24T15:15:48.102429Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.171:2380"} {"level":"info","ts":"2026-08-24T15:15:48.102455Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.171:2380"} {"level":"info","ts":"2026-08-24T15:15:48.102637Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"837e89131cc6bd81","initial-advertise-peer-urls":["https://199.19.213.171:2380"],"listen-peer-urls":["https://199.19.213.171:2380"],"advertise-client-urls":["https://199.19.213.171:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.171:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:15:48.102725Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:15:48.387937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:15:48.388032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:15:48.388084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 received MsgPreVoteResp from 837e89131cc6bd81 at term 1"} {"level":"info","ts":"2026-08-24T15:15:48.388107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:15:48.388117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 received MsgVoteResp from 837e89131cc6bd81 at term 2"} {"level":"info","ts":"2026-08-24T15:15:48.388132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"837e89131cc6bd81 became leader at term 2"} {"level":"info","ts":"2026-08-24T15:15:48.388147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 837e89131cc6bd81 elected leader 837e89131cc6bd81 at term 2"} {"level":"info","ts":"2026-08-24T15:15:48.388982Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:48.389836Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:15:48.389842Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"837e89131cc6bd81","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.171:2379]}","request-path":"/0/members/837e89131cc6bd81/attributes","cluster-id":"8af92e75ab8f3e69","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:15:48.389916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:15:48.390252Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:15:48.390318Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:15:48.393177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T15:15:48.393611Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.171:2379"} {"level":"info","ts":"2026-08-24T15:15:48.394429Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8af92e75ab8f3e69","local-member-id":"837e89131cc6bd81","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:48.394558Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:48.394597Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:50.144402Z","caller":"traceutil/trace.go:171","msg":"trace[795304156] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"118.572132ms","start":"2026-08-24T15:15:50.025799Z","end":"2026-08-24T15:15:50.144371Z","steps":["trace[795304156] 'process raft request' (duration: 118.465693ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.14439Z","caller":"traceutil/trace.go:171","msg":"trace[1895047724] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"118.699272ms","start":"2026-08-24T15:15:50.025644Z","end":"2026-08-24T15:15:50.144344Z","steps":["trace[1895047724] 'process raft request' (duration: 118.538674ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.144567Z","caller":"traceutil/trace.go:171","msg":"trace[1915865545] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"118.274306ms","start":"2026-08-24T15:15:50.026141Z","end":"2026-08-24T15:15:50.144415Z","steps":["trace[1915865545] 'process raft request' (duration: 118.186767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.144749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.94152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-24T15:15:50.144839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.527993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.144879Z","caller":"traceutil/trace.go:171","msg":"trace[72539775] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"117.722681ms","start":"2026-08-24T15:15:50.027143Z","end":"2026-08-24T15:15:50.144865Z","steps":["trace[72539775] 'process raft request' (duration: 117.244216ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.144927Z","caller":"traceutil/trace.go:171","msg":"trace[66887697] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"121.669442ms","start":"2026-08-24T15:15:50.023235Z","end":"2026-08-24T15:15:50.144905Z","steps":["trace[66887697] 'agreement among raft nodes before linearized reading' (duration: 121.513383ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.144972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.322916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.145027Z","caller":"traceutil/trace.go:171","msg":"trace[73497175] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"125.412816ms","start":"2026-08-24T15:15:50.0196Z","end":"2026-08-24T15:15:50.145012Z","steps":["trace[73497175] 'agreement among raft nodes before linearized reading' (duration: 125.301327ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.145076Z","caller":"traceutil/trace.go:171","msg":"trace[1553865746] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"118.481903ms","start":"2026-08-24T15:15:50.026518Z","end":"2026-08-24T15:15:50.145Z","steps":["trace[1553865746] 'process raft request' (duration: 117.837249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.145125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.845852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.145158Z","caller":"traceutil/trace.go:171","msg":"trace[758777131] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"125.91374ms","start":"2026-08-24T15:15:50.019234Z","end":"2026-08-24T15:15:50.145148Z","steps":["trace[758777131] 'agreement among raft nodes before linearized reading' (duration: 125.861651ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.145223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.511295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.145262Z","caller":"traceutil/trace.go:171","msg":"trace[1959229726] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"125.566774ms","start":"2026-08-24T15:15:50.019685Z","end":"2026-08-24T15:15:50.145252Z","steps":["trace[1959229726] 'agreement among raft nodes before linearized reading' (duration: 125.511015ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.144885Z","caller":"traceutil/trace.go:171","msg":"trace[650020760] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"120.104588ms","start":"2026-08-24T15:15:50.024754Z","end":"2026-08-24T15:15:50.144859Z","steps":["trace[650020760] 'agreement among raft nodes before linearized reading' (duration: 119.814361ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.145584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.618633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.171\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.145632Z","caller":"traceutil/trace.go:171","msg":"trace[107663698] range","detail":"{range_begin:/registry/masterleases/199.19.213.171; range_end:; response_count:0; response_revision:11; }","duration":"122.707382ms","start":"2026-08-24T15:15:50.022912Z","end":"2026-08-24T15:15:50.14562Z","steps":["trace[107663698] 'agreement among raft nodes before linearized reading' (duration: 122.035489ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.200523Z","caller":"traceutil/trace.go:171","msg":"trace[1912038325] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"142.118311ms","start":"2026-08-24T15:15:50.058364Z","end":"2026-08-24T15:15:50.200482Z","steps":["trace[1912038325] 'process raft request' (duration: 97.48165ms)","trace[1912038325] 'compare' (duration: 44.392773ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:50.200717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.567104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.200794Z","caller":"traceutil/trace.go:171","msg":"trace[567972820] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:14; }","duration":"125.702623ms","start":"2026-08-24T15:15:50.075074Z","end":"2026-08-24T15:15:50.200777Z","steps":["trace[567972820] 'agreement among raft nodes before linearized reading' (duration: 125.463015ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.201265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.903251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:50.201334Z","caller":"traceutil/trace.go:171","msg":"trace[1945431657] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:15; }","duration":"131.99706ms","start":"2026-08-24T15:15:50.069316Z","end":"2026-08-24T15:15:50.201313Z","steps":["trace[1945431657] 'agreement among raft nodes before linearized reading' (duration: 131.265428ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:50.588273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.298332ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-08-24T15:15:50.588559Z","caller":"traceutil/trace.go:171","msg":"trace[93928675] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"167.674109ms","start":"2026-08-24T15:15:50.420868Z","end":"2026-08-24T15:15:50.588542Z","steps":["trace[93928675] 'process raft request' (duration: 167.58632ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:50.588751Z","caller":"traceutil/trace.go:171","msg":"trace[1318206200] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"172.703059ms","start":"2026-08-24T15:15:50.415886Z","end":"2026-08-24T15:15:50.588589Z","steps":["trace[1318206200] 'process raft request' (duration: 12.511626ms)","trace[1318206200] 'compare' (duration: 159.178114ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:51.423765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655371691831654315,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:15:51.515815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.470289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-24T15:15:51.51594Z","caller":"traceutil/trace.go:171","msg":"trace[331274853] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"860.019155ms","start":"2026-08-24T15:15:50.655897Z","end":"2026-08-24T15:15:51.515916Z","steps":["trace[331274853] 'process raft request' (duration: 68.322798ms)","trace[331274853] 'compare' (duration: 791.286841ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:51.516023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:50.65587Z","time spent":"860.111763ms","remote":"127.0.0.1:34000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:51.77412Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.049845078s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-24T15:15:52.336526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.067189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-08-24T15:15:52.336668Z","caller":"traceutil/trace.go:171","msg":"trace[436461267] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"1.650834175s","start":"2026-08-24T15:15:50.685798Z","end":"2026-08-24T15:15:52.336632Z","steps":["trace[436461267] 'process raft request' (duration: 1.088571178s)","trace[436461267] 'compare' (duration: 561.86445ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:52.33678Z","caller":"traceutil/trace.go:171","msg":"trace[1487835201] linearizableReadLoop","detail":"{readStateIndex:57; appliedIndex:56; }","duration":"1.414001777s","start":"2026-08-24T15:15:50.922758Z","end":"2026-08-24T15:15:52.33676Z","steps":["trace[1487835201] 'read index received' (duration: 851.575941ms)","trace[1487835201] 'applied index is now lower than readState.Index' (duration: 562.423306ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:52.336856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:50.685778Z","time spent":"1.650985873s","remote":"127.0.0.1:34000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1199,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:15:52.336706Z","caller":"traceutil/trace.go:171","msg":"trace[484562232] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"817.111607ms","start":"2026-08-24T15:15:51.519577Z","end":"2026-08-24T15:15:52.336689Z","steps":["trace[484562232] 'process raft request' (duration: 817.054418ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:52.337041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.413902998s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:52.33708Z","caller":"traceutil/trace.go:171","msg":"trace[577340154] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:54; }","duration":"1.413990368s","start":"2026-08-24T15:15:50.923079Z","end":"2026-08-24T15:15:52.33707Z","steps":["trace[577340154] 'agreement among raft nodes before linearized reading' (duration: 1.413940659s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:52.337123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:50.923047Z","time spent":"1.414067748s","remote":"127.0.0.1:33888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-08-24T15:15:52.337235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:51.519554Z","time spent":"817.473545ms","remote":"127.0.0.1:34000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T15:15:52.337298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38022602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-24T15:15:52.33699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.414323114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:52.337344Z","caller":"traceutil/trace.go:171","msg":"trace[301663481] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:54; }","duration":"1.38033076s","start":"2026-08-24T15:15:50.957001Z","end":"2026-08-24T15:15:52.337332Z","steps":["trace[301663481] 'agreement among raft nodes before linearized reading' (duration: 1.3802689s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:52.337247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331856016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-24T15:15:52.33738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:50.956984Z","time spent":"1.38038794s","remote":"127.0.0.1:33686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-08-24T15:15:52.337368Z","caller":"traceutil/trace.go:171","msg":"trace[752988641] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:54; }","duration":"1.41486001s","start":"2026-08-24T15:15:50.922488Z","end":"2026-08-24T15:15:52.337348Z","steps":["trace[752988641] 'agreement among raft nodes before linearized reading' (duration: 1.414387994s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:52.337389Z","caller":"traceutil/trace.go:171","msg":"trace[1506251344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:54; }","duration":"1.332025864s","start":"2026-08-24T15:15:51.005355Z","end":"2026-08-24T15:15:52.337381Z","steps":["trace[1506251344] 'agreement among raft nodes before linearized reading' (duration: 1.331844806s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:52.337423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:51.005341Z","time spent":"1.332073164s","remote":"127.0.0.1:33546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:15:52.337424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:50.922465Z","time spent":"1.414945389s","remote":"127.0.0.1:33906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-08-24T15:15:52.511636Z","caller":"traceutil/trace.go:171","msg":"trace[1996165895] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"118.955764ms","start":"2026-08-24T15:15:52.39266Z","end":"2026-08-24T15:15:52.511616Z","steps":["trace[1996165895] 'process raft request' (duration: 47.016064ms)","trace[1996165895] 'compare' (duration: 71.800251ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:52.512046Z","caller":"traceutil/trace.go:171","msg":"trace[1874123736] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"119.043212ms","start":"2026-08-24T15:15:52.392994Z","end":"2026-08-24T15:15:52.512038Z","steps":["trace[1874123736] 'process raft request' (duration: 118.576166ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:52.512211Z","caller":"traceutil/trace.go:171","msg":"trace[31464658] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"112.441117ms","start":"2026-08-24T15:15:52.399741Z","end":"2026-08-24T15:15:52.512182Z","steps":["trace[31464658] 'process raft request' (duration: 112.394817ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:52.51223Z","caller":"traceutil/trace.go:171","msg":"trace[424716893] linearizableReadLoop","detail":"{readStateIndex:66; appliedIndex:63; }","duration":"118.863764ms","start":"2026-08-24T15:15:52.393348Z","end":"2026-08-24T15:15:52.512212Z","steps":["trace[424716893] 'read index received' (duration: 4.075696ms)","trace[424716893] 'applied index is now lower than readState.Index' (duration: 114.785958ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:52.512425Z","caller":"traceutil/trace.go:171","msg":"trace[557115493] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"118.853604ms","start":"2026-08-24T15:15:52.393539Z","end":"2026-08-24T15:15:52.512393Z","steps":["trace[557115493] 'process raft request' (duration: 118.291839ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:52.512489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.130632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:52.512778Z","caller":"traceutil/trace.go:171","msg":"trace[1492884296] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:64; }","duration":"119.450349ms","start":"2026-08-24T15:15:52.393311Z","end":"2026-08-24T15:15:52.512761Z","steps":["trace[1492884296] 'agreement among raft nodes before linearized reading' (duration: 119.054362ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:52.905739Z","caller":"traceutil/trace.go:171","msg":"trace[1203598367] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"106.640604ms","start":"2026-08-24T15:15:52.799071Z","end":"2026-08-24T15:15:52.905712Z","steps":["trace[1203598367] 'read index received' (duration: 13.856425ms)","trace[1203598367] 'applied index is now lower than readState.Index' (duration: 92.783289ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:15:52.906006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.874102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-24T15:15:52.906086Z","caller":"traceutil/trace.go:171","msg":"trace[757931690] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:74; }","duration":"107.04476ms","start":"2026-08-24T15:15:52.799026Z","end":"2026-08-24T15:15:52.906071Z","steps":["trace[757931690] 'agreement among raft nodes before linearized reading' (duration: 106.877602ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:52.906295Z","caller":"traceutil/trace.go:171","msg":"trace[1727157068] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"174.842255ms","start":"2026-08-24T15:15:52.73136Z","end":"2026-08-24T15:15:52.906202Z","steps":["trace[1727157068] 'process raft request' (duration: 81.61458ms)","trace[1727157068] 'compare' (duration: 92.593811ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:53.111247Z","caller":"traceutil/trace.go:171","msg":"trace[1979411876] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"117.931277ms","start":"2026-08-24T15:15:52.993289Z","end":"2026-08-24T15:15:53.111221Z","steps":["trace[1979411876] 'process raft request' (duration: 58.337269ms)","trace[1979411876] 'compare' (duration: 59.433229ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:59.329161Z","caller":"traceutil/trace.go:171","msg":"trace[462753433] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"104.62463ms","start":"2026-08-24T15:15:59.224519Z","end":"2026-08-24T15:15:59.329144Z","steps":["trace[462753433] 'process raft request' (duration: 43.944574ms)","trace[462753433] 'compare' (duration: 60.571466ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:59.486916Z","caller":"traceutil/trace.go:171","msg":"trace[475892878] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"149.49249ms","start":"2026-08-24T15:15:59.337391Z","end":"2026-08-24T15:15:59.486883Z","steps":["trace[475892878] 'process raft request' (duration: 149.183391ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.487147Z","caller":"traceutil/trace.go:171","msg":"trace[884028995] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:363; }","duration":"131.88736ms","start":"2026-08-24T15:15:59.355169Z","end":"2026-08-24T15:15:59.487057Z","steps":["trace[884028995] 'read index received' (duration: 8.715665ms)","trace[884028995] 'applied index is now lower than readState.Index' (duration: 123.169025ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:59.487264Z","caller":"traceutil/trace.go:171","msg":"trace[1150888468] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"148.176474ms","start":"2026-08-24T15:15:59.339036Z","end":"2026-08-24T15:15:59.487212Z","steps":["trace[1150888468] 'process raft request' (duration: 147.788155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:59.487419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.191599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-08-24T15:15:59.487563Z","caller":"traceutil/trace.go:171","msg":"trace[1151240628] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:352; }","duration":"132.391879ms","start":"2026-08-24T15:15:59.355117Z","end":"2026-08-24T15:15:59.487508Z","steps":["trace[1151240628] 'agreement among raft nodes before linearized reading' (duration: 132.1429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:28.700035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.640445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:16:28.700257Z","caller":"traceutil/trace.go:171","msg":"trace[1825281029] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"211.752395ms","start":"2026-08-24T15:16:28.48846Z","end":"2026-08-24T15:16:28.700212Z","steps":["trace[1825281029] 'process raft request' (duration: 106.849046ms)","trace[1825281029] 'compare' (duration: 104.468653ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:28.700293Z","caller":"traceutil/trace.go:171","msg":"trace[1754740299] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"207.845192ms","start":"2026-08-24T15:16:28.492431Z","end":"2026-08-24T15:16:28.700276Z","steps":["trace[1754740299] 'process raft request' (duration: 207.784801ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:28.70055Z","caller":"traceutil/trace.go:171","msg":"trace[345909658] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"211.707455ms","start":"2026-08-24T15:16:28.488731Z","end":"2026-08-24T15:16:28.700439Z","steps":["trace[345909658] 'process raft request' (duration: 211.412691ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:28.709698Z","caller":"traceutil/trace.go:171","msg":"trace[75105071] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:534; }","duration":"179.619489ms","start":"2026-08-24T15:16:28.530056Z","end":"2026-08-24T15:16:28.709676Z","steps":["trace[75105071] 'read index received' (duration: 65.265978ms)","trace[75105071] 'applied index is now lower than readState.Index' (duration: 114.352481ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:28.709704Z","caller":"traceutil/trace.go:171","msg":"trace[1802839729] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"185.099845ms","start":"2026-08-24T15:16:28.52457Z","end":"2026-08-24T15:16:28.70967Z","steps":["trace[1802839729] 'process raft request' (duration: 184.895542ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:28.70981Z","caller":"traceutil/trace.go:171","msg":"trace[1918357940] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"179.985435ms","start":"2026-08-24T15:16:28.529816Z","end":"2026-08-24T15:16:28.709801Z","steps":["trace[1918357940] 'process raft request' (duration: 179.827723ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:28.710005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.932753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-08-24T15:16:28.710034Z","caller":"traceutil/trace.go:171","msg":"trace[978744853] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:520; }","duration":"179.990154ms","start":"2026-08-24T15:16:28.530035Z","end":"2026-08-24T15:16:28.710026Z","steps":["trace[978744853] 'agreement among raft nodes before linearized reading' (duration: 179.888182ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:28.71031Z","caller":"traceutil/trace.go:171","msg":"trace[430454353] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"183.23243ms","start":"2026-08-24T15:16:28.527014Z","end":"2026-08-24T15:16:28.710246Z","steps":["trace[430454353] 'process raft request' (duration: 182.581261ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:28.731058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.477233ms","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-08-24T15:16:28.731128Z","caller":"traceutil/trace.go:171","msg":"trace[661841022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"191.593355ms","start":"2026-08-24T15:16:28.539518Z","end":"2026-08-24T15:16:28.731111Z","steps":["trace[661841022] 'agreement among raft nodes before linearized reading' (duration: 191.436803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:28.731479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.834964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-08-24T15:16:28.731655Z","caller":"traceutil/trace.go:171","msg":"trace[691887318] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:521; }","duration":"145.044708ms","start":"2026-08-24T15:16:28.586587Z","end":"2026-08-24T15:16:28.731632Z","steps":["trace[691887318] 'agreement among raft nodes before linearized reading' (duration: 144.461389ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.341362Z","caller":"traceutil/trace.go:171","msg":"trace[982345068] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"115.829205ms","start":"2026-08-24T15:16:30.225492Z","end":"2026-08-24T15:16:30.341321Z","steps":["trace[982345068] 'process raft request' (duration: 115.49636ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.341564Z","caller":"traceutil/trace.go:171","msg":"trace[173977384] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"102.01385ms","start":"2026-08-24T15:16:30.239526Z","end":"2026-08-24T15:16:30.34154Z","steps":["trace[173977384] 'process raft request' (duration: 101.930289ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.341773Z","caller":"traceutil/trace.go:171","msg":"trace[1738279933] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"114.136799ms","start":"2026-08-24T15:16:30.227614Z","end":"2026-08-24T15:16:30.341751Z","steps":["trace[1738279933] 'process raft request' (duration: 113.547261ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.341812Z","caller":"traceutil/trace.go:171","msg":"trace[1260233632] transaction","detail":"{read_only:false; number_of_response:1; response_revision:544; }","duration":"114.14385ms","start":"2026-08-24T15:16:30.227654Z","end":"2026-08-24T15:16:30.341798Z","steps":["trace[1260233632] 'process raft request' (duration: 113.720904ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.403827Z","caller":"traceutil/trace.go:171","msg":"trace[1155212051] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"114.212781ms","start":"2026-08-24T15:16:30.289568Z","end":"2026-08-24T15:16:30.403781Z","steps":["trace[1155212051] 'process raft request' (duration: 113.950247ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404208Z","caller":"traceutil/trace.go:171","msg":"trace[437210386] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"113.252158ms","start":"2026-08-24T15:16:30.290928Z","end":"2026-08-24T15:16:30.404181Z","steps":["trace[437210386] 'process raft request' (duration: 112.706709ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404203Z","caller":"traceutil/trace.go:171","msg":"trace[766044071] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"108.481217ms","start":"2026-08-24T15:16:30.295692Z","end":"2026-08-24T15:16:30.404173Z","steps":["trace[766044071] 'process raft request' (duration: 108.006979ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404377Z","caller":"traceutil/trace.go:171","msg":"trace[942575341] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"111.956868ms","start":"2026-08-24T15:16:30.292365Z","end":"2026-08-24T15:16:30.404322Z","steps":["trace[942575341] 'process raft request' (duration: 111.306037ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404454Z","caller":"traceutil/trace.go:171","msg":"trace[549585628] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"100.645891ms","start":"2026-08-24T15:16:30.303685Z","end":"2026-08-24T15:16:30.404331Z","steps":["trace[549585628] 'process raft request' (duration: 100.530039ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404553Z","caller":"traceutil/trace.go:171","msg":"trace[2008571262] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"104.881634ms","start":"2026-08-24T15:16:30.299657Z","end":"2026-08-24T15:16:30.404538Z","steps":["trace[2008571262] 'process raft request' (duration: 104.198313ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404658Z","caller":"traceutil/trace.go:171","msg":"trace[290955162] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"104.527569ms","start":"2026-08-24T15:16:30.300109Z","end":"2026-08-24T15:16:30.404637Z","steps":["trace[290955162] 'process raft request' (duration: 104.029262ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:30.404725Z","caller":"traceutil/trace.go:171","msg":"trace[2146605427] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"108.815082ms","start":"2026-08-24T15:16:30.29589Z","end":"2026-08-24T15:16:30.404705Z","steps":["trace[2146605427] 'process raft request' (duration: 107.894158ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:31.411143Z","caller":"traceutil/trace.go:171","msg":"trace[907320635] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"119.064185ms","start":"2026-08-24T15:16:31.292059Z","end":"2026-08-24T15:16:31.411124Z","steps":["trace[907320635] 'process raft request' (duration: 117.861137ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:34.653806Z","caller":"traceutil/trace.go:171","msg":"trace[97942699] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"119.634277ms","start":"2026-08-24T15:16:34.534125Z","end":"2026-08-24T15:16:34.653759Z","steps":["trace[97942699] 'process raft request' (duration: 41.594478ms)","trace[97942699] 'compare' (duration: 77.828105ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:35.866167Z","caller":"traceutil/trace.go:171","msg":"trace[754587433] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"247.550802ms","start":"2026-08-24T15:16:35.61859Z","end":"2026-08-24T15:16:35.866141Z","steps":["trace[754587433] 'process raft request' (duration: 246.922412ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:39.012505Z","caller":"traceutil/trace.go:171","msg":"trace[304987887] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"100.551656ms","start":"2026-08-24T15:16:38.911927Z","end":"2026-08-24T15:16:39.012479Z","steps":["trace[304987887] 'process raft request' (duration: 100.384573ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:39.189612Z","caller":"traceutil/trace.go:171","msg":"trace[911536184] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"148.269777ms","start":"2026-08-24T15:16:39.041316Z","end":"2026-08-24T15:16:39.189586Z","steps":["trace[911536184] 'read index received' (duration: 148.024102ms)","trace[911536184] 'applied index is now lower than readState.Index' (duration: 244.385µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:39.189707Z","caller":"traceutil/trace.go:171","msg":"trace[1722412449] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"154.859639ms","start":"2026-08-24T15:16:39.034832Z","end":"2026-08-24T15:16:39.189692Z","steps":["trace[1722412449] 'process raft request' (duration: 154.541804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:39.189846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.511851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-24T15:16:39.189919Z","caller":"traceutil/trace.go:171","msg":"trace[674441921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"148.622193ms","start":"2026-08-24T15:16:39.041276Z","end":"2026-08-24T15:16:39.189898Z","steps":["trace[674441921] 'agreement among raft nodes before linearized reading' (duration: 148.404909ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:55.252082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.590022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rqvlm\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-24T15:16:55.252186Z","caller":"traceutil/trace.go:171","msg":"trace[1006420179] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rqvlm; range_end:; response_count:1; response_revision:810; }","duration":"136.761276ms","start":"2026-08-24T15:16:55.115401Z","end":"2026-08-24T15:16:55.252163Z","steps":["trace[1006420179] 'range keys from in-memory index tree' (duration: 136.367106ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:55.252261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.740106ms","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-08-24T15:16:55.25236Z","caller":"traceutil/trace.go:171","msg":"trace[514440762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:810; }","duration":"136.90736ms","start":"2026-08-24T15:16:55.115435Z","end":"2026-08-24T15:16:55.252342Z","steps":["trace[514440762] 'range keys from in-memory index tree' (duration: 136.50272ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:55.252183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.618533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-24T15:16:55.2525Z","caller":"traceutil/trace.go:171","msg":"trace[1892179366] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:810; }","duration":"136.973831ms","start":"2026-08-24T15:16:55.115497Z","end":"2026-08-24T15:16:55.252471Z","steps":["trace[1892179366] 'range keys from in-memory index tree' (duration: 136.403767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:01.133732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13655371691831656667,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-24T15:18:01.285483Z","caller":"traceutil/trace.go:171","msg":"trace[871927502] linearizableReadLoop","detail":"{readStateIndex:1203; appliedIndex:1202; }","duration":"651.745638ms","start":"2026-08-24T15:18:00.63369Z","end":"2026-08-24T15:18:01.285435Z","steps":["trace[871927502] 'read index received' (duration: 642.172662ms)","trace[871927502] 'applied index is now lower than readState.Index' (duration: 9.571676ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:18:01.285549Z","caller":"traceutil/trace.go:171","msg":"trace[1339159564] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"752.333687ms","start":"2026-08-24T15:18:00.533178Z","end":"2026-08-24T15:18:01.285511Z","steps":["trace[1339159564] 'process raft request' (duration: 742.628027ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:01.285664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.945385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:18:01.285705Z","caller":"traceutil/trace.go:171","msg":"trace[1927029313] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1158; }","duration":"652.039488ms","start":"2026-08-24T15:18:00.633651Z","end":"2026-08-24T15:18:01.285691Z","steps":["trace[1927029313] 'agreement among raft nodes before linearized reading' (duration: 651.950495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:01.285741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:00.633631Z","time spent":"652.09933ms","remote":"127.0.0.1:35186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:01.285752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.591622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:18:01.285743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:00.533148Z","time spent":"752.486173ms","remote":"127.0.0.1:33808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:01.285823Z","caller":"traceutil/trace.go:171","msg":"trace[1180642936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1158; }","duration":"651.653244ms","start":"2026-08-24T15:18:00.634146Z","end":"2026-08-24T15:18:01.285799Z","steps":["trace[1180642936] 'agreement among raft nodes before linearized reading' (duration: 651.546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:01.285865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:00.634119Z","time spent":"651.735177ms","remote":"127.0.0.1:33546","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-08-24T15:18:01.285933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.81127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-24T15:18:01.285966Z","caller":"traceutil/trace.go:171","msg":"trace[879645895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1158; }","duration":"213.884384ms","start":"2026-08-24T15:18:01.072073Z","end":"2026-08-24T15:18:01.285958Z","steps":["trace[879645895] 'agreement among raft nodes before linearized reading' (duration: 213.769589ms)"],"step_count":1}