{"level":"warn","ts":"2026-06-28T19:51:06.594537Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:51:06.594646Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-06-28T19:51:06.594729Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:51:06.59474Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-06-28T19:51:06.594768Z","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-06-28T19:51:06.59558Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-06-28T19:51:06.595672Z","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.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-06-28T19:51:06.599748Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.815231ms"} {"level":"info","ts":"2026-06-28T19:51:06.605666Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-06-28T19:51:06.605746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T19:51:06.605769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-06-28T19:51:06.605783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T19:51:06.605794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-06-28T19:51:06.605841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-06-28T19:51:06.612089Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T19:51:06.616065Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T19:51:06.618311Z","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-06-28T19:51:06.620659Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T19:51:06.622828Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T19:51:06.622572Z","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-06-28T19:51:06.623078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-06-28T19:51:06.623082Z","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-06-28T19:51:06.623403Z","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-06-28T19:51:06.623541Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-06-28T19:51:06.628541Z","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-06-28T19:51:06.628793Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-06-28T19:51:06.628821Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-06-28T19:51:06.62882Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T19:51:06.628894Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T19:51:06.906908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T19:51:06.907014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T19:51:06.907058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-06-28T19:51:06.907088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-06-28T19:51:06.9071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-06-28T19:51:06.90712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-06-28T19:51:06.907148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-06-28T19:51:06.90828Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T19:51:06.911901Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:51:06.912434Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:51:06.912495Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:51:06.913149Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:51:06.913259Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:51:06.913294Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:51:06.916325Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-06-28T19:51:06.916787Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T19:51:06.916834Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T19:51:06.917295Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-28T19:51:08.675764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.158512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-28T19:51:08.676001Z","caller":"traceutil/trace.go:171","msg":"trace[1194810427] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"174.622326ms","start":"2026-06-28T19:51:08.501358Z","end":"2026-06-28T19:51:08.675981Z","steps":["trace[1194810427] 'process raft request' (duration: 174.552145ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:08.676222Z","caller":"traceutil/trace.go:171","msg":"trace[1914964288] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"174.931019ms","start":"2026-06-28T19:51:08.501247Z","end":"2026-06-28T19:51:08.676178Z","steps":["trace[1914964288] 'process raft request' (duration: 62.638495ms)","trace[1914964288] 'compare' (duration: 110.90045ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:09.766453Z","caller":"traceutil/trace.go:171","msg":"trace[69072431] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"114.299901ms","start":"2026-06-28T19:51:09.652113Z","end":"2026-06-28T19:51:09.766413Z","steps":["trace[69072431] 'process raft request' (duration: 21.565915ms)","trace[69072431] 'compare' (duration: 92.562734ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:09.951449Z","caller":"traceutil/trace.go:171","msg":"trace[246520161] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"153.043025ms","start":"2026-06-28T19:51:09.798331Z","end":"2026-06-28T19:51:09.951374Z","steps":["trace[246520161] 'process raft request' (duration: 145.102352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:11.523685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.542102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:51:11.523836Z","caller":"traceutil/trace.go:171","msg":"trace[1171044087] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"158.624984ms","start":"2026-06-28T19:51:11.365186Z","end":"2026-06-28T19:51:11.52381Z","steps":["trace[1171044087] 'process raft request' (duration: 53.679917ms)","trace[1171044087] 'compare' (duration: 104.418121ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:11.523884Z","caller":"traceutil/trace.go:171","msg":"trace[2036819435] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"147.340187ms","start":"2026-06-28T19:51:11.37653Z","end":"2026-06-28T19:51:11.52387Z","steps":["trace[2036819435] 'process raft request' (duration: 147.278806ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:11.524076Z","caller":"traceutil/trace.go:171","msg":"trace[2095711686] linearizableReadLoop","detail":"{readStateIndex:228; appliedIndex:226; }","duration":"154.213987ms","start":"2026-06-28T19:51:11.369803Z","end":"2026-06-28T19:51:11.524017Z","steps":["trace[2095711686] 'read index received' (duration: 3.677137ms)","trace[2095711686] 'applied index is now lower than readState.Index' (duration: 150.53508ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:11.524231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.403639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:11.524309Z","caller":"traceutil/trace.go:171","msg":"trace[1261677594] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:0; response_revision:223; }","duration":"154.545621ms","start":"2026-06-28T19:51:11.369741Z","end":"2026-06-28T19:51:11.524287Z","steps":["trace[1261677594] 'agreement among raft nodes before linearized reading' (duration: 154.382199ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:11.730377Z","caller":"traceutil/trace.go:171","msg":"trace[1066629838] linearizableReadLoop","detail":"{readStateIndex:233; appliedIndex:232; }","duration":"148.872192ms","start":"2026-06-28T19:51:11.58148Z","end":"2026-06-28T19:51:11.730352Z","steps":["trace[1066629838] 'read index received' (duration: 65.915663ms)","trace[1066629838] 'applied index is now lower than readState.Index' (duration: 82.955629ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:11.730629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.439537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-28T19:51:11.730687Z","caller":"traceutil/trace.go:171","msg":"trace[652159989] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:227; }","duration":"148.527148ms","start":"2026-06-28T19:51:11.582144Z","end":"2026-06-28T19:51:11.730671Z","steps":["trace[652159989] 'agreement among raft nodes before linearized reading' (duration: 148.366827ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:11.730553Z","caller":"traceutil/trace.go:171","msg":"trace[1968865404] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"157.023647ms","start":"2026-06-28T19:51:11.573382Z","end":"2026-06-28T19:51:11.730405Z","steps":["trace[1968865404] 'process raft request' (duration: 74.129518ms)","trace[1968865404] 'compare' (duration: 82.733247ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:11.730704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.168105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-ke4yne\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-06-28T19:51:11.730952Z","caller":"traceutil/trace.go:171","msg":"trace[1087304724] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-ke4yne; range_end:; response_count:1; response_revision:227; }","duration":"149.482839ms","start":"2026-06-28T19:51:11.581445Z","end":"2026-06-28T19:51:11.730928Z","steps":["trace[1087304724] 'agreement among raft nodes before linearized reading' (duration: 149.044953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:12.105973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.629658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:51:12.106251Z","caller":"traceutil/trace.go:171","msg":"trace[5394740] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"264.433706ms","start":"2026-06-28T19:51:11.841777Z","end":"2026-06-28T19:51:12.10621Z","steps":["trace[5394740] 'process raft request' (duration: 108.449683ms)","trace[5394740] 'compare' (duration: 155.445307ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:12.106459Z","caller":"traceutil/trace.go:171","msg":"trace[645968589] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"264.242814ms","start":"2026-06-28T19:51:11.842195Z","end":"2026-06-28T19:51:12.106438Z","steps":["trace[645968589] 'process raft request' (duration: 263.908441ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:12.132434Z","caller":"traceutil/trace.go:171","msg":"trace[1336231901] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"233.706887ms","start":"2026-06-28T19:51:11.898694Z","end":"2026-06-28T19:51:12.132401Z","steps":["trace[1336231901] 'process raft request' (duration: 233.593866ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:12.132472Z","caller":"traceutil/trace.go:171","msg":"trace[623701550] linearizableReadLoop","detail":"{readStateIndex:242; appliedIndex:239; }","duration":"233.046059ms","start":"2026-06-28T19:51:11.899333Z","end":"2026-06-28T19:51:12.132379Z","steps":["trace[623701550] 'read index received' (duration: 50.881697ms)","trace[623701550] 'applied index is now lower than readState.Index' (duration: 182.163022ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:12.132848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.367183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:12.133083Z","caller":"traceutil/trace.go:171","msg":"trace[1220519496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:236; }","duration":"233.583405ms","start":"2026-06-28T19:51:11.899318Z","end":"2026-06-28T19:51:12.132901Z","steps":["trace[1220519496] 'agreement among raft nodes before linearized reading' (duration: 233.195371ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:12.949428Z","caller":"traceutil/trace.go:171","msg":"trace[1813902662] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"328.504533ms","start":"2026-06-28T19:51:12.620891Z","end":"2026-06-28T19:51:12.949395Z","steps":["trace[1813902662] 'process raft request' (duration: 328.371302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:12.949718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:12.62087Z","time spent":"328.745125ms","remote":"127.0.0.1:57034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:51:12.949932Z","caller":"traceutil/trace.go:171","msg":"trace[1816556262] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"375.575458ms","start":"2026-06-28T19:51:12.574281Z","end":"2026-06-28T19:51:12.949856Z","steps":["trace[1816556262] 'process raft request' (duration: 332.705706ms)","trace[1816556262] 'compare' (duration: 41.920402ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:12.950083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.837829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3708"} {"level":"info","ts":"2026-06-28T19:51:12.949831Z","caller":"traceutil/trace.go:171","msg":"trace[965811797] linearizableReadLoop","detail":"{readStateIndex:259; appliedIndex:258; }","duration":"338.569287ms","start":"2026-06-28T19:51:12.611214Z","end":"2026-06-28T19:51:12.949783Z","steps":["trace[965811797] 'read index received' (duration: 295.945526ms)","trace[965811797] 'applied index is now lower than readState.Index' (duration: 42.615791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:12.950165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:12.574259Z","time spent":"375.786991ms","remote":"127.0.0.1:56906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:12.950186Z","caller":"traceutil/trace.go:171","msg":"trace[326573851] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:254; }","duration":"339.005231ms","start":"2026-06-28T19:51:12.611148Z","end":"2026-06-28T19:51:12.950153Z","steps":["trace[326573851] 'agreement among raft nodes before linearized reading' (duration: 338.756599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:12.95024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:12.611124Z","time spent":"339.107012ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3731,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-28T19:51:13.070516Z","caller":"traceutil/trace.go:171","msg":"trace[1459365227] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"111.425648ms","start":"2026-06-28T19:51:12.959054Z","end":"2026-06-28T19:51:13.07048Z","steps":["trace[1459365227] 'process raft request' (duration: 111.284616ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:13.070531Z","caller":"traceutil/trace.go:171","msg":"trace[434820492] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"113.646492ms","start":"2026-06-28T19:51:12.956853Z","end":"2026-06-28T19:51:13.070499Z","steps":["trace[434820492] 'process raft request' (duration: 96.657847ms)","trace[434820492] 'compare' (duration: 16.695362ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:13.070669Z","caller":"traceutil/trace.go:171","msg":"trace[1065264100] linearizableReadLoop","detail":"{readStateIndex:262; appliedIndex:261; }","duration":"112.958344ms","start":"2026-06-28T19:51:12.957691Z","end":"2026-06-28T19:51:13.07065Z","steps":["trace[1065264100] 'read index received' (duration: 53.974417ms)","trace[1065264100] 'applied index is now lower than readState.Index' (duration: 58.982117ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:13.070855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.131827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-28T19:51:13.071292Z","caller":"traceutil/trace.go:171","msg":"trace[2105491823] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:257; }","duration":"113.587981ms","start":"2026-06-28T19:51:12.95765Z","end":"2026-06-28T19:51:13.071238Z","steps":["trace[2105491823] 'agreement among raft nodes before linearized reading' (duration: 113.111706ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:14.839438Z","caller":"traceutil/trace.go:171","msg":"trace[1518121606] transaction","detail":"{read_only:false; number_of_response:0; response_revision:326; }","duration":"149.416235ms","start":"2026-06-28T19:51:14.689967Z","end":"2026-06-28T19:51:14.839383Z","steps":["trace[1518121606] 'process raft request' (duration: 148.749128ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:14.83948Z","caller":"traceutil/trace.go:171","msg":"trace[229363777] transaction","detail":"{read_only:false; number_of_response:0; response_revision:326; }","duration":"149.241903ms","start":"2026-06-28T19:51:14.690208Z","end":"2026-06-28T19:51:14.83945Z","steps":["trace[229363777] 'process raft request' (duration: 149.079321ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:14.839478Z","caller":"traceutil/trace.go:171","msg":"trace[245094119] transaction","detail":"{read_only:false; number_of_response:0; response_revision:326; }","duration":"149.231983ms","start":"2026-06-28T19:51:14.690208Z","end":"2026-06-28T19:51:14.83944Z","steps":["trace[245094119] 'process raft request' (duration: 149.120132ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:14.839603Z","caller":"traceutil/trace.go:171","msg":"trace[567066087] transaction","detail":"{read_only:false; number_of_response:0; response_revision:326; }","duration":"148.349534ms","start":"2026-06-28T19:51:14.691213Z","end":"2026-06-28T19:51:14.839563Z","steps":["trace[567066087] 'process raft request' (duration: 148.153042ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:14.881236Z","caller":"traceutil/trace.go:171","msg":"trace[1527473378] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"123.271526ms","start":"2026-06-28T19:51:14.757934Z","end":"2026-06-28T19:51:14.881206Z","steps":["trace[1527473378] 'process raft request' (duration: 122.955362ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:15.180224Z","caller":"traceutil/trace.go:171","msg":"trace[790103314] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:344; }","duration":"109.444671ms","start":"2026-06-28T19:51:15.070749Z","end":"2026-06-28T19:51:15.180193Z","steps":["trace[790103314] 'read index received' (duration: 52.338376ms)","trace[790103314] 'applied index is now lower than readState.Index' (duration: 57.104675ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:15.180346Z","caller":"traceutil/trace.go:171","msg":"trace[1791074208] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"147.580391ms","start":"2026-06-28T19:51:15.032714Z","end":"2026-06-28T19:51:15.180294Z","steps":["trace[1791074208] 'process raft request' (duration: 90.446176ms)","trace[1791074208] 'compare' (duration: 56.881323ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:15.180444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.659923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-28T19:51:15.180554Z","caller":"traceutil/trace.go:171","msg":"trace[1440074706] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:332; }","duration":"109.850304ms","start":"2026-06-28T19:51:15.070681Z","end":"2026-06-28T19:51:15.180531Z","steps":["trace[1440074706] 'agreement among raft nodes before linearized reading' (duration: 109.622092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:15.59068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.308063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:51:15.591067Z","caller":"traceutil/trace.go:171","msg":"trace[1015432106] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"120.390664ms","start":"2026-06-28T19:51:15.470654Z","end":"2026-06-28T19:51:15.591045Z","steps":["trace[1015432106] 'read index received' (duration: 53.161µs)","trace[1015432106] 'applied index is now lower than readState.Index' (duration: 120.336063ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:15.591276Z","caller":"traceutil/trace.go:171","msg":"trace[524934278] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"163.897729ms","start":"2026-06-28T19:51:15.427356Z","end":"2026-06-28T19:51:15.591254Z","steps":["trace[524934278] 'process raft request' (duration: 34.916748ms)","trace[524934278] 'compare' (duration: 128.135341ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:15.59137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.703146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-28T19:51:15.592571Z","caller":"traceutil/trace.go:171","msg":"trace[1014640938] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:340; }","duration":"121.947719ms","start":"2026-06-28T19:51:15.47059Z","end":"2026-06-28T19:51:15.592538Z","steps":["trace[1014640938] 'agreement among raft nodes before linearized reading' (duration: 120.632125ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:16.156717Z","caller":"traceutil/trace.go:171","msg":"trace[344642078] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"119.29691ms","start":"2026-06-28T19:51:16.037385Z","end":"2026-06-28T19:51:16.156682Z","steps":["trace[344642078] 'process raft request' (duration: 106.991424ms)","trace[344642078] 'compare' (duration: 11.272775ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:16.290215Z","caller":"traceutil/trace.go:171","msg":"trace[1286338043] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"129.072648ms","start":"2026-06-28T19:51:16.161098Z","end":"2026-06-28T19:51:16.290171Z","steps":["trace[1286338043] 'process raft request' (duration: 128.730965ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:16.290336Z","caller":"traceutil/trace.go:171","msg":"trace[1691531575] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:357; }","duration":"119.762753ms","start":"2026-06-28T19:51:16.170548Z","end":"2026-06-28T19:51:16.290311Z","steps":["trace[1691531575] 'read index received' (duration: 44.793807ms)","trace[1691531575] 'applied index is now lower than readState.Index' (duration: 74.967756ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:16.290352Z","caller":"traceutil/trace.go:171","msg":"trace[531359738] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"124.811045ms","start":"2026-06-28T19:51:16.165501Z","end":"2026-06-28T19:51:16.290312Z","steps":["trace[531359738] 'process raft request' (duration: 124.589343ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:16.290343Z","caller":"traceutil/trace.go:171","msg":"trace[1523744602] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"128.347271ms","start":"2026-06-28T19:51:16.161904Z","end":"2026-06-28T19:51:16.290251Z","steps":["trace[1523744602] 'process raft request' (duration: 128.073558ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:16.290374Z","caller":"traceutil/trace.go:171","msg":"trace[1855718579] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"127.665344ms","start":"2026-06-28T19:51:16.16261Z","end":"2026-06-28T19:51:16.290275Z","steps":["trace[1855718579] 'process raft request' (duration: 127.433382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:16.290557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.978576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-28T19:51:16.290635Z","caller":"traceutil/trace.go:171","msg":"trace[786941401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:349; }","duration":"120.094137ms","start":"2026-06-28T19:51:16.170523Z","end":"2026-06-28T19:51:16.290617Z","steps":["trace[786941401] 'agreement among raft nodes before linearized reading' (duration: 119.911326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:19.724355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862127,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:51:19.871396Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.161375603s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:51:19.871997Z","caller":"traceutil/trace.go:171","msg":"trace[399372090] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"1.162123981s","start":"2026-06-28T19:51:18.709845Z","end":"2026-06-28T19:51:19.871969Z","steps":["trace[399372090] 'process raft request' (duration: 1.161877659s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:19.872191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:18.709815Z","time spent":"1.162267282s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:20.487362Z","caller":"traceutil/trace.go:171","msg":"trace[1566585188] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:413; }","duration":"1.26353102s","start":"2026-06-28T19:51:19.223807Z","end":"2026-06-28T19:51:20.487338Z","steps":["trace[1566585188] 'read index received' (duration: 647.9806ms)","trace[1566585188] 'applied index is now lower than readState.Index' (duration: 615.54952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:20.487545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.263727983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-28T19:51:20.487582Z","caller":"traceutil/trace.go:171","msg":"trace[1800913189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:401; }","duration":"1.263835663s","start":"2026-06-28T19:51:19.223736Z","end":"2026-06-28T19:51:20.487572Z","steps":["trace[1800913189] 'agreement among raft nodes before linearized reading' (duration: 1.263745632s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:20.487559Z","caller":"traceutil/trace.go:171","msg":"trace[1595229559] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"1.777126416s","start":"2026-06-28T19:51:18.710382Z","end":"2026-06-28T19:51:20.487508Z","steps":["trace[1595229559] 'process raft request' (duration: 1.770788681s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:20.487668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212811295s","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-06-28T19:51:20.487698Z","caller":"traceutil/trace.go:171","msg":"trace[954214178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:401; }","duration":"1.212889496s","start":"2026-06-28T19:51:19.274803Z","end":"2026-06-28T19:51:20.487693Z","steps":["trace[954214178] 'agreement among raft nodes before linearized reading' (duration: 1.212840616s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:20.487734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:19.274776Z","time spent":"1.212952707s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:51:20.487794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:18.710353Z","time spent":"1.777322397s","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:20.487821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.782451ms","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-06-28T19:51:20.487848Z","caller":"traceutil/trace.go:171","msg":"trace[1180927943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:401; }","duration":"118.853493ms","start":"2026-06-28T19:51:20.368988Z","end":"2026-06-28T19:51:20.487842Z","steps":["trace[1180927943] 'agreement among raft nodes before linearized reading' (duration: 118.809102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:20.487612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:19.223709Z","time spent":"1.263895753s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:51:30.511806Z","caller":"traceutil/trace.go:171","msg":"trace[1144641095] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:444; }","duration":"146.747998ms","start":"2026-06-28T19:51:30.365035Z","end":"2026-06-28T19:51:30.511783Z","steps":["trace[1144641095] 'read index received' (duration: 146.584754ms)","trace[1144641095] 'applied index is now lower than readState.Index' (duration: 162.534µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:30.511943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.892601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:30.511966Z","caller":"traceutil/trace.go:171","msg":"trace[2066037793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"146.980723ms","start":"2026-06-28T19:51:30.364978Z","end":"2026-06-28T19:51:30.511959Z","steps":["trace[2066037793] 'agreement among raft nodes before linearized reading' (duration: 146.889601ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:30.51217Z","caller":"traceutil/trace.go:171","msg":"trace[568939096] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"379.434497ms","start":"2026-06-28T19:51:30.132695Z","end":"2026-06-28T19:51:30.512129Z","steps":["trace[568939096] 'process raft request' (duration: 378.987825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:30.512358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:30.132669Z","time spent":"379.591122ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:32.566769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.959124019s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-28T19:51:32.566894Z","caller":"traceutil/trace.go:171","msg":"trace[1189915318] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:445; }","duration":"2.016912645s","start":"2026-06-28T19:51:30.549957Z","end":"2026-06-28T19:51:32.56687Z","steps":["trace[1189915318] 'read index received' (duration: 57.606881ms)","trace[1189915318] 'applied index is now lower than readState.Index' (duration: 1.959303814s)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:32.567014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:30.514974Z","time spent":"2.052033578s","remote":"127.0.0.1:56876","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-28T19:51:32.567142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.010633918s","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-06-28T19:51:32.567188Z","caller":"traceutil/trace.go:171","msg":"trace[109934687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:429; }","duration":"2.01070747s","start":"2026-06-28T19:51:30.556467Z","end":"2026-06-28T19:51:32.567174Z","steps":["trace[109934687] 'agreement among raft nodes before linearized reading' (duration: 2.010595567s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:32.567222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:30.556458Z","time spent":"2.010756971s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-28T19:51:32.567318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.017358116s","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-06-28T19:51:32.567358Z","caller":"traceutil/trace.go:171","msg":"trace[2139149088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:429; }","duration":"2.017415248s","start":"2026-06-28T19:51:30.549926Z","end":"2026-06-28T19:51:32.567341Z","steps":["trace[2139149088] 'agreement among raft nodes before linearized reading' (duration: 2.017343366s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:32.567328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.201554946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:51:32.56739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:30.549912Z","time spent":"2.017470779s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-28T19:51:32.56741Z","caller":"traceutil/trace.go:171","msg":"trace[2072253685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"1.20169181s","start":"2026-06-28T19:51:31.365699Z","end":"2026-06-28T19:51:32.567391Z","steps":["trace[2072253685] 'agreement among raft nodes before linearized reading' (duration: 1.201554576s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:32.567444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:31.365675Z","time spent":"1.201763002s","remote":"127.0.0.1:56856","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-06-28T19:51:32.567484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00807617s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-28T19:51:32.567455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.009880147s","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-06-28T19:51:32.567511Z","caller":"traceutil/trace.go:171","msg":"trace[1167298770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"2.00811955s","start":"2026-06-28T19:51:30.559382Z","end":"2026-06-28T19:51:32.567502Z","steps":["trace[1167298770] 'agreement among raft nodes before linearized reading' (duration: 2.008072819s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:32.56754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:30.559372Z","time spent":"2.008163322s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:51:32.567564Z","caller":"traceutil/trace.go:171","msg":"trace[420700331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:429; }","duration":"2.010055692s","start":"2026-06-28T19:51:30.557479Z","end":"2026-06-28T19:51:32.567535Z","steps":["trace[420700331] 'agreement among raft nodes before linearized reading' (duration: 2.009843027s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:32.567623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:30.557456Z","time spent":"2.010155425s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:51:33.187673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.516998ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:51:33.188339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.190466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:51:33.188073Z","caller":"traceutil/trace.go:171","msg":"trace[1011466213] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:429; }","duration":"423.95491ms","start":"2026-06-28T19:51:32.764092Z","end":"2026-06-28T19:51:33.188047Z","steps":["trace[1011466213] 'range keys from in-memory index tree' (duration: 423.487627ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:33.188909Z","caller":"traceutil/trace.go:171","msg":"trace[1495592429] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"619.308615ms","start":"2026-06-28T19:51:32.569561Z","end":"2026-06-28T19:51:33.18887Z","steps":["trace[1495592429] 'process raft request' (duration: 235.485973ms)","trace[1495592429] 'compare' (duration: 382.635071ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:33.189083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:32.569543Z","time spent":"619.449989ms","remote":"127.0.0.1:56876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:33.189634Z","caller":"traceutil/trace.go:171","msg":"trace[217809046] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"615.960059ms","start":"2026-06-28T19:51:32.573639Z","end":"2026-06-28T19:51:33.189599Z","steps":["trace[217809046] 'process raft request' (duration: 615.678222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:33.189975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:32.573622Z","time spent":"616.096242ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:33.19018Z","caller":"traceutil/trace.go:171","msg":"trace[481980656] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"615.186458ms","start":"2026-06-28T19:51:32.57497Z","end":"2026-06-28T19:51:33.190156Z","steps":["trace[481980656] 'process raft request' (duration: 615.066305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:33.190196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.63243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:33.190237Z","caller":"traceutil/trace.go:171","msg":"trace[1478456476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:434; }","duration":"612.689482ms","start":"2026-06-28T19:51:32.577538Z","end":"2026-06-28T19:51:33.190227Z","steps":["trace[1478456476] 'agreement among raft nodes before linearized reading' (duration: 612.629541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:33.19026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:32.577532Z","time spent":"612.723063ms","remote":"127.0.0.1:56856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-28T19:51:33.190262Z","caller":"traceutil/trace.go:171","msg":"trace[417150472] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"615.740333ms","start":"2026-06-28T19:51:32.574393Z","end":"2026-06-28T19:51:33.190133Z","steps":["trace[417150472] 'process raft request' (duration: 615.377884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:33.190273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:32.574961Z","time spent":"615.26971ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:33.190189Z","caller":"traceutil/trace.go:171","msg":"trace[1742929332] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:446; }","duration":"612.571139ms","start":"2026-06-28T19:51:32.577557Z","end":"2026-06-28T19:51:33.190128Z","steps":["trace[1742929332] 'read index received' (duration: 227.415503ms)","trace[1742929332] 'applied index is now lower than readState.Index' (duration: 385.154626ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:33.190364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:32.574367Z","time spent":"615.924767ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:33.189849Z","caller":"traceutil/trace.go:171","msg":"trace[1570406171] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"615.826925ms","start":"2026-06-28T19:51:32.574007Z","end":"2026-06-28T19:51:33.189834Z","steps":["trace[1570406171] 'process raft request' (duration: 615.456925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:33.191685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:32.573982Z","time spent":"617.59349ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:39.557126Z","caller":"traceutil/trace.go:171","msg":"trace[825189718] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"341.371186ms","start":"2026-06-28T19:51:39.215714Z","end":"2026-06-28T19:51:39.557085Z","steps":["trace[825189718] 'process raft request' (duration: 341.11743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:39.5574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:39.215682Z","time spent":"341.585953ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:39.617109Z","caller":"traceutil/trace.go:171","msg":"trace[1052367369] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:493; }","duration":"252.478254ms","start":"2026-06-28T19:51:39.364604Z","end":"2026-06-28T19:51:39.617082Z","steps":["trace[1052367369] 'read index received' (duration: 192.485499ms)","trace[1052367369] 'applied index is now lower than readState.Index' (duration: 59.991365ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:39.617141Z","caller":"traceutil/trace.go:171","msg":"trace[1066512956] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"401.284999ms","start":"2026-06-28T19:51:39.215839Z","end":"2026-06-28T19:51:39.617124Z","steps":["trace[1066512956] 'process raft request' (duration: 400.91697ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:39.617246Z","caller":"traceutil/trace.go:171","msg":"trace[2104256391] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"400.794497ms","start":"2026-06-28T19:51:39.216418Z","end":"2026-06-28T19:51:39.617213Z","steps":["trace[2104256391] 'process raft request' (duration: 400.49134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:39.617313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:39.215801Z","time spent":"401.398531ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:39.617388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:39.216407Z","time spent":"400.913691ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:39.617531Z","caller":"traceutil/trace.go:171","msg":"trace[797907511] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"400.86909ms","start":"2026-06-28T19:51:39.216589Z","end":"2026-06-28T19:51:39.617458Z","steps":["trace[797907511] 'process raft request' (duration: 400.421548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:39.617768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:39.216553Z","time spent":"401.182877ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:39.617953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.318534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:39.618101Z","caller":"traceutil/trace.go:171","msg":"trace[1799047196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:477; }","duration":"253.5357ms","start":"2026-06-28T19:51:39.364547Z","end":"2026-06-28T19:51:39.618083Z","steps":["trace[1799047196] 'agreement among raft nodes before linearized reading' (duration: 253.172951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:41.30035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.607326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:51:41.300561Z","caller":"traceutil/trace.go:171","msg":"trace[891280048] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"491.346461ms","start":"2026-06-28T19:51:40.809179Z","end":"2026-06-28T19:51:41.300526Z","steps":["trace[891280048] 'process raft request' (duration: 491.27713ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:41.30061Z","caller":"traceutil/trace.go:171","msg":"trace[2123533433] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"523.167877ms","start":"2026-06-28T19:51:40.777402Z","end":"2026-06-28T19:51:41.30057Z","steps":["trace[2123533433] 'process raft request' (duration: 68.267773ms)","trace[2123533433] 'compare' (duration: 454.490084ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:41.30069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:40.80915Z","time spent":"491.487215ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:41.300707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:40.777375Z","time spent":"523.28111ms","remote":"127.0.0.1:56876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:42.477168Z","caller":"traceutil/trace.go:171","msg":"trace[500305836] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"830.892344ms","start":"2026-06-28T19:51:41.646224Z","end":"2026-06-28T19:51:42.477117Z","steps":["trace[500305836] 'process raft request' (duration: 826.443348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:42.477329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:41.646211Z","time spent":"831.040578ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:42.477994Z","caller":"traceutil/trace.go:171","msg":"trace[410376364] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:500; }","duration":"112.776563ms","start":"2026-06-28T19:51:42.365193Z","end":"2026-06-28T19:51:42.47797Z","steps":["trace[410376364] 'read index received' (duration: 107.63959ms)","trace[410376364] 'applied index is now lower than readState.Index' (duration: 5.135953ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:42.478145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.944778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:42.478187Z","caller":"traceutil/trace.go:171","msg":"trace[2110014574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"113.04239ms","start":"2026-06-28T19:51:42.365132Z","end":"2026-06-28T19:51:42.478174Z","steps":["trace[2110014574] 'agreement among raft nodes before linearized reading' (duration: 112.935508ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:42.478181Z","caller":"traceutil/trace.go:171","msg":"trace[1186928966] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"831.631092ms","start":"2026-06-28T19:51:41.6465Z","end":"2026-06-28T19:51:42.478131Z","steps":["trace[1186928966] 'process raft request' (duration: 831.295313ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:42.478247Z","caller":"traceutil/trace.go:171","msg":"trace[1329072833] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"831.421127ms","start":"2026-06-28T19:51:41.646794Z","end":"2026-06-28T19:51:42.478215Z","steps":["trace[1329072833] 'process raft request' (duration: 831.13362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:42.478393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:41.646783Z","time spent":"831.53763ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:42.47847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:41.646491Z","time spent":"831.809607ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:46.615181Z","caller":"traceutil/trace.go:171","msg":"trace[1854737571] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"112.609763ms","start":"2026-06-28T19:51:46.50253Z","end":"2026-06-28T19:51:46.61514Z","steps":["trace[1854737571] 'process raft request' (duration: 112.431929ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:50.166976Z","caller":"traceutil/trace.go:171","msg":"trace[955568981] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"137.173066ms","start":"2026-06-28T19:51:50.029773Z","end":"2026-06-28T19:51:50.166946Z","steps":["trace[955568981] 'process raft request' (duration: 135.417006ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:50.169696Z","caller":"traceutil/trace.go:171","msg":"trace[1450301974] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"118.575937ms","start":"2026-06-28T19:51:50.051103Z","end":"2026-06-28T19:51:50.169679Z","steps":["trace[1450301974] 'process raft request' (duration: 118.25665ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:50.169782Z","caller":"traceutil/trace.go:171","msg":"trace[1180760282] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"131.150029ms","start":"2026-06-28T19:51:50.038622Z","end":"2026-06-28T19:51:50.169772Z","steps":["trace[1180760282] 'process raft request' (duration: 130.602947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:51.013011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862460,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:51:51.513534Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862460,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:51:51.683317Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.22603842s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:51:51.702542Z","caller":"traceutil/trace.go:171","msg":"trace[862931660] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.245362852s","start":"2026-06-28T19:51:50.457141Z","end":"2026-06-28T19:51:51.702504Z","steps":["trace[862931660] 'process raft request' (duration: 1.226360418s)","trace[862931660] 'compare' (duration: 17.860829ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:51:51.702739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.45712Z","time spent":"1.245515016s","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:51:51.702909Z","caller":"traceutil/trace.go:171","msg":"trace[1820036580] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.235346176s","start":"2026-06-28T19:51:50.467531Z","end":"2026-06-28T19:51:51.702878Z","steps":["trace[1820036580] 'process raft request' (duration: 1.234929587s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:51.70306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.467513Z","time spent":"1.235478719s","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:51:51.703198Z","caller":"traceutil/trace.go:171","msg":"trace[153320033] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.187364207s","start":"2026-06-28T19:51:50.515818Z","end":"2026-06-28T19:51:51.703183Z","steps":["trace[153320033] 'process raft request' (duration: 1.186952048s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:51.703206Z","caller":"traceutil/trace.go:171","msg":"trace[1834032443] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:607; }","duration":"1.190473307s","start":"2026-06-28T19:51:50.51271Z","end":"2026-06-28T19:51:51.703184Z","steps":["trace[1834032443] 'read index received' (duration: 1.17087657s)","trace[1834032443] 'applied index is now lower than readState.Index' (duration: 19.595577ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:51.70323Z","caller":"traceutil/trace.go:171","msg":"trace[1998107456] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"118.232889ms","start":"2026-06-28T19:51:51.584978Z","end":"2026-06-28T19:51:51.70321Z","steps":["trace[1998107456] 'process raft request' (duration: 118.141557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:51.703277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.515793Z","time spent":"1.187438389s","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:51.703371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.190650912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-28T19:51:51.703379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.867047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:51:51.703425Z","caller":"traceutil/trace.go:171","msg":"trace[1368150447] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:588; }","duration":"1.190742284s","start":"2026-06-28T19:51:50.512665Z","end":"2026-06-28T19:51:51.703407Z","steps":["trace[1368150447] 'agreement among raft nodes before linearized reading' (duration: 1.19063696s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:51.703429Z","caller":"traceutil/trace.go:171","msg":"trace[298808687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"335.954309ms","start":"2026-06-28T19:51:51.36746Z","end":"2026-06-28T19:51:51.703414Z","steps":["trace[298808687] 'agreement among raft nodes before linearized reading' (duration: 335.879457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:51.703438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185972616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-28T19:51:51.703446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077653359s","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-06-28T19:51:51.703457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.512643Z","time spent":"1.190807275s","remote":"127.0.0.1:56876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.70\" "} {"level":"warn","ts":"2026-06-28T19:51:51.703468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:51.367442Z","time spent":"336.016591ms","remote":"127.0.0.1:56856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-28T19:51:51.703482Z","caller":"traceutil/trace.go:171","msg":"trace[416581993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"1.077716041s","start":"2026-06-28T19:51:50.625757Z","end":"2026-06-28T19:51:51.703473Z","steps":["trace[416581993] 'agreement among raft nodes before linearized reading' (duration: 1.07765056s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:51.703482Z","caller":"traceutil/trace.go:171","msg":"trace[568467329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"1.186038907s","start":"2026-06-28T19:51:50.517429Z","end":"2026-06-28T19:51:51.703468Z","steps":["trace[568467329] 'agreement among raft nodes before linearized reading' (duration: 1.185900444s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:51.703505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.625739Z","time spent":"1.077761432s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-28T19:51:51.703521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.517415Z","time spent":"1.186095449s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T19:51:51.703537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111548572s","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-06-28T19:51:51.703574Z","caller":"traceutil/trace.go:171","msg":"trace[290097468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"1.111613553s","start":"2026-06-28T19:51:50.591949Z","end":"2026-06-28T19:51:51.703563Z","steps":["trace[290097468] 'agreement among raft nodes before linearized reading' (duration: 1.111545002s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:51.703603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:50.591934Z","time spent":"1.111662224s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-28T19:51:52.423913Z","caller":"traceutil/trace.go:171","msg":"trace[717730828] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"309.68575ms","start":"2026-06-28T19:51:52.11421Z","end":"2026-06-28T19:51:52.423896Z","steps":["trace[717730828] 'process raft request' (duration: 309.244811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:52.424021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:52.114172Z","time spent":"309.797103ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:51:58.002167Z","caller":"traceutil/trace.go:171","msg":"trace[648444132] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"249.016135ms","start":"2026-06-28T19:51:57.75313Z","end":"2026-06-28T19:51:58.002146Z","steps":["trace[648444132] 'read index received' (duration: 248.191368ms)","trace[648444132] 'applied index is now lower than readState.Index' (duration: 824.217µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:51:58.002297Z","caller":"traceutil/trace.go:171","msg":"trace[2114813672] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"588.469361ms","start":"2026-06-28T19:51:57.41382Z","end":"2026-06-28T19:51:58.00229Z","steps":["trace[2114813672] 'process raft request' (duration: 587.756267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:58.002398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:57.413788Z","time spent":"588.528703ms","remote":"127.0.0.1:56924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:51:58.002579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.789852ms","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-06-28T19:51:58.002609Z","caller":"traceutil/trace.go:171","msg":"trace[1939442450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"241.891564ms","start":"2026-06-28T19:51:57.760707Z","end":"2026-06-28T19:51:58.002599Z","steps":["trace[1939442450] 'agreement among raft nodes before linearized reading' (duration: 241.786371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:58.002604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.44566ms","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-06-28T19:51:58.002675Z","caller":"traceutil/trace.go:171","msg":"trace[689221741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"245.514902ms","start":"2026-06-28T19:51:57.757139Z","end":"2026-06-28T19:51:58.002653Z","steps":["trace[689221741] 'agreement among raft nodes before linearized reading' (duration: 245.307927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:58.002683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.556818ms","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-06-28T19:51:58.002754Z","caller":"traceutil/trace.go:171","msg":"trace[1890554892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"249.68043ms","start":"2026-06-28T19:51:57.753045Z","end":"2026-06-28T19:51:58.002725Z","steps":["trace[1890554892] 'agreement among raft nodes before linearized reading' (duration: 249.504147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:58.002823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.387304ms","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-06-28T19:51:58.002948Z","caller":"traceutil/trace.go:171","msg":"trace[321797595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"235.542908ms","start":"2026-06-28T19:51:57.767372Z","end":"2026-06-28T19:51:58.002915Z","steps":["trace[321797595] 'agreement among raft nodes before linearized reading' (duration: 235.093308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:59.301655Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862590,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:51:59.802143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862590,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:00.30254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862590,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:00.314364Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.835599697s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:52:00.318168Z","caller":"traceutil/trace.go:171","msg":"trace[703263630] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"1.517471955s","start":"2026-06-28T19:51:58.800575Z","end":"2026-06-28T19:52:00.318047Z","steps":["trace[703263630] 'read index received' (duration: 1.513945642s)","trace[703263630] 'applied index is now lower than readState.Index' (duration: 3.523513ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:00.319293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51869197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6q5fn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-28T19:52:00.319425Z","caller":"traceutil/trace.go:171","msg":"trace[1518413225] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6q5fn; range_end:; response_count:1; response_revision:646; }","duration":"1.518844664s","start":"2026-06-28T19:51:58.800527Z","end":"2026-06-28T19:52:00.319372Z","steps":["trace[1518413225] 'agreement among raft nodes before linearized reading' (duration: 1.518521707s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:00.319481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:58.800506Z","time spent":"1.518963386s","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-6q5fn\" "} {"level":"info","ts":"2026-06-28T19:52:00.319832Z","caller":"traceutil/trace.go:171","msg":"trace[838304296] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.842230717s","start":"2026-06-28T19:51:58.477565Z","end":"2026-06-28T19:52:00.319796Z","steps":["trace[838304296] 'process raft request' (duration: 1.837258263s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:00.319937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:58.477532Z","time spent":"1.842337899s","remote":"127.0.0.1:56924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:00.320389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.763095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:52:00.320429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.133665ms","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-06-28T19:52:00.320483Z","caller":"traceutil/trace.go:171","msg":"trace[457155330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"956.919019ms","start":"2026-06-28T19:51:59.363534Z","end":"2026-06-28T19:52:00.320453Z","steps":["trace[457155330] 'agreement among raft nodes before linearized reading' (duration: 956.757755ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:00.32053Z","caller":"traceutil/trace.go:171","msg":"trace[1678061665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"303.230306ms","start":"2026-06-28T19:52:00.017232Z","end":"2026-06-28T19:52:00.320462Z","steps":["trace[1678061665] 'agreement among raft nodes before linearized reading' (duration: 303.063602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:00.320549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:51:59.363506Z","time spent":"957.03254ms","remote":"127.0.0.1:56856","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-06-28T19:52:00.32061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.017208Z","time spent":"303.386779ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:52:00.320679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.808838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-28T19:52:00.320676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.949333ms","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-06-28T19:52:00.320766Z","caller":"traceutil/trace.go:171","msg":"trace[1160130472] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"303.91227ms","start":"2026-06-28T19:52:00.016823Z","end":"2026-06-28T19:52:00.320736Z","steps":["trace[1160130472] 'agreement among raft nodes before linearized reading' (duration: 303.727717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:00.320816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.016813Z","time spent":"303.992502ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T19:52:00.320994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.661765ms","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-06-28T19:52:00.321082Z","caller":"traceutil/trace.go:171","msg":"trace[96324469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"303.756597ms","start":"2026-06-28T19:52:00.017305Z","end":"2026-06-28T19:52:00.321062Z","steps":["trace[96324469] 'agreement among raft nodes before linearized reading' (duration: 303.325558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:00.321141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.017299Z","time spent":"303.815508ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-28T19:52:00.322053Z","caller":"traceutil/trace.go:171","msg":"trace[1134956821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"307.093656ms","start":"2026-06-28T19:52:00.013649Z","end":"2026-06-28T19:52:00.320743Z","steps":["trace[1134956821] 'agreement among raft nodes before linearized reading' (duration: 306.907593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:00.322318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.013628Z","time spent":"308.544786ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:52:01.013062Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862594,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:01.084892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.210288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:01.085254Z","caller":"traceutil/trace.go:171","msg":"trace[1052354614] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"757.477855ms","start":"2026-06-28T19:52:00.327732Z","end":"2026-06-28T19:52:01.08521Z","steps":["trace[1052354614] 'process raft request' (duration: 135.816438ms)","trace[1052354614] 'compare' (duration: 621.009744ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:01.085724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.327715Z","time spent":"757.624518ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:01.085834Z","caller":"traceutil/trace.go:171","msg":"trace[397690572] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"757.957545ms","start":"2026-06-28T19:52:00.327852Z","end":"2026-06-28T19:52:01.085809Z","steps":["trace[397690572] 'process raft request' (duration: 757.198059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:01.086113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.327846Z","time spent":"758.22176ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:01.086242Z","caller":"traceutil/trace.go:171","msg":"trace[947878848] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"749.563049ms","start":"2026-06-28T19:52:00.336648Z","end":"2026-06-28T19:52:01.086211Z","steps":["trace[947878848] 'process raft request' (duration: 749.410406ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:01.086274Z","caller":"traceutil/trace.go:171","msg":"trace[1618488746] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"756.510434ms","start":"2026-06-28T19:52:00.329716Z","end":"2026-06-28T19:52:01.086226Z","steps":["trace[1618488746] 'process raft request' (duration: 756.049105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:01.086565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.336635Z","time spent":"749.673991ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:01.087051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.329698Z","time spent":"756.855241ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:01.514122Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862594,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:02.014512Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862594,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:02.480108Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.016569627s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-28T19:52:02.620146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.782359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:02.620345Z","caller":"traceutil/trace.go:171","msg":"trace[664146067] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"584.660476ms","start":"2026-06-28T19:52:02.035667Z","end":"2026-06-28T19:52:02.620327Z","steps":["trace[664146067] 'process raft request' (duration: 584.565514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:02.620422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:02.035633Z","time spent":"584.749728ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:02.620619Z","caller":"traceutil/trace.go:171","msg":"trace[1172195301] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"2.233806947s","start":"2026-06-28T19:52:00.386802Z","end":"2026-06-28T19:52:02.620609Z","steps":["trace[1172195301] 'process raft request' (duration: 2.093491006s)","trace[1172195301] 'compare' (duration: 139.239888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:02.620656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.386785Z","time spent":"2.233855937s","remote":"127.0.0.1:57062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:52:02.620737Z","caller":"traceutil/trace.go:171","msg":"trace[1361624844] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"2.107774163s","start":"2026-06-28T19:52:00.512956Z","end":"2026-06-28T19:52:02.62073Z","steps":["trace[1361624844] 'read index received' (duration: 1.96734795s)","trace[1361624844] 'applied index is now lower than readState.Index' (duration: 140.425483ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:02.621198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.25608607s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:02.621243Z","caller":"traceutil/trace.go:171","msg":"trace[1020159448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"1.256177112s","start":"2026-06-28T19:52:01.365055Z","end":"2026-06-28T19:52:02.621232Z","steps":["trace[1020159448] 'agreement among raft nodes before linearized reading' (duration: 1.256108191s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:02.621273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:01.36503Z","time spent":"1.256237014s","remote":"127.0.0.1:56856","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-06-28T19:52:02.621493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.373473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-28T19:52:02.621529Z","caller":"traceutil/trace.go:171","msg":"trace[9017155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"241.457875ms","start":"2026-06-28T19:52:02.380061Z","end":"2026-06-28T19:52:02.621519Z","steps":["trace[9017155] 'agreement among raft nodes before linearized reading' (duration: 241.342212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:02.62243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.108271253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-28T19:52:02.622558Z","caller":"traceutil/trace.go:171","msg":"trace[598061704] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:653; }","duration":"2.109613681s","start":"2026-06-28T19:52:00.512909Z","end":"2026-06-28T19:52:02.622523Z","steps":["trace[598061704] 'agreement among raft nodes before linearized reading' (duration: 2.108163371s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:02.622704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:00.512891Z","time spent":"2.109762833s","remote":"127.0.0.1:56876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.70\" "} {"level":"info","ts":"2026-06-28T19:52:04.439514Z","caller":"traceutil/trace.go:171","msg":"trace[1388528137] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"457.02026ms","start":"2026-06-28T19:52:03.982461Z","end":"2026-06-28T19:52:04.439481Z","steps":["trace[1388528137] 'read index received' (duration: 456.878738ms)","trace[1388528137] 'applied index is now lower than readState.Index' (duration: 136.572µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:04.439612Z","caller":"traceutil/trace.go:171","msg":"trace[707557264] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"457.196684ms","start":"2026-06-28T19:52:03.982374Z","end":"2026-06-28T19:52:04.439571Z","steps":["trace[707557264] 'process raft request' (duration: 456.912648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.439795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.297326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:04.439866Z","caller":"traceutil/trace.go:171","msg":"trace[1608733324] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:676; }","duration":"457.382027ms","start":"2026-06-28T19:52:03.982448Z","end":"2026-06-28T19:52:04.43983Z","steps":["trace[1608733324] 'agreement among raft nodes before linearized reading' (duration: 457.250045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.439911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.98244Z","time spent":"457.461189ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-06-28T19:52:04.439912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.98234Z","time spent":"457.463899ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:04.442943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.207674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:04.443013Z","caller":"traceutil/trace.go:171","msg":"trace[1457997026] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"460.317196ms","start":"2026-06-28T19:52:03.98268Z","end":"2026-06-28T19:52:04.442997Z","steps":["trace[1457997026] 'agreement among raft nodes before linearized reading' (duration: 460.202674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.443055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.982663Z","time spent":"460.382957ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"info","ts":"2026-06-28T19:52:04.443104Z","caller":"traceutil/trace.go:171","msg":"trace[342055961] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"454.240912ms","start":"2026-06-28T19:52:03.988722Z","end":"2026-06-28T19:52:04.442963Z","steps":["trace[342055961] 'process raft request' (duration: 453.995107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.443228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.091437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:04.443264Z","caller":"traceutil/trace.go:171","msg":"trace[631596890] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"262.163758ms","start":"2026-06-28T19:52:04.181091Z","end":"2026-06-28T19:52:04.443255Z","steps":["trace[631596890] 'agreement among raft nodes before linearized reading' (duration: 262.107967ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:04.443321Z","caller":"traceutil/trace.go:171","msg":"trace[359758198] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"452.396535ms","start":"2026-06-28T19:52:03.990907Z","end":"2026-06-28T19:52:04.443304Z","steps":["trace[359758198] 'process raft request' (duration: 451.926175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.443363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.576119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:04.44339Z","caller":"traceutil/trace.go:171","msg":"trace[535368883] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"454.614001ms","start":"2026-06-28T19:52:03.988768Z","end":"2026-06-28T19:52:04.443382Z","steps":["trace[535368883] 'agreement among raft nodes before linearized reading' (duration: 454.5672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.443389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.9909Z","time spent":"452.461446ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:52:04.443423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.988763Z","time spent":"454.652852ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-06-28T19:52:04.443215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.988706Z","time spent":"454.453447ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:52:04.443546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.500307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:04.443585Z","caller":"traceutil/trace.go:171","msg":"trace[300047465] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"453.545849ms","start":"2026-06-28T19:52:03.990026Z","end":"2026-06-28T19:52:04.443572Z","steps":["trace[300047465] 'agreement among raft nodes before linearized reading' (duration: 453.494098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.44357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.988456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:52:04.443614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.990001Z","time spent":"453.605919ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-06-28T19:52:04.443632Z","caller":"traceutil/trace.go:171","msg":"trace[1752943403] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"452.057767ms","start":"2026-06-28T19:52:03.991555Z","end":"2026-06-28T19:52:04.443613Z","steps":["trace[1752943403] 'agreement among raft nodes before linearized reading' (duration: 451.940815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.443688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.99155Z","time spent":"452.127009ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-28T19:52:04.443717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.10617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:04.443949Z","caller":"traceutil/trace.go:171","msg":"trace[827881604] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"454.500228ms","start":"2026-06-28T19:52:03.989427Z","end":"2026-06-28T19:52:04.443927Z","steps":["trace[827881604] 'agreement among raft nodes before linearized reading' (duration: 453.811644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:04.444118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:03.989421Z","time spent":"454.676802ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-06-28T19:52:05.497428Z","caller":"traceutil/trace.go:171","msg":"trace[430452897] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"115.502331ms","start":"2026-06-28T19:52:05.3819Z","end":"2026-06-28T19:52:05.497403Z","steps":["trace[430452897] 'process raft request' (duration: 115.366898ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:05.920316Z","caller":"traceutil/trace.go:171","msg":"trace[676454741] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"307.114749ms","start":"2026-06-28T19:52:05.613167Z","end":"2026-06-28T19:52:05.920282Z","steps":["trace[676454741] 'process raft request' (duration: 306.927655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:05.920527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:05.613125Z","time spent":"307.280722ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:06.069953Z","caller":"traceutil/trace.go:171","msg":"trace[353855515] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:735; }","duration":"209.891857ms","start":"2026-06-28T19:52:05.86003Z","end":"2026-06-28T19:52:06.069922Z","steps":["trace[353855515] 'read index received' (duration: 60.068672ms)","trace[353855515] 'applied index is now lower than readState.Index' (duration: 149.820515ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:06.070003Z","caller":"traceutil/trace.go:171","msg":"trace[71250118] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"286.257308ms","start":"2026-06-28T19:52:05.78371Z","end":"2026-06-28T19:52:06.069968Z","steps":["trace[71250118] 'process raft request' (duration: 285.607295ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.0701Z","caller":"traceutil/trace.go:171","msg":"trace[1513632574] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"209.370166ms","start":"2026-06-28T19:52:05.860641Z","end":"2026-06-28T19:52:06.070011Z","steps":["trace[1513632574] 'process raft request' (duration: 209.178252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:06.070237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.181223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6q5fn\" ","response":"range_response_count:1 size:17786"} {"level":"info","ts":"2026-06-28T19:52:06.070299Z","caller":"traceutil/trace.go:171","msg":"trace[1240831564] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6q5fn; range_end:; response_count:1; response_revision:712; }","duration":"210.293796ms","start":"2026-06-28T19:52:05.859988Z","end":"2026-06-28T19:52:06.070282Z","steps":["trace[1240831564] 'agreement among raft nodes before linearized reading' (duration: 210.04689ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.095601Z","caller":"traceutil/trace.go:171","msg":"trace[1529065318] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"163.854035ms","start":"2026-06-28T19:52:05.931718Z","end":"2026-06-28T19:52:06.095572Z","steps":["trace[1529065318] 'process raft request' (duration: 163.630441ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.095726Z","caller":"traceutil/trace.go:171","msg":"trace[1022649634] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"110.172391ms","start":"2026-06-28T19:52:05.985534Z","end":"2026-06-28T19:52:06.095707Z","steps":["trace[1022649634] 'process raft request' (duration: 109.980628ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.476972Z","caller":"traceutil/trace.go:171","msg":"trace[751939276] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"392.889487ms","start":"2026-06-28T19:52:06.084053Z","end":"2026-06-28T19:52:06.476943Z","steps":["trace[751939276] 'process raft request' (duration: 392.793035ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.476989Z","caller":"traceutil/trace.go:171","msg":"trace[1183744386] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"398.192013ms","start":"2026-06-28T19:52:06.07877Z","end":"2026-06-28T19:52:06.476962Z","steps":["trace[1183744386] 'process raft request' (duration: 397.5175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:06.477135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:06.084035Z","time spent":"393.017639ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18048,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:06.477138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:06.078697Z","time spent":"398.358585ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:06.596845Z","caller":"traceutil/trace.go:171","msg":"trace[188878848] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"380.938007ms","start":"2026-06-28T19:52:06.215837Z","end":"2026-06-28T19:52:06.596775Z","steps":["trace[188878848] 'process raft request' (duration: 380.59958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:06.597004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:06.215777Z","time spent":"381.159081ms","remote":"127.0.0.1:56880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:52:06.596845Z","caller":"traceutil/trace.go:171","msg":"trace[1758504065] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:740; }","duration":"152.078099ms","start":"2026-06-28T19:52:06.444743Z","end":"2026-06-28T19:52:06.596821Z","steps":["trace[1758504065] 'read index received' (duration: 31.553503ms)","trace[1758504065] 'applied index is now lower than readState.Index' (duration: 120.523616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:06.59709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.322334ms","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-06-28T19:52:06.597172Z","caller":"traceutil/trace.go:171","msg":"trace[161019721] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:718; }","duration":"152.450577ms","start":"2026-06-28T19:52:06.444707Z","end":"2026-06-28T19:52:06.597157Z","steps":["trace[161019721] 'agreement among raft nodes before linearized reading' (duration: 152.200162ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.597264Z","caller":"traceutil/trace.go:171","msg":"trace[1063652221] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"191.410518ms","start":"2026-06-28T19:52:06.405559Z","end":"2026-06-28T19:52:06.596969Z","steps":["trace[1063652221] 'process raft request' (duration: 191.128973ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.665589Z","caller":"traceutil/trace.go:171","msg":"trace[1403422072] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"177.962488ms","start":"2026-06-28T19:52:06.4876Z","end":"2026-06-28T19:52:06.665562Z","steps":["trace[1403422072] 'process raft request' (duration: 177.732294ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.665621Z","caller":"traceutil/trace.go:171","msg":"trace[684419275] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"174.03896ms","start":"2026-06-28T19:52:06.491557Z","end":"2026-06-28T19:52:06.665596Z","steps":["trace[684419275] 'process raft request' (duration: 173.922257ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.804997Z","caller":"traceutil/trace.go:171","msg":"trace[1979701931] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"110.631908ms","start":"2026-06-28T19:52:06.694342Z","end":"2026-06-28T19:52:06.804974Z","steps":["trace[1979701931] 'process raft request' (duration: 110.532346ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.872007Z","caller":"traceutil/trace.go:171","msg":"trace[1974384561] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"135.074268ms","start":"2026-06-28T19:52:06.736907Z","end":"2026-06-28T19:52:06.871982Z","steps":["trace[1974384561] 'process raft request' (duration: 134.504087ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:06.872118Z","caller":"traceutil/trace.go:171","msg":"trace[1995129027] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"141.610029ms","start":"2026-06-28T19:52:06.730481Z","end":"2026-06-28T19:52:06.872091Z","steps":["trace[1995129027] 'process raft request' (duration: 140.739762ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:16.408941Z","caller":"traceutil/trace.go:171","msg":"trace[262502627] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"406.659778ms","start":"2026-06-28T19:52:16.002269Z","end":"2026-06-28T19:52:16.408929Z","steps":["trace[262502627] 'process raft request' (duration: 402.134612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.002241Z","time spent":"406.80245ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:16.409179Z","caller":"traceutil/trace.go:171","msg":"trace[1208202254] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"406.666597ms","start":"2026-06-28T19:52:16.002502Z","end":"2026-06-28T19:52:16.409169Z","steps":["trace[1208202254] 'process raft request' (duration: 406.156897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.722672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.409389Z","caller":"traceutil/trace.go:171","msg":"trace[218572209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:800; }","duration":"387.013227ms","start":"2026-06-28T19:52:16.022315Z","end":"2026-06-28T19:52:16.409328Z","steps":["trace[218572209] 'agreement among raft nodes before linearized reading' (duration: 386.683211ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:16.408748Z","caller":"traceutil/trace.go:171","msg":"trace[1263607196] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:828; }","duration":"386.371625ms","start":"2026-06-28T19:52:16.022357Z","end":"2026-06-28T19:52:16.408729Z","steps":["trace[1263607196] 'read index received' (duration: 382.056564ms)","trace[1263607196] 'applied index is now lower than readState.Index' (duration: 4.314111ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:16.409477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.022296Z","time spent":"387.129909ms","remote":"127.0.0.1:53298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-06-28T19:52:16.409601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.781548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.409651Z","caller":"traceutil/trace.go:171","msg":"trace[334226450] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:800; }","duration":"323.8687ms","start":"2026-06-28T19:52:16.085773Z","end":"2026-06-28T19:52:16.409642Z","steps":["trace[334226450] 'agreement among raft nodes before linearized reading' (duration: 323.788748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.792136ms","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-06-28T19:52:16.409712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.123204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.409747Z","caller":"traceutil/trace.go:171","msg":"trace[461477397] 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:800; }","duration":"367.843426ms","start":"2026-06-28T19:52:16.041886Z","end":"2026-06-28T19:52:16.40973Z","steps":["trace[461477397] 'agreement among raft nodes before linearized reading' (duration: 367.787475ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:16.409759Z","caller":"traceutil/trace.go:171","msg":"trace[550813905] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:800; }","duration":"224.212285ms","start":"2026-06-28T19:52:16.185524Z","end":"2026-06-28T19:52:16.409737Z","steps":["trace[550813905] 'agreement among raft nodes before linearized reading' (duration: 224.162835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.041881Z","time spent":"367.894337ms","remote":"127.0.0.1:53312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-28T19:52:16.409803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.795979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.409906Z","caller":"traceutil/trace.go:171","msg":"trace[497876672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:800; }","duration":"281.9078ms","start":"2026-06-28T19:52:16.127989Z","end":"2026-06-28T19:52:16.409897Z","steps":["trace[497876672] 'agreement among raft nodes before linearized reading' (duration: 281.763828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.07512ms","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-06-28T19:52:16.409995Z","caller":"traceutil/trace.go:171","msg":"trace[1038371758] 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:800; }","duration":"368.146993ms","start":"2026-06-28T19:52:16.041839Z","end":"2026-06-28T19:52:16.409986Z","steps":["trace[1038371758] 'agreement among raft nodes before linearized reading' (duration: 368.096452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.410045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.221834ms","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":"warn","ts":"2026-06-28T19:52:16.410061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.529112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:52:16.41009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.228227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.410072Z","caller":"traceutil/trace.go:171","msg":"trace[1468325285] 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:800; }","duration":"368.249024ms","start":"2026-06-28T19:52:16.041816Z","end":"2026-06-28T19:52:16.410065Z","steps":["trace[1468325285] 'agreement among raft nodes before linearized reading' (duration: 368.211804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.410164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.809508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.410201Z","caller":"traceutil/trace.go:171","msg":"trace[1220743476] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:800; }","duration":"224.868499ms","start":"2026-06-28T19:52:16.185324Z","end":"2026-06-28T19:52:16.410193Z","steps":["trace[1220743476] 'agreement among raft nodes before linearized reading' (duration: 224.815798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.410297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.041755Z","time spent":"368.53015ms","remote":"127.0.0.1:53312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-28T19:52:16.409665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.615331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.412469Z","caller":"traceutil/trace.go:171","msg":"trace[2133439718] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:800; }","duration":"204.389203ms","start":"2026-06-28T19:52:16.20803Z","end":"2026-06-28T19:52:16.412419Z","steps":["trace[2133439718] 'agreement among raft nodes before linearized reading' (duration: 201.608611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.411118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.783483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.412949Z","caller":"traceutil/trace.go:171","msg":"trace[1838502879] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:800; }","duration":"204.689109ms","start":"2026-06-28T19:52:16.208249Z","end":"2026-06-28T19:52:16.412938Z","steps":["trace[1838502879] 'agreement among raft nodes before linearized reading' (duration: 201.377727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.085752Z","time spent":"323.944111ms","remote":"127.0.0.1:53326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:52:16.413621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.716283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.41374Z","caller":"traceutil/trace.go:171","msg":"trace[1746037658] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:800; }","duration":"285.877166ms","start":"2026-06-28T19:52:16.127837Z","end":"2026-06-28T19:52:16.413714Z","steps":["trace[1746037658] 'agreement among raft nodes before linearized reading' (duration: 282.203936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.40951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.063798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:52:16.410115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.653078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.413898Z","caller":"traceutil/trace.go:171","msg":"trace[166983177] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:800; }","duration":"391.451061ms","start":"2026-06-28T19:52:16.022392Z","end":"2026-06-28T19:52:16.413843Z","steps":["trace[166983177] 'agreement among raft nodes before linearized reading' (duration: 387.083779ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:16.413957Z","caller":"traceutil/trace.go:171","msg":"trace[1076277125] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:800; }","duration":"391.481951ms","start":"2026-06-28T19:52:16.022447Z","end":"2026-06-28T19:52:16.413929Z","steps":["trace[1076277125] 'agreement among raft nodes before linearized reading' (duration: 387.652819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.413967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.022389Z","time spent":"391.556843ms","remote":"127.0.0.1:53298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:52:16.414046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.022436Z","time spent":"391.570063ms","remote":"127.0.0.1:53298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-28T19:52:16.409463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.002497Z","time spent":"406.841591ms","remote":"127.0.0.1:57300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:16.414068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.152718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.414125Z","caller":"traceutil/trace.go:171","msg":"trace[1857500914] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:800; }","duration":"205.196178ms","start":"2026-06-28T19:52:16.208899Z","end":"2026-06-28T19:52:16.414096Z","steps":["trace[1857500914] 'agreement among raft nodes before linearized reading' (duration: 205.119317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.409606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.137147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:16.414648Z","caller":"traceutil/trace.go:171","msg":"trace[1386009314] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:800; }","duration":"286.183182ms","start":"2026-06-28T19:52:16.128449Z","end":"2026-06-28T19:52:16.414632Z","steps":["trace[1386009314] 'agreement among raft nodes before linearized reading' (duration: 281.109466ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:16.414655Z","caller":"traceutil/trace.go:171","msg":"trace[1871833956] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:800; }","duration":"324.341789ms","start":"2026-06-28T19:52:16.085809Z","end":"2026-06-28T19:52:16.410151Z","steps":["trace[1871833956] 'agreement among raft nodes before linearized reading' (duration: 324.240526ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:16.410114Z","caller":"traceutil/trace.go:171","msg":"trace[1355671246] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:800; }","duration":"224.591273ms","start":"2026-06-28T19:52:16.185512Z","end":"2026-06-28T19:52:16.410104Z","steps":["trace[1355671246] 'agreement among raft nodes before linearized reading' (duration: 224.516972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:16.41471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.085788Z","time spent":"328.905795ms","remote":"127.0.0.1:53326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-06-28T19:52:16.41122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:16.041834Z","time spent":"368.186914ms","remote":"127.0.0.1:53312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:52:18.837926Z","caller":"traceutil/trace.go:171","msg":"trace[202985734] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"104.199306ms","start":"2026-06-28T19:52:18.733648Z","end":"2026-06-28T19:52:18.837847Z","steps":["trace[202985734] 'process raft request' (duration: 103.945151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:19.45148Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862979,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:19.952296Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623862979,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:20.437532Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.595037818s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-28T19:52:20.810451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.465388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:20.810572Z","caller":"traceutil/trace.go:171","msg":"trace[1458087196] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"1.859941458s","start":"2026-06-28T19:52:18.95061Z","end":"2026-06-28T19:52:20.810552Z","steps":["trace[1458087196] 'read index received' (duration: 1.487045672s)","trace[1458087196] 'applied index is now lower than readState.Index' (duration: 372.894116ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:20.810995Z","caller":"traceutil/trace.go:171","msg":"trace[92216665] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"1.968603317s","start":"2026-06-28T19:52:18.842374Z","end":"2026-06-28T19:52:20.810977Z","steps":["trace[92216665] 'process raft request' (duration: 1.595469406s)","trace[92216665] 'compare' (duration: 372.052611ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:20.810999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.860383417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7jrbv\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-28T19:52:20.81105Z","caller":"traceutil/trace.go:171","msg":"trace[1247094752] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7jrbv; range_end:; response_count:1; response_revision:816; }","duration":"1.860466249s","start":"2026-06-28T19:52:18.950569Z","end":"2026-06-28T19:52:20.811035Z","steps":["trace[1247094752] 'agreement among raft nodes before linearized reading' (duration: 1.860239085s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.811069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:18.842345Z","time spent":"1.968689639s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:20.811033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.968362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-28T19:52:20.811085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:18.950554Z","time spent":"1.86052243s","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7jrbv\" "} {"level":"warn","ts":"2026-06-28T19:52:20.81102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.401825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:52:20.81124Z","caller":"traceutil/trace.go:171","msg":"trace[1801246841] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:816; }","duration":"221.691819ms","start":"2026-06-28T19:52:20.589535Z","end":"2026-06-28T19:52:20.811227Z","steps":["trace[1801246841] 'agreement among raft nodes before linearized reading' (duration: 221.393434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.811234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.445106291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:52:20.81136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.586312969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-28T19:52:20.811391Z","caller":"traceutil/trace.go:171","msg":"trace[1109838924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"1.58636144s","start":"2026-06-28T19:52:19.22502Z","end":"2026-06-28T19:52:20.811382Z","steps":["trace[1109838924] 'agreement among raft nodes before linearized reading' (duration: 1.586282159s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.811423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:19.225009Z","time spent":"1.586406611s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-28T19:52:20.811493Z","caller":"traceutil/trace.go:171","msg":"trace[1734484872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"1.445313864s","start":"2026-06-28T19:52:19.366036Z","end":"2026-06-28T19:52:20.81135Z","steps":["trace[1734484872] 'agreement among raft nodes before linearized reading' (duration: 1.445012019s)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:20.811137Z","caller":"traceutil/trace.go:171","msg":"trace[1010199540] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:816; }","duration":"297.134904ms","start":"2026-06-28T19:52:20.513978Z","end":"2026-06-28T19:52:20.811113Z","steps":["trace[1010199540] 'agreement among raft nodes before linearized reading' (duration: 296.821409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.81157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.591369122s","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-06-28T19:52:20.811621Z","caller":"traceutil/trace.go:171","msg":"trace[724726444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"1.591469095s","start":"2026-06-28T19:52:19.22014Z","end":"2026-06-28T19:52:20.811609Z","steps":["trace[724726444] 'agreement among raft nodes before linearized reading' (duration: 1.591348773s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.811668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:19.220109Z","time spent":"1.591550396s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-28T19:52:20.811254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.440221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:52:20.811783Z","caller":"traceutil/trace.go:171","msg":"trace[2130505897] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:816; }","duration":"792.008131ms","start":"2026-06-28T19:52:20.019762Z","end":"2026-06-28T19:52:20.81177Z","steps":["trace[2130505897] 'agreement among raft nodes before linearized reading' (duration: 791.458091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.811776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:19.366018Z","time spent":"1.445555469s","remote":"127.0.0.1:56856","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-06-28T19:52:20.811827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:20.019738Z","time spent":"792.074112ms","remote":"127.0.0.1:57324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:52:20.813117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.592975102s","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-06-28T19:52:20.813178Z","caller":"traceutil/trace.go:171","msg":"trace[1261411330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:816; }","duration":"1.593089744s","start":"2026-06-28T19:52:19.220073Z","end":"2026-06-28T19:52:20.813163Z","steps":["trace[1261411330] 'agreement among raft nodes before linearized reading' (duration: 1.590703521s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:20.81321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:19.220055Z","time spent":"1.593147545s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:52:29.08092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.4601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:29.081134Z","caller":"traceutil/trace.go:171","msg":"trace[1903036144] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"203.073697ms","start":"2026-06-28T19:52:28.878027Z","end":"2026-06-28T19:52:29.081101Z","steps":["trace[1903036144] 'process raft request' (duration: 22.327362ms)","trace[1903036144] 'compare' (duration: 180.299197ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:29.081157Z","caller":"traceutil/trace.go:171","msg":"trace[162046204] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:940; }","duration":"193.182062ms","start":"2026-06-28T19:52:28.887954Z","end":"2026-06-28T19:52:29.081136Z","steps":["trace[162046204] 'read index received' (duration: 12.431068ms)","trace[162046204] 'applied index is now lower than readState.Index' (duration: 180.749404ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:29.08131Z","caller":"traceutil/trace.go:171","msg":"trace[1191906009] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"200.004361ms","start":"2026-06-28T19:52:28.88129Z","end":"2026-06-28T19:52:29.081294Z","steps":["trace[1191906009] 'process raft request' (duration: 199.767367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:29.081432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.241097ms","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-06-28T19:52:29.081475Z","caller":"traceutil/trace.go:171","msg":"trace[1809441160] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:909; }","duration":"192.324838ms","start":"2026-06-28T19:52:28.889139Z","end":"2026-06-28T19:52:29.081464Z","steps":["trace[1809441160] 'agreement among raft nodes before linearized reading' (duration: 192.168925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:29.081496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.5343ms","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-06-28T19:52:29.081564Z","caller":"traceutil/trace.go:171","msg":"trace[5557484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:909; }","duration":"193.635911ms","start":"2026-06-28T19:52:28.887911Z","end":"2026-06-28T19:52:29.081547Z","steps":["trace[5557484] 'agreement among raft nodes before linearized reading' (duration: 193.455118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.340297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.180772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:31.340385Z","caller":"traceutil/trace.go:171","msg":"trace[1578888710] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:937; }","duration":"387.301904ms","start":"2026-06-28T19:52:30.953062Z","end":"2026-06-28T19:52:31.340364Z","steps":["trace[1578888710] 'count revisions from in-memory index tree' (duration: 386.987739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.340435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:30.953009Z","time spent":"387.413746ms","remote":"127.0.0.1:57078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:52:31.340796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.155837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-28T19:52:31.340826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.459819ms","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-06-28T19:52:31.34088Z","caller":"traceutil/trace.go:171","msg":"trace[1446709590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:937; }","duration":"255.305139ms","start":"2026-06-28T19:52:31.085556Z","end":"2026-06-28T19:52:31.340861Z","steps":["trace[1446709590] 'range keys from in-memory index tree' (duration: 254.956033ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:31.340915Z","caller":"traceutil/trace.go:171","msg":"trace[1593484502] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:937; }","duration":"194.628302ms","start":"2026-06-28T19:52:31.146267Z","end":"2026-06-28T19:52:31.340895Z","steps":["trace[1593484502] 'range keys from in-memory index tree' (duration: 194.196265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.340924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.80126ms","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-06-28T19:52:31.340796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.278943ms","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-06-28T19:52:31.340982Z","caller":"traceutil/trace.go:171","msg":"trace[103540470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:937; }","duration":"254.866432ms","start":"2026-06-28T19:52:31.086096Z","end":"2026-06-28T19:52:31.340962Z","steps":["trace[103540470] 'range keys from in-memory index tree' (duration: 254.693499ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:31.341019Z","caller":"traceutil/trace.go:171","msg":"trace[2141767658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:937; }","duration":"243.551786ms","start":"2026-06-28T19:52:31.097426Z","end":"2026-06-28T19:52:31.340978Z","steps":["trace[2141767658] 'range keys from in-memory index tree' (duration: 242.801864ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:31.560383Z","caller":"traceutil/trace.go:171","msg":"trace[2077987984] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"393.297773ms","start":"2026-06-28T19:52:31.167062Z","end":"2026-06-28T19:52:31.560359Z","steps":["trace[2077987984] 'process raft request' (duration: 393.133041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.56053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:31.167031Z","time spent":"393.421625ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:31.701636Z","caller":"traceutil/trace.go:171","msg":"trace[1387208334] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"356.241422ms","start":"2026-06-28T19:52:31.345359Z","end":"2026-06-28T19:52:31.701601Z","steps":["trace[1387208334] 'process raft request' (duration: 327.335882ms)","trace[1387208334] 'compare' (duration: 28.634905ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:31.701682Z","caller":"traceutil/trace.go:171","msg":"trace[106819889] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:971; }","duration":"339.202568ms","start":"2026-06-28T19:52:31.36245Z","end":"2026-06-28T19:52:31.701653Z","steps":["trace[106819889] 'read index received' (duration: 197.842516ms)","trace[106819889] 'applied index is now lower than readState.Index' (duration: 141.358672ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:31.70193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.480243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:31.701912Z","caller":"traceutil/trace.go:171","msg":"trace[132304969] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"355.555151ms","start":"2026-06-28T19:52:31.346283Z","end":"2026-06-28T19:52:31.701839Z","steps":["trace[132304969] 'process raft request' (duration: 355.313487ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:31.701977Z","caller":"traceutil/trace.go:171","msg":"trace[1673634608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"339.563674ms","start":"2026-06-28T19:52:31.362404Z","end":"2026-06-28T19:52:31.701967Z","steps":["trace[1673634608] 'agreement among raft nodes before linearized reading' (duration: 339.456382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.702009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:31.362391Z","time spent":"339.611775ms","remote":"127.0.0.1:56856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-28T19:52:31.701771Z","caller":"traceutil/trace.go:171","msg":"trace[892885417] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"356.296073ms","start":"2026-06-28T19:52:31.345457Z","end":"2026-06-28T19:52:31.701753Z","steps":["trace[892885417] 'process raft request' (duration: 356.09609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.70211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:31.346272Z","time spent":"355.720593ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:31.701796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:31.345334Z","time spent":"356.377145ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:31.702143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:31.345428Z","time spent":"356.627978ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:31.702162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.394604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:31.70182Z","caller":"traceutil/trace.go:171","msg":"trace[851544287] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"356.382534ms","start":"2026-06-28T19:52:31.345429Z","end":"2026-06-28T19:52:31.701812Z","steps":["trace[851544287] 'process raft request' (duration: 356.080079ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:31.702241Z","caller":"traceutil/trace.go:171","msg":"trace[868608104] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:942; }","duration":"155.525276ms","start":"2026-06-28T19:52:31.546695Z","end":"2026-06-28T19:52:31.70222Z","steps":["trace[868608104] 'agreement among raft nodes before linearized reading' (duration: 155.391914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:31.702305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:31.345404Z","time spent":"356.868112ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:31.895848Z","caller":"traceutil/trace.go:171","msg":"trace[1917624675] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"105.537494ms","start":"2026-06-28T19:52:31.790288Z","end":"2026-06-28T19:52:31.895825Z","steps":["trace[1917624675] 'process raft request' (duration: 95.045392ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:32.056953Z","caller":"traceutil/trace.go:171","msg":"trace[1747147464] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"141.683113ms","start":"2026-06-28T19:52:31.915253Z","end":"2026-06-28T19:52:32.056936Z","steps":["trace[1747147464] 'process raft request' (duration: 140.153806ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:32.251213Z","caller":"traceutil/trace.go:171","msg":"trace[1545835078] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"108.507924ms","start":"2026-06-28T19:52:32.142668Z","end":"2026-06-28T19:52:32.251176Z","steps":["trace[1545835078] 'process raft request' (duration: 22.71861ms)","trace[1545835078] 'compare' (duration: 85.632181ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:32.37948Z","caller":"traceutil/trace.go:171","msg":"trace[401172252] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"122.381322ms","start":"2026-06-28T19:52:32.257051Z","end":"2026-06-28T19:52:32.379432Z","steps":["trace[401172252] 'process raft request' (duration: 121.159801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:32.898025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.348041ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:32.898165Z","caller":"traceutil/trace.go:171","msg":"trace[1004930789] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:962; }","duration":"133.510585ms","start":"2026-06-28T19:52:32.764633Z","end":"2026-06-28T19:52:32.898144Z","steps":["trace[1004930789] 'range keys from in-memory index tree' (duration: 133.28359ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:32.898409Z","caller":"traceutil/trace.go:171","msg":"trace[1266611000] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"423.590129ms","start":"2026-06-28T19:52:32.474796Z","end":"2026-06-28T19:52:32.898387Z","steps":["trace[1266611000] 'read index received' (duration: 344.774644ms)","trace[1266611000] 'applied index is now lower than readState.Index' (duration: 78.814105ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:32.898711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.581555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12751"} {"level":"info","ts":"2026-06-28T19:52:32.899107Z","caller":"traceutil/trace.go:171","msg":"trace[1348560032] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:963; }","duration":"450.016842ms","start":"2026-06-28T19:52:32.449074Z","end":"2026-06-28T19:52:32.899091Z","steps":["trace[1348560032] 'agreement among raft nodes before linearized reading' (duration: 449.412192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:32.898746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.873118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3696"} {"level":"info","ts":"2026-06-28T19:52:32.89919Z","caller":"traceutil/trace.go:171","msg":"trace[1372850323] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:963; }","duration":"436.346757ms","start":"2026-06-28T19:52:32.462828Z","end":"2026-06-28T19:52:32.899175Z","steps":["trace[1372850323] 'agreement among raft nodes before linearized reading' (duration: 435.624375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:32.899239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:32.462821Z","time spent":"436.404048ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":3719,"request content":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-06-28T19:52:32.899212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:32.449061Z","time spent":"450.132063ms","remote":"127.0.0.1:56924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12774,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"info","ts":"2026-06-28T19:52:32.898781Z","caller":"traceutil/trace.go:171","msg":"trace[152845003] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"435.607784ms","start":"2026-06-28T19:52:32.462831Z","end":"2026-06-28T19:52:32.898439Z","steps":["trace[152845003] 'process raft request' (duration: 356.648407ms)","trace[152845003] 'compare' (duration: 78.496038ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:32.899526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:32.462814Z","time spent":"436.639972ms","remote":"127.0.0.1:57300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3249,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:33.048966Z","caller":"traceutil/trace.go:171","msg":"trace[1297288200] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"149.924912ms","start":"2026-06-28T19:52:32.89902Z","end":"2026-06-28T19:52:33.048945Z","steps":["trace[1297288200] 'read index received' (duration: 112.186057ms)","trace[1297288200] 'applied index is now lower than readState.Index' (duration: 37.737925ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:33.049124Z","caller":"traceutil/trace.go:171","msg":"trace[1329609907] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"567.058919ms","start":"2026-06-28T19:52:32.481992Z","end":"2026-06-28T19:52:33.049051Z","steps":["trace[1329609907] 'process raft request' (duration: 529.198191ms)","trace[1329609907] 'compare' (duration: 37.647814ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:33.049171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.39162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-06-28T19:52:33.049206Z","caller":"traceutil/trace.go:171","msg":"trace[1950327942] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:964; }","duration":"359.449491ms","start":"2026-06-28T19:52:32.689746Z","end":"2026-06-28T19:52:33.049195Z","steps":["trace[1950327942] 'agreement among raft nodes before linearized reading' (duration: 359.295048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:33.049244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:32.689683Z","time spent":"359.553743ms","remote":"127.0.0.1:57034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-06-28T19:52:33.049287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:32.481974Z","time spent":"567.227492ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3595,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:33.049563Z","caller":"traceutil/trace.go:171","msg":"trace[731975335] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"142.583006ms","start":"2026-06-28T19:52:32.906962Z","end":"2026-06-28T19:52:33.049545Z","steps":["trace[731975335] 'process raft request' (duration: 142.395393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:33.049618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.632807ms","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-06-28T19:52:33.04968Z","caller":"traceutil/trace.go:171","msg":"trace[1348835027] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:965; }","duration":"135.722588ms","start":"2026-06-28T19:52:32.913944Z","end":"2026-06-28T19:52:33.049666Z","steps":["trace[1348835027] 'agreement among raft nodes before linearized reading' (duration: 135.530585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:33.99684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.432999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:33.996952Z","caller":"traceutil/trace.go:171","msg":"trace[862372182] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"387.874409ms","start":"2026-06-28T19:52:33.609056Z","end":"2026-06-28T19:52:33.99693Z","steps":["trace[862372182] 'process raft request' (duration: 216.277907ms)","trace[862372182] 'compare' (duration: 171.273857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:33.997014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:33.609037Z","time spent":"387.954751ms","remote":"127.0.0.1:56498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2492,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-28T19:52:34.002358Z","caller":"traceutil/trace.go:171","msg":"trace[1065060730] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1003; }","duration":"296.02818ms","start":"2026-06-28T19:52:33.706311Z","end":"2026-06-28T19:52:34.002339Z","steps":["trace[1065060730] 'read index received' (duration: 119.103366ms)","trace[1065060730] 'applied index is now lower than readState.Index' (duration: 176.923984ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:34.002453Z","caller":"traceutil/trace.go:171","msg":"trace[1610822333] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"326.43092ms","start":"2026-06-28T19:52:33.676015Z","end":"2026-06-28T19:52:34.002446Z","steps":["trace[1610822333] 'process raft request' (duration: 326.250387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:34.002526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:33.675972Z","time spent":"326.51972ms","remote":"127.0.0.1:56906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-28T19:52:34.002851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.535129ms","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-06-28T19:52:34.002893Z","caller":"traceutil/trace.go:171","msg":"trace[704727695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:971; }","duration":"296.61797ms","start":"2026-06-28T19:52:33.706268Z","end":"2026-06-28T19:52:34.002886Z","steps":["trace[704727695] 'agreement among raft nodes before linearized reading' (duration: 296.424186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:34.003128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.631791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-28T19:52:34.003151Z","caller":"traceutil/trace.go:171","msg":"trace[650340324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:971; }","duration":"296.670961ms","start":"2026-06-28T19:52:33.706473Z","end":"2026-06-28T19:52:34.003144Z","steps":["trace[650340324] 'agreement among raft nodes before linearized reading' (duration: 296.571119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:34.003638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.828434ms","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-06-28T19:52:34.003674Z","caller":"traceutil/trace.go:171","msg":"trace[118950033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"296.904915ms","start":"2026-06-28T19:52:33.706762Z","end":"2026-06-28T19:52:34.003667Z","steps":["trace[118950033] 'agreement among raft nodes before linearized reading' (duration: 296.797853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:34.003973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.037857ms","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-06-28T19:52:34.003999Z","caller":"traceutil/trace.go:171","msg":"trace[1432960372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"297.107248ms","start":"2026-06-28T19:52:33.706886Z","end":"2026-06-28T19:52:34.003993Z","steps":["trace[1432960372] 'agreement among raft nodes before linearized reading' (duration: 296.501638ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:34.174474Z","caller":"traceutil/trace.go:171","msg":"trace[795190731] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"166.478791ms","start":"2026-06-28T19:52:34.007975Z","end":"2026-06-28T19:52:34.174454Z","steps":["trace[795190731] 'process raft request' (duration: 166.384419ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:34.174472Z","caller":"traceutil/trace.go:171","msg":"trace[613608251] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"166.628584ms","start":"2026-06-28T19:52:34.007816Z","end":"2026-06-28T19:52:34.174445Z","steps":["trace[613608251] 'process raft request' (duration: 116.672984ms)","trace[613608251] 'compare' (duration: 49.727476ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:34.174638Z","caller":"traceutil/trace.go:171","msg":"trace[1359084032] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"166.618614ms","start":"2026-06-28T19:52:34.008009Z","end":"2026-06-28T19:52:34.174628Z","steps":["trace[1359084032] 'process raft request' (duration: 166.40211ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:34.174815Z","caller":"traceutil/trace.go:171","msg":"trace[1718432825] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"166.399719ms","start":"2026-06-28T19:52:34.008396Z","end":"2026-06-28T19:52:34.174796Z","steps":["trace[1718432825] 'process raft request' (duration: 166.159575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:35.18658Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623863263,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:52:35.565157Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.148818988s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:52:35.565564Z","caller":"traceutil/trace.go:171","msg":"trace[2013695855] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"879.434467ms","start":"2026-06-28T19:52:34.686101Z","end":"2026-06-28T19:52:35.565535Z","steps":["trace[2013695855] 'read index received' (duration: 879.342295ms)","trace[2013695855] 'applied index is now lower than readState.Index' (duration: 91.052µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:35.56576Z","caller":"traceutil/trace.go:171","msg":"trace[257602541] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"1.149417348s","start":"2026-06-28T19:52:34.416232Z","end":"2026-06-28T19:52:35.565649Z","steps":["trace[257602541] 'process raft request' (duration: 1.149104663s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:35.56582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.685601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:52:35.565916Z","caller":"traceutil/trace.go:171","msg":"trace[843708024] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:976; }","duration":"879.797892ms","start":"2026-06-28T19:52:34.686059Z","end":"2026-06-28T19:52:35.565857Z","steps":["trace[843708024] 'agreement among raft nodes before linearized reading' (duration: 879.581769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:35.565971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:34.686041Z","time spent":"879.912855ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:52:35.565989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:34.416207Z","time spent":"1.149607891s","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:35.721253Z","caller":"traceutil/trace.go:171","msg":"trace[26028930] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"499.749966ms","start":"2026-06-28T19:52:35.221459Z","end":"2026-06-28T19:52:35.721209Z","steps":["trace[26028930] 'process raft request' (duration: 424.561243ms)","trace[26028930] 'compare' (duration: 74.939089ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:35.721351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.065881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:52:35.721419Z","caller":"traceutil/trace.go:171","msg":"trace[623454783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"357.184244ms","start":"2026-06-28T19:52:35.364219Z","end":"2026-06-28T19:52:35.721403Z","steps":["trace[623454783] 'agreement among raft nodes before linearized reading' (duration: 357.008651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:35.721456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:35.364201Z","time spent":"357.247675ms","remote":"127.0.0.1:56856","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-06-28T19:52:35.721456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:35.221422Z","time spent":"499.934599ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:35.721622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.936396ms","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-06-28T19:52:35.721729Z","caller":"traceutil/trace.go:171","msg":"trace[2105448154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"657.122928ms","start":"2026-06-28T19:52:35.064582Z","end":"2026-06-28T19:52:35.721705Z","steps":["trace[2105448154] 'agreement among raft nodes before linearized reading' (duration: 656.810593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:35.721788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:35.064555Z","time spent":"657.22312ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-28T19:52:35.722475Z","caller":"traceutil/trace.go:171","msg":"trace[1415860595] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"156.842884ms","start":"2026-06-28T19:52:35.565615Z","end":"2026-06-28T19:52:35.722458Z","steps":["trace[1415860595] 'read index received' (duration: 80.497232ms)","trace[1415860595] 'applied index is now lower than readState.Index' (duration: 75.06004ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:35.725422Z","caller":"traceutil/trace.go:171","msg":"trace[1289054364] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"151.902171ms","start":"2026-06-28T19:52:35.573494Z","end":"2026-06-28T19:52:35.725397Z","steps":["trace[1289054364] 'process raft request' (duration: 151.695777ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:35.725701Z","caller":"traceutil/trace.go:171","msg":"trace[81371151] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"148.418871ms","start":"2026-06-28T19:52:35.577265Z","end":"2026-06-28T19:52:35.725684Z","steps":["trace[81371151] 'process raft request' (duration: 148.136257ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:35.725764Z","caller":"traceutil/trace.go:171","msg":"trace[835394505] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"149.550531ms","start":"2026-06-28T19:52:35.576182Z","end":"2026-06-28T19:52:35.725733Z","steps":["trace[835394505] 'process raft request' (duration: 149.110204ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:35.725803Z","caller":"traceutil/trace.go:171","msg":"trace[1059843888] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"117.785683ms","start":"2026-06-28T19:52:35.607992Z","end":"2026-06-28T19:52:35.725777Z","steps":["trace[1059843888] 'process raft request' (duration: 117.447097ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:46.164512Z","caller":"traceutil/trace.go:171","msg":"trace[1849042387] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"130.375234ms","start":"2026-06-28T19:52:46.034112Z","end":"2026-06-28T19:52:46.164487Z","steps":["trace[1849042387] 'process raft request' (duration: 130.237032ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:46.414332Z","caller":"traceutil/trace.go:171","msg":"trace[845738438] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"121.959239ms","start":"2026-06-28T19:52:46.292346Z","end":"2026-06-28T19:52:46.414305Z","steps":["trace[845738438] 'process raft request' (duration: 109.458107ms)","trace[845738438] 'compare' (duration: 12.337329ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:46.414698Z","caller":"traceutil/trace.go:171","msg":"trace[67445076] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"121.622783ms","start":"2026-06-28T19:52:46.293057Z","end":"2026-06-28T19:52:46.41468Z","steps":["trace[67445076] 'process raft request' (duration: 121.203827ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:46.414719Z","caller":"traceutil/trace.go:171","msg":"trace[693063935] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"120.868111ms","start":"2026-06-28T19:52:46.29384Z","end":"2026-06-28T19:52:46.414708Z","steps":["trace[693063935] 'process raft request' (duration: 120.646017ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:48.006066Z","caller":"traceutil/trace.go:171","msg":"trace[1743727555] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"123.409853ms","start":"2026-06-28T19:52:47.882619Z","end":"2026-06-28T19:52:48.006029Z","steps":["trace[1743727555] 'process raft request' (duration: 123.093358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:48.457451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.193175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:48.458229Z","caller":"traceutil/trace.go:171","msg":"trace[670078623] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"448.49439ms","start":"2026-06-28T19:52:48.009714Z","end":"2026-06-28T19:52:48.458208Z","steps":["trace[670078623] 'process raft request' (duration: 320.459111ms)","trace[670078623] 'compare' (duration: 127.011682ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:52:48.458443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.680007ms","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-06-28T19:52:48.458522Z","caller":"traceutil/trace.go:171","msg":"trace[1818937807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1035; }","duration":"138.80669ms","start":"2026-06-28T19:52:48.319697Z","end":"2026-06-28T19:52:48.458504Z","steps":["trace[1818937807] 'agreement among raft nodes before linearized reading' (duration: 138.579456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:48.458492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:48.009687Z","time spent":"448.759554ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:48.459085Z","caller":"traceutil/trace.go:171","msg":"trace[364810857] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"138.420133ms","start":"2026-06-28T19:52:48.319749Z","end":"2026-06-28T19:52:48.45817Z","steps":["trace[364810857] 'read index received' (duration: 10.345094ms)","trace[364810857] 'applied index is now lower than readState.Index' (duration: 128.071169ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:48.803697Z","caller":"traceutil/trace.go:171","msg":"trace[474061006] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"338.493469ms","start":"2026-06-28T19:52:48.465176Z","end":"2026-06-28T19:52:48.803669Z","steps":["trace[474061006] 'process raft request' (duration: 275.20412ms)","trace[474061006] 'compare' (duration: 63.117615ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:48.803944Z","caller":"traceutil/trace.go:171","msg":"trace[1500322208] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"338.497869ms","start":"2026-06-28T19:52:48.465407Z","end":"2026-06-28T19:52:48.803905Z","steps":["trace[1500322208] 'process raft request' (duration: 338.221875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:48.804003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:48.465149Z","time spent":"338.62257ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:52:48.804094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:48.465398Z","time spent":"338.613701ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:48.804249Z","caller":"traceutil/trace.go:171","msg":"trace[86003365] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"338.193164ms","start":"2026-06-28T19:52:48.466025Z","end":"2026-06-28T19:52:48.804218Z","steps":["trace[86003365] 'process raft request' (duration: 337.803568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:48.804378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:52:48.466018Z","time spent":"338.289985ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:52:52.969329Z","caller":"traceutil/trace.go:171","msg":"trace[2042612601] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"101.6141ms","start":"2026-06-28T19:52:52.867694Z","end":"2026-06-28T19:52:52.969309Z","steps":["trace[2042612601] 'process raft request' (duration: 81.148429ms)","trace[2042612601] 'compare' (duration: 20.36657ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:52:56.401674Z","caller":"traceutil/trace.go:171","msg":"trace[73026233] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"132.625583ms","start":"2026-06-28T19:52:56.269017Z","end":"2026-06-28T19:52:56.401642Z","steps":["trace[73026233] 'process raft request' (duration: 132.411349ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:10.791145Z","caller":"traceutil/trace.go:171","msg":"trace[1644085046] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1153; }","duration":"164.179522ms","start":"2026-06-28T19:53:10.626935Z","end":"2026-06-28T19:53:10.791114Z","steps":["trace[1644085046] 'read index received' (duration: 97.301724ms)","trace[1644085046] 'applied index is now lower than readState.Index' (duration: 66.876268ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:53:10.791231Z","caller":"traceutil/trace.go:171","msg":"trace[1389846725] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"230.202498ms","start":"2026-06-28T19:53:10.560967Z","end":"2026-06-28T19:53:10.791169Z","steps":["trace[1389846725] 'process raft request' (duration: 163.36498ms)","trace[1389846725] 'compare' (duration: 66.600034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:53:10.791546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.242409ms","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":"warn","ts":"2026-06-28T19:53:10.791538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.576068ms","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-06-28T19:53:10.791604Z","caller":"traceutil/trace.go:171","msg":"trace[1296843976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1111; }","duration":"148.37037ms","start":"2026-06-28T19:53:10.643218Z","end":"2026-06-28T19:53:10.791588Z","steps":["trace[1296843976] 'agreement among raft nodes before linearized reading' (duration: 148.082646ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:10.791638Z","caller":"traceutil/trace.go:171","msg":"trace[261335904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1111; }","duration":"164.72251ms","start":"2026-06-28T19:53:10.626883Z","end":"2026-06-28T19:53:10.791606Z","steps":["trace[261335904] 'agreement among raft nodes before linearized reading' (duration: 164.369726ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:53:10.99557Z","caller":"traceutil/trace.go:171","msg":"trace[1652442999] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"199.292655ms","start":"2026-06-28T19:53:10.796251Z","end":"2026-06-28T19:53:10.995543Z","steps":["trace[1652442999] 'process raft request' (duration: 167.993548ms)","trace[1652442999] 'compare' (duration: 31.164705ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:53:10.997306Z","caller":"traceutil/trace.go:171","msg":"trace[146187809] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1154; }","duration":"200.668416ms","start":"2026-06-28T19:53:10.796611Z","end":"2026-06-28T19:53:10.99728Z","steps":["trace[146187809] 'read index received' (duration: 167.761415ms)","trace[146187809] 'applied index is now lower than readState.Index' (duration: 32.905361ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:53:10.997422Z","caller":"traceutil/trace.go:171","msg":"trace[62494883] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"200.857869ms","start":"2026-06-28T19:53:10.796541Z","end":"2026-06-28T19:53:10.997399Z","steps":["trace[62494883] 'process raft request' (duration: 200.577115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:10.997525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.894959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-28T19:53:10.997707Z","caller":"traceutil/trace.go:171","msg":"trace[1590848974] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1113; }","duration":"201.122203ms","start":"2026-06-28T19:53:10.79656Z","end":"2026-06-28T19:53:10.997682Z","steps":["trace[1590848974] 'agreement among raft nodes before linearized reading' (duration: 200.87623ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:54:15.66419Z","caller":"traceutil/trace.go:171","msg":"trace[1745628726] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"176.238447ms","start":"2026-06-28T19:54:15.487928Z","end":"2026-06-28T19:54:15.664166Z","steps":["trace[1745628726] 'read index received' (duration: 176.089025ms)","trace[1745628726] 'applied index is now lower than readState.Index' (duration: 148.352µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:54:15.664256Z","caller":"traceutil/trace.go:171","msg":"trace[1294228436] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"248.346287ms","start":"2026-06-28T19:54:15.415878Z","end":"2026-06-28T19:54:15.664224Z","steps":["trace[1294228436] 'process raft request' (duration: 248.097964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:15.664465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.51583ms","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-06-28T19:54:15.664532Z","caller":"traceutil/trace.go:171","msg":"trace[871609522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1361; }","duration":"176.632851ms","start":"2026-06-28T19:54:15.487884Z","end":"2026-06-28T19:54:15.664517Z","steps":["trace[871609522] 'agreement among raft nodes before linearized reading' (duration: 176.409838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.018773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.599463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:54:16.018971Z","caller":"traceutil/trace.go:171","msg":"trace[1175674561] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"348.640995ms","start":"2026-06-28T19:54:15.670309Z","end":"2026-06-28T19:54:16.01895Z","steps":["trace[1175674561] 'process raft request' (duration: 348.579924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.019052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.670282Z","time spent":"348.729446ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:54:16.019185Z","caller":"traceutil/trace.go:171","msg":"trace[1814937895] linearizableReadLoop","detail":"{readStateIndex:1418; appliedIndex:1417; }","duration":"354.881524ms","start":"2026-06-28T19:54:15.664279Z","end":"2026-06-28T19:54:16.01916Z","steps":["trace[1814937895] 'read index received' (duration: 85.892926ms)","trace[1814937895] 'applied index is now lower than readState.Index' (duration: 268.986168ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:54:16.019326Z","caller":"traceutil/trace.go:171","msg":"trace[1337733331] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"454.437971ms","start":"2026-06-28T19:54:15.56487Z","end":"2026-06-28T19:54:16.019308Z","steps":["trace[1337733331] 'process raft request' (duration: 185.20438ms)","trace[1337733331] 'compare' (duration: 268.033646ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:54:16.019429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.564836Z","time spent":"454.521843ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:54:16.019629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.899779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-28T19:54:16.019652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.176969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:54:16.019684Z","caller":"traceutil/trace.go:171","msg":"trace[1499418270] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1363; }","duration":"432.9811ms","start":"2026-06-28T19:54:15.586688Z","end":"2026-06-28T19:54:16.019669Z","steps":["trace[1499418270] 'agreement among raft nodes before linearized reading' (duration: 432.885128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.019725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.586676Z","time spent":"433.038391ms","remote":"127.0.0.1:57188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-06-28T19:54:16.019722Z","caller":"traceutil/trace.go:171","msg":"trace[637362479] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1363; }","duration":"462.30149ms","start":"2026-06-28T19:54:15.557403Z","end":"2026-06-28T19:54:16.019705Z","steps":["trace[637362479] 'agreement among raft nodes before linearized reading' (duration: 462.197719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.019771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.557382Z","time spent":"462.381402ms","remote":"127.0.0.1:56978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-06-28T19:54:16.020286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.078619ms","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-06-28T19:54:16.020349Z","caller":"traceutil/trace.go:171","msg":"trace[377560143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1363; }","duration":"500.19281ms","start":"2026-06-28T19:54:15.520143Z","end":"2026-06-28T19:54:16.020324Z","steps":["trace[377560143] 'agreement among raft nodes before linearized reading' (duration: 499.40073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.02039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.520116Z","time spent":"500.266471ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:54:16.02043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.252711ms","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-06-28T19:54:16.020483Z","caller":"traceutil/trace.go:171","msg":"trace[827218826] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1363; }","duration":"523.328522ms","start":"2026-06-28T19:54:15.497142Z","end":"2026-06-28T19:54:16.020471Z","steps":["trace[827218826] 'agreement among raft nodes before linearized reading' (duration: 522.489671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.020516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.49713Z","time spent":"523.378683ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-28T19:54:16.02068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.663111ms","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-06-28T19:54:16.020719Z","caller":"traceutil/trace.go:171","msg":"trace[232011542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1363; }","duration":"525.725503ms","start":"2026-06-28T19:54:15.494984Z","end":"2026-06-28T19:54:16.02071Z","steps":["trace[232011542] 'agreement among raft nodes before linearized reading' (duration: 524.680829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.02075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:15.494973Z","time spent":"525.768403ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-28T19:54:16.141216Z","caller":"traceutil/trace.go:171","msg":"trace[1816568077] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1419; }","duration":"121.929558ms","start":"2026-06-28T19:54:16.019268Z","end":"2026-06-28T19:54:16.141198Z","steps":["trace[1816568077] 'read index received' (duration: 65.448706ms)","trace[1816568077] 'applied index is now lower than readState.Index' (duration: 56.479262ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:54:16.141329Z","caller":"traceutil/trace.go:171","msg":"trace[131047937] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"115.797151ms","start":"2026-06-28T19:54:16.025504Z","end":"2026-06-28T19:54:16.141301Z","steps":["trace[131047937] 'process raft request' (duration: 115.751801ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:54:16.141381Z","caller":"traceutil/trace.go:171","msg":"trace[1408747895] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"116.50877ms","start":"2026-06-28T19:54:16.024851Z","end":"2026-06-28T19:54:16.14136Z","steps":["trace[1408747895] 'process raft request' (duration: 116.210896ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:54:16.141416Z","caller":"traceutil/trace.go:171","msg":"trace[1502340511] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"116.049444ms","start":"2026-06-28T19:54:16.025352Z","end":"2026-06-28T19:54:16.141402Z","steps":["trace[1502340511] 'process raft request' (duration: 115.861712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.141362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.522156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:54:16.141526Z","caller":"traceutil/trace.go:171","msg":"trace[1905580283] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1366; }","duration":"122.693368ms","start":"2026-06-28T19:54:16.018822Z","end":"2026-06-28T19:54:16.141515Z","steps":["trace[1905580283] 'agreement among raft nodes before linearized reading' (duration: 122.482555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:16.14192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.629791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:54:16.142007Z","caller":"traceutil/trace.go:171","msg":"trace[861900871] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1366; }","duration":"116.744092ms","start":"2026-06-28T19:54:16.025239Z","end":"2026-06-28T19:54:16.141983Z","steps":["trace[861900871] 'agreement among raft nodes before linearized reading' (duration: 116.103015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:17.864413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296568040623864272,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:54:17.992435Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.526611473s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:54:17.993074Z","caller":"traceutil/trace.go:171","msg":"trace[759717729] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"1.527329933s","start":"2026-06-28T19:54:16.465692Z","end":"2026-06-28T19:54:17.993022Z","steps":["trace[759717729] 'process raft request' (duration: 1.52712787s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:17.993273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:16.465665Z","time spent":"1.527501795s","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:54:18.132137Z","caller":"traceutil/trace.go:171","msg":"trace[529896118] linearizableReadLoop","detail":"{readStateIndex:1425; appliedIndex:1423; }","duration":"768.47869ms","start":"2026-06-28T19:54:17.363634Z","end":"2026-06-28T19:54:18.132112Z","steps":["trace[529896118] 'read index received' (duration: 629.193397ms)","trace[529896118] 'applied index is now lower than readState.Index' (duration: 139.284163ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:54:18.132159Z","caller":"traceutil/trace.go:171","msg":"trace[1781817295] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"521.379107ms","start":"2026-06-28T19:54:17.610744Z","end":"2026-06-28T19:54:18.132123Z","steps":["trace[1781817295] 'process raft request' (duration: 501.8119ms)","trace[1781817295] 'compare' (duration: 19.443335ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:54:18.132301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:17.610721Z","time spent":"521.503429ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5897,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:54:18.132313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.649392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:54:18.132373Z","caller":"traceutil/trace.go:171","msg":"trace[1444408212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1368; }","duration":"768.754484ms","start":"2026-06-28T19:54:17.363603Z","end":"2026-06-28T19:54:18.132358Z","steps":["trace[1444408212] 'agreement among raft nodes before linearized reading' (duration: 768.652013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:18.132441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:17.363588Z","time spent":"768.828255ms","remote":"127.0.0.1:56856","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-06-28T19:54:18.132536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.77113ms","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-06-28T19:54:18.132576Z","caller":"traceutil/trace.go:171","msg":"trace[1320205948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1368; }","duration":"463.861932ms","start":"2026-06-28T19:54:17.668703Z","end":"2026-06-28T19:54:18.132565Z","steps":["trace[1320205948] 'agreement among raft nodes before linearized reading' (duration: 463.72482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:18.132606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:54:17.668675Z","time spent":"463.925092ms","remote":"127.0.0.1:57098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T19:54:18.132825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.671495ms","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-06-28T19:54:18.132862Z","caller":"traceutil/trace.go:171","msg":"trace[1302564959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1368; }","duration":"107.738765ms","start":"2026-06-28T19:54:18.025114Z","end":"2026-06-28T19:54:18.132853Z","steps":["trace[1302564959] 'agreement among raft nodes before linearized reading' (duration: 107.642734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:18.132885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.150697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:54:18.132986Z","caller":"traceutil/trace.go:171","msg":"trace[1021068382] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1368; }","duration":"211.279759ms","start":"2026-06-28T19:54:17.921648Z","end":"2026-06-28T19:54:18.132927Z","steps":["trace[1021068382] 'agreement among raft nodes before linearized reading' (duration: 211.124177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:54:18.473903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.917299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:54:18.474017Z","caller":"traceutil/trace.go:171","msg":"trace[653960050] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1430; }","duration":"108.396503ms","start":"2026-06-28T19:54:18.365603Z","end":"2026-06-28T19:54:18.473999Z","steps":["trace[653960050] 'read index received' (duration: 44.631µs)","trace[653960050] 'applied index is now lower than readState.Index' (duration: 108.350362ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:54:18.474108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.503754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:54:18.474135Z","caller":"traceutil/trace.go:171","msg":"trace[1951385440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1374; }","duration":"108.580305ms","start":"2026-06-28T19:54:18.365545Z","end":"2026-06-28T19:54:18.474125Z","steps":["trace[1951385440] 'agreement among raft nodes before linearized reading' (duration: 108.501714ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:54:18.474231Z","caller":"traceutil/trace.go:171","msg":"trace[199327216] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"292.291178ms","start":"2026-06-28T19:54:18.181908Z","end":"2026-06-28T19:54:18.474199Z","steps":["trace[199327216] 'process raft request' (duration: 94.960055ms)","trace[199327216] 'compare' (duration: 196.753086ms)"],"step_count":2}