{"level":"warn","ts":"2026-10-03T09:04:03.663288Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T09:04:03.663381Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.24:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.24:2380","--initial-cluster=instance=https://162.253.55.24:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.24:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.24:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-03T09:04:03.663461Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T09:04:03.663475Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.24:2380"]} {"level":"info","ts":"2026-10-03T09:04:03.663496Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-03T09:04:03.666578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.24:2379"]} {"level":"info","ts":"2026-10-03T09:04:03.666684Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.24:2380"],"listen-peer-urls":["https://162.253.55.24:2380"],"advertise-client-urls":["https://162.253.55.24:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.24:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.24:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-03T09:04:03.672982Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.563184ms"} {"level":"info","ts":"2026-10-03T09:04:03.685448Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7a47c02f9bc0b904","cluster-id":"318a7363fda604da"} {"level":"info","ts":"2026-10-03T09:04:03.685529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T09:04:03.68555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became follower at term 0"} {"level":"info","ts":"2026-10-03T09:04:03.685562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7a47c02f9bc0b904 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T09:04:03.685568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became follower at term 1"} {"level":"info","ts":"2026-10-03T09:04:03.685603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 switched to configuration voters=(8811222506682759428)"} {"level":"warn","ts":"2026-10-03T09:04:03.699138Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T09:04:03.700765Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T09:04:03.704351Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-03T09:04:03.706604Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7a47c02f9bc0b904","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T09:04:03.706744Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7a47c02f9bc0b904","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T09:04:03.706723Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T09:04:03.706884Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T09:04:03.706902Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T09:04:03.708399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 switched to configuration voters=(8811222506682759428)"} {"level":"info","ts":"2026-10-03T09:04:03.708865Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"318a7363fda604da","local-member-id":"7a47c02f9bc0b904","added-peer-id":"7a47c02f9bc0b904","added-peer-peer-urls":["https://162.253.55.24:2380"]} {"level":"info","ts":"2026-10-03T09:04:03.710604Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-03T09:04:03.710675Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.24:2380"} {"level":"info","ts":"2026-10-03T09:04:03.710721Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.24:2380"} {"level":"info","ts":"2026-10-03T09:04:03.710856Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7a47c02f9bc0b904","initial-advertise-peer-urls":["https://162.253.55.24:2380"],"listen-peer-urls":["https://162.253.55.24:2380"],"advertise-client-urls":["https://162.253.55.24:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.24:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T09:04:03.710912Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T09:04:04.086336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T09:04:04.086392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T09:04:04.086414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 received MsgPreVoteResp from 7a47c02f9bc0b904 at term 1"} {"level":"info","ts":"2026-10-03T09:04:04.086432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became candidate at term 2"} {"level":"info","ts":"2026-10-03T09:04:04.086445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 received MsgVoteResp from 7a47c02f9bc0b904 at term 2"} {"level":"info","ts":"2026-10-03T09:04:04.086459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became leader at term 2"} {"level":"info","ts":"2026-10-03T09:04:04.086471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7a47c02f9bc0b904 elected leader 7a47c02f9bc0b904 at term 2"} {"level":"info","ts":"2026-10-03T09:04:04.089113Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7a47c02f9bc0b904","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.24:2379]}","request-path":"/0/members/7a47c02f9bc0b904/attributes","cluster-id":"318a7363fda604da","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T09:04:04.089223Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T09:04:04.089349Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T09:04:04.089366Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:04:04.089482Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T09:04:04.089957Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T09:04:04.091375Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"318a7363fda604da","local-member-id":"7a47c02f9bc0b904","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:04:04.091467Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:04:04.091492Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:04:04.092634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.24:2379"} {"level":"info","ts":"2026-10-03T09:04:04.093687Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-03T09:04:06.146705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.339664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-03T09:04:06.146834Z","caller":"traceutil/trace.go:171","msg":"trace[2016356277] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:68; }","duration":"134.573998ms","start":"2026-10-03T09:04:06.012239Z","end":"2026-10-03T09:04:06.146813Z","steps":["trace[2016356277] 'range keys from in-memory index tree' (duration: 134.261234ms)"],"step_count":1} 2026/10/03 09:04:09 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-10-03T09:04:10.223587Z","caller":"traceutil/trace.go:171","msg":"trace[989789344] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"107.474039ms","start":"2026-10-03T09:04:10.116048Z","end":"2026-10-03T09:04:10.223522Z","steps":["trace[989789344] 'process raft request' (duration: 69.847536ms)","trace[989789344] 'compare' (duration: 37.52023ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:10.349866Z","caller":"traceutil/trace.go:171","msg":"trace[1089295853] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"130.974962ms","start":"2026-10-03T09:04:10.218862Z","end":"2026-10-03T09:04:10.349837Z","steps":["trace[1089295853] 'process raft request' (duration: 115.400208ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:10.375732Z","caller":"traceutil/trace.go:171","msg":"trace[854585121] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"156.69728ms","start":"2026-10-03T09:04:10.218987Z","end":"2026-10-03T09:04:10.375685Z","steps":["trace[854585121] 'process raft request' (duration: 156.447566ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:10.375772Z","caller":"traceutil/trace.go:171","msg":"trace[1678711110] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:268; }","duration":"152.251907ms","start":"2026-10-03T09:04:10.223496Z","end":"2026-10-03T09:04:10.375748Z","steps":["trace[1678711110] 'read index received' (duration: 110.783173ms)","trace[1678711110] 'applied index is now lower than readState.Index' (duration: 41.467614ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:10.375894Z","caller":"traceutil/trace.go:171","msg":"trace[1432584174] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"149.296149ms","start":"2026-10-03T09:04:10.226584Z","end":"2026-10-03T09:04:10.37588Z","steps":["trace[1432584174] 'process raft request' (duration: 149.028505ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:10.375931Z","caller":"traceutil/trace.go:171","msg":"trace[1020003178] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"156.802921ms","start":"2026-10-03T09:04:10.219109Z","end":"2026-10-03T09:04:10.375912Z","steps":["trace[1020003178] 'process raft request' (duration: 156.482376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:10.376223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.343366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-10-03T09:04:10.376265Z","caller":"traceutil/trace.go:171","msg":"trace[1703740477] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:263; }","duration":"158.424919ms","start":"2026-10-03T09:04:10.217829Z","end":"2026-10-03T09:04:10.376254Z","steps":["trace[1703740477] 'agreement among raft nodes before linearized reading' (duration: 158.352058ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:10.375761Z","caller":"traceutil/trace.go:171","msg":"trace[906764515] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"157.143027ms","start":"2026-10-03T09:04:10.2186Z","end":"2026-10-03T09:04:10.375743Z","steps":["trace[906764515] 'process raft request' (duration: 156.943354ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:13.650839Z","caller":"traceutil/trace.go:171","msg":"trace[2096503007] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"206.031621ms","start":"2026-10-03T09:04:13.44477Z","end":"2026-10-03T09:04:13.650802Z","steps":["trace[2096503007] 'process raft request' (duration: 203.904927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:14.27585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.368928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:04:14.275993Z","caller":"traceutil/trace.go:171","msg":"trace[1518493692] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"171.376922ms","start":"2026-10-03T09:04:14.104598Z","end":"2026-10-03T09:04:14.275974Z","steps":["trace[1518493692] 'read index received' (duration: 43.336953ms)","trace[1518493692] 'applied index is now lower than readState.Index' (duration: 128.038409ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:14.276043Z","caller":"traceutil/trace.go:171","msg":"trace[1306219573] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"612.735559ms","start":"2026-10-03T09:04:13.663265Z","end":"2026-10-03T09:04:14.276001Z","steps":["trace[1306219573] 'process raft request' (duration: 484.547277ms)","trace[1306219573] 'compare' (duration: 127.141925ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:14.276161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.556056ms","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-10-03T09:04:14.276193Z","caller":"traceutil/trace.go:171","msg":"trace[1203163974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:303; }","duration":"171.638297ms","start":"2026-10-03T09:04:14.104544Z","end":"2026-10-03T09:04:14.276183Z","steps":["trace[1203163974] 'agreement among raft nodes before linearized reading' (duration: 171.519686ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:14.276204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:13.663237Z","time spent":"612.884742ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:14.382907Z","caller":"traceutil/trace.go:171","msg":"trace[562911592] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:313; }","duration":"100.831874ms","start":"2026-10-03T09:04:14.282049Z","end":"2026-10-03T09:04:14.382881Z","steps":["trace[562911592] 'read index received' (duration: 59.926749ms)","trace[562911592] 'applied index is now lower than readState.Index' (duration: 40.903615ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:14.383027Z","caller":"traceutil/trace.go:171","msg":"trace[308273016] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"101.499294ms","start":"2026-10-03T09:04:14.281502Z","end":"2026-10-03T09:04:14.383001Z","steps":["trace[308273016] 'process raft request' (duration: 97.153984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:14.383081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.021117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:14.383122Z","caller":"traceutil/trace.go:171","msg":"trace[1330632328] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:305; }","duration":"101.145338ms","start":"2026-10-03T09:04:14.281963Z","end":"2026-10-03T09:04:14.383108Z","steps":["trace[1330632328] 'agreement among raft nodes before linearized reading' (duration: 101.019836ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:14.634119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.279898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-10-03T09:04:14.634208Z","caller":"traceutil/trace.go:171","msg":"trace[1386398762] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:309; }","duration":"142.429749ms","start":"2026-10-03T09:04:14.491759Z","end":"2026-10-03T09:04:14.634189Z","steps":["trace[1386398762] 'range keys from in-memory index tree' (duration: 142.151066ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:14.634222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.421262ms","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-10-03T09:04:14.634283Z","caller":"traceutil/trace.go:171","msg":"trace[1237594288] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:309; }","duration":"134.507643ms","start":"2026-10-03T09:04:14.499762Z","end":"2026-10-03T09:04:14.634269Z","steps":["trace[1237594288] 'range keys from in-memory index tree' (duration: 134.348101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:14.634332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.295021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-10-03T09:04:14.634374Z","caller":"traceutil/trace.go:171","msg":"trace[1774601460] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:309; }","duration":"136.394553ms","start":"2026-10-03T09:04:14.497966Z","end":"2026-10-03T09:04:14.634361Z","steps":["trace[1774601460] 'range keys from in-memory index tree' (duration: 136.152949ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:15.128972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.216468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:04:15.129121Z","caller":"traceutil/trace.go:171","msg":"trace[2080483258] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"227.899499ms","start":"2026-10-03T09:04:14.901196Z","end":"2026-10-03T09:04:15.129095Z","steps":["trace[2080483258] 'process raft request' (duration: 100.246845ms)","trace[2080483258] 'compare' (duration: 127.104675ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:15.138948Z","caller":"traceutil/trace.go:171","msg":"trace[503845515] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"235.706833ms","start":"2026-10-03T09:04:14.903191Z","end":"2026-10-03T09:04:15.138898Z","steps":["trace[503845515] 'process raft request' (duration: 235.462ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:15.13903Z","caller":"traceutil/trace.go:171","msg":"trace[646515579] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:324; }","duration":"217.41072ms","start":"2026-10-03T09:04:14.921597Z","end":"2026-10-03T09:04:15.139008Z","steps":["trace[646515579] 'read index received' (duration: 79.866308ms)","trace[646515579] 'applied index is now lower than readState.Index' (duration: 137.543022ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:15.139136Z","caller":"traceutil/trace.go:171","msg":"trace[723380522] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"235.582161ms","start":"2026-10-03T09:04:14.903511Z","end":"2026-10-03T09:04:15.139093Z","steps":["trace[723380522] 'process raft request' (duration: 235.308207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:15.13939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.783417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T09:04:15.139464Z","caller":"traceutil/trace.go:171","msg":"trace[1524021743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:317; }","duration":"217.899299ms","start":"2026-10-03T09:04:14.921552Z","end":"2026-10-03T09:04:15.139452Z","steps":["trace[1524021743] 'agreement among raft nodes before linearized reading' (duration: 217.717685ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:15.139682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.1548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-10-03T09:04:15.139781Z","caller":"traceutil/trace.go:171","msg":"trace[2078103719] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:317; }","duration":"196.352903ms","start":"2026-10-03T09:04:14.943405Z","end":"2026-10-03T09:04:15.139757Z","steps":["trace[2078103719] 'agreement among raft nodes before linearized reading' (duration: 196.162021ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:15.140026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.051478ms","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-10-03T09:04:15.14008Z","caller":"traceutil/trace.go:171","msg":"trace[1997740682] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:317; }","duration":"146.132869ms","start":"2026-10-03T09:04:14.993933Z","end":"2026-10-03T09:04:15.140066Z","steps":["trace[1997740682] 'agreement among raft nodes before linearized reading' (duration: 146.038028ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:19.26922Z","caller":"traceutil/trace.go:171","msg":"trace[426494666] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"124.431832ms","start":"2026-10-03T09:04:19.144776Z","end":"2026-10-03T09:04:19.269207Z","steps":["trace[426494666] 'process raft request' (duration: 124.356521ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:19.269369Z","caller":"traceutil/trace.go:171","msg":"trace[1672908013] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:385; }","duration":"106.374889ms","start":"2026-10-03T09:04:19.162971Z","end":"2026-10-03T09:04:19.269346Z","steps":["trace[1672908013] 'read index received' (duration: 106.362329ms)","trace[1672908013] 'applied index is now lower than readState.Index' (duration: 11.04µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:19.269516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.532662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-03T09:04:19.269635Z","caller":"traceutil/trace.go:171","msg":"trace[366269924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:373; }","duration":"106.593922ms","start":"2026-10-03T09:04:19.162959Z","end":"2026-10-03T09:04:19.269553Z","steps":["trace[366269924] 'agreement among raft nodes before linearized reading' (duration: 106.480831ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:20.441763Z","caller":"traceutil/trace.go:171","msg":"trace[705070882] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"194.641962ms","start":"2026-10-03T09:04:20.247089Z","end":"2026-10-03T09:04:20.44173Z","steps":["trace[705070882] 'process raft request' (duration: 194.398128ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:27.649469Z","caller":"traceutil/trace.go:171","msg":"trace[1049120249] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"155.346508ms","start":"2026-10-03T09:04:27.49411Z","end":"2026-10-03T09:04:27.649457Z","steps":["trace[1049120249] 'process raft request' (duration: 155.102283ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:29.71323Z","caller":"traceutil/trace.go:171","msg":"trace[1392958442] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"127.969797ms","start":"2026-10-03T09:04:29.585221Z","end":"2026-10-03T09:04:29.71319Z","steps":["trace[1392958442] 'process raft request' (duration: 98.391249ms)","trace[1392958442] 'compare' (duration: 29.378615ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:29.713341Z","caller":"traceutil/trace.go:171","msg":"trace[214214558] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"124.238281ms","start":"2026-10-03T09:04:29.589084Z","end":"2026-10-03T09:04:29.713322Z","steps":["trace[214214558] 'process raft request' (duration: 124.19115ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:29.713574Z","caller":"traceutil/trace.go:171","msg":"trace[923292277] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"128.262472ms","start":"2026-10-03T09:04:29.585303Z","end":"2026-10-03T09:04:29.713566Z","steps":["trace[923292277] 'process raft request' (duration: 127.825005ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:29.713729Z","caller":"traceutil/trace.go:171","msg":"trace[2077047307] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"125.937457ms","start":"2026-10-03T09:04:29.587785Z","end":"2026-10-03T09:04:29.713723Z","steps":["trace[2077047307] 'process raft request' (duration: 125.371858ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:29.713935Z","caller":"traceutil/trace.go:171","msg":"trace[2012368066] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"125.168005ms","start":"2026-10-03T09:04:29.588761Z","end":"2026-10-03T09:04:29.713929Z","steps":["trace[2012368066] 'process raft request' (duration: 124.440793ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:35.039697Z","caller":"traceutil/trace.go:171","msg":"trace[1965475861] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:459; }","duration":"344.319555ms","start":"2026-10-03T09:04:34.695298Z","end":"2026-10-03T09:04:35.039617Z","steps":["trace[1965475861] 'read index received' (duration: 344.066141ms)","trace[1965475861] 'applied index is now lower than readState.Index' (duration: 252.304µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:35.039754Z","caller":"traceutil/trace.go:171","msg":"trace[115268403] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"351.657654ms","start":"2026-10-03T09:04:34.68806Z","end":"2026-10-03T09:04:35.039717Z","steps":["trace[115268403] 'process raft request' (duration: 351.37302ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:35.039851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.535278ms","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-10-03T09:04:35.039909Z","caller":"traceutil/trace.go:171","msg":"trace[1160425920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:444; }","duration":"344.63683ms","start":"2026-10-03T09:04:34.695256Z","end":"2026-10-03T09:04:35.039893Z","steps":["trace[1160425920] 'agreement among raft nodes before linearized reading' (duration: 344.530378ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:35.039916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:34.68803Z","time spent":"351.802476ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:04:35.039977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:34.695244Z","time spent":"344.70866ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-03T09:04:35.739577Z","caller":"traceutil/trace.go:171","msg":"trace[516541973] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"198.441375ms","start":"2026-10-03T09:04:35.541112Z","end":"2026-10-03T09:04:35.739553Z","steps":["trace[516541973] 'process raft request' (duration: 179.182259ms)","trace[516541973] 'compare' (duration: 19.033872ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:37.305428Z","caller":"traceutil/trace.go:171","msg":"trace[1455934906] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:464; }","duration":"173.507779ms","start":"2026-10-03T09:04:37.131899Z","end":"2026-10-03T09:04:37.305407Z","steps":["trace[1455934906] 'read index received' (duration: 173.319357ms)","trace[1455934906] 'applied index is now lower than readState.Index' (duration: 185.592µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:37.305532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.622801ms","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-10-03T09:04:37.305517Z","caller":"traceutil/trace.go:171","msg":"trace[1610322710] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"258.760577ms","start":"2026-10-03T09:04:37.04673Z","end":"2026-10-03T09:04:37.305491Z","steps":["trace[1610322710] 'process raft request' (duration: 258.562634ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:37.305565Z","caller":"traceutil/trace.go:171","msg":"trace[592562131] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:449; }","duration":"173.670051ms","start":"2026-10-03T09:04:37.131885Z","end":"2026-10-03T09:04:37.305555Z","steps":["trace[592562131] 'agreement among raft nodes before linearized reading' (duration: 173.60044ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:37.497666Z","caller":"traceutil/trace.go:171","msg":"trace[1869807367] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"188.58843ms","start":"2026-10-03T09:04:37.309059Z","end":"2026-10-03T09:04:37.497647Z","steps":["trace[1869807367] 'process raft request' (duration: 95.950454ms)","trace[1869807367] 'compare' (duration: 92.567775ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:38.060249Z","caller":"traceutil/trace.go:171","msg":"trace[2130390959] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"259.498595ms","start":"2026-10-03T09:04:37.800726Z","end":"2026-10-03T09:04:38.060225Z","steps":["trace[2130390959] 'process raft request' (duration: 259.345283ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:41.725387Z","caller":"traceutil/trace.go:171","msg":"trace[521940663] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"208.739862ms","start":"2026-10-03T09:04:41.516616Z","end":"2026-10-03T09:04:41.725356Z","steps":["trace[521940663] 'process raft request' (duration: 152.440872ms)","trace[521940663] 'compare' (duration: 56.126658ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:41.725663Z","caller":"traceutil/trace.go:171","msg":"trace[1339553579] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"208.123414ms","start":"2026-10-03T09:04:41.517515Z","end":"2026-10-03T09:04:41.725639Z","steps":["trace[1339553579] 'process raft request' (duration: 207.791809ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:41.725685Z","caller":"traceutil/trace.go:171","msg":"trace[143306013] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:478; }","duration":"176.417861ms","start":"2026-10-03T09:04:41.548925Z","end":"2026-10-03T09:04:41.725343Z","steps":["trace[143306013] 'read index received' (duration: 120.06539ms)","trace[143306013] 'applied index is now lower than readState.Index' (duration: 56.351741ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:41.726322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.375754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-03T09:04:41.726387Z","caller":"traceutil/trace.go:171","msg":"trace[872392749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:463; }","duration":"177.474117ms","start":"2026-10-03T09:04:41.548896Z","end":"2026-10-03T09:04:41.726371Z","steps":["trace[872392749] 'agreement among raft nodes before linearized reading' (duration: 176.845687ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:41.943281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.147558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:04:41.94337Z","caller":"traceutil/trace.go:171","msg":"trace[1101008691] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"133.06771ms","start":"2026-10-03T09:04:41.810282Z","end":"2026-10-03T09:04:41.94335Z","steps":["trace[1101008691] 'process raft request' (duration: 17.78749ms)","trace[1101008691] 'compare' (duration: 115.069326ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:42.285282Z","caller":"traceutil/trace.go:171","msg":"trace[1538687433] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"145.16634ms","start":"2026-10-03T09:04:42.140075Z","end":"2026-10-03T09:04:42.285241Z","steps":["trace[1538687433] 'process raft request' (duration: 75.650259ms)","trace[1538687433] 'compare' (duration: 69.323648ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:42.31371Z","caller":"traceutil/trace.go:171","msg":"trace[407643444] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"172.172511ms","start":"2026-10-03T09:04:42.1415Z","end":"2026-10-03T09:04:42.313673Z","steps":["trace[407643444] 'process raft request' (duration: 171.965119ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.313772Z","caller":"traceutil/trace.go:171","msg":"trace[1747720676] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"171.864697ms","start":"2026-10-03T09:04:42.141875Z","end":"2026-10-03T09:04:42.31374Z","steps":["trace[1747720676] 'process raft request' (duration: 171.682335ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.314097Z","caller":"traceutil/trace.go:171","msg":"trace[1747053795] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"170.738401ms","start":"2026-10-03T09:04:42.143341Z","end":"2026-10-03T09:04:42.31408Z","steps":["trace[1747053795] 'process raft request' (duration: 170.299095ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.314371Z","caller":"traceutil/trace.go:171","msg":"trace[134294919] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"170.644579ms","start":"2026-10-03T09:04:42.143697Z","end":"2026-10-03T09:04:42.314341Z","steps":["trace[134294919] 'process raft request' (duration: 169.9891ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.315216Z","caller":"traceutil/trace.go:171","msg":"trace[11394450] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"165.926001ms","start":"2026-10-03T09:04:42.149272Z","end":"2026-10-03T09:04:42.315198Z","steps":["trace[11394450] 'process raft request' (duration: 165.256621ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.473168Z","caller":"traceutil/trace.go:171","msg":"trace[364043526] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:502; }","duration":"100.035794ms","start":"2026-10-03T09:04:42.37311Z","end":"2026-10-03T09:04:42.473146Z","steps":["trace[364043526] 'read index received' (duration: 67.686744ms)","trace[364043526] 'applied index is now lower than readState.Index' (duration: 32.34791ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:42.473304Z","caller":"traceutil/trace.go:171","msg":"trace[756502322] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"129.372949ms","start":"2026-10-03T09:04:42.343909Z","end":"2026-10-03T09:04:42.473282Z","steps":["trace[756502322] 'process raft request' (duration: 129.097095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:42.473402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.268197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-ntmdj\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-10-03T09:04:42.473442Z","caller":"traceutil/trace.go:171","msg":"trace[126174257] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-ntmdj; range_end:; response_count:1; response_revision:487; }","duration":"100.357319ms","start":"2026-10-03T09:04:42.373074Z","end":"2026-10-03T09:04:42.473431Z","steps":["trace[126174257] 'agreement among raft nodes before linearized reading' (duration: 100.205947ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.473748Z","caller":"traceutil/trace.go:171","msg":"trace[1969303946] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"141.140811ms","start":"2026-10-03T09:04:42.332017Z","end":"2026-10-03T09:04:42.473157Z","steps":["trace[1969303946] 'process raft request' (duration: 108.747461ms)","trace[1969303946] 'compare' (duration: 32.111176ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:42.481116Z","caller":"traceutil/trace.go:171","msg":"trace[613575007] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"107.836587ms","start":"2026-10-03T09:04:42.373263Z","end":"2026-10-03T09:04:42.481099Z","steps":["trace[613575007] 'process raft request' (duration: 107.623163ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.481692Z","caller":"traceutil/trace.go:171","msg":"trace[189514884] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"105.572064ms","start":"2026-10-03T09:04:42.376107Z","end":"2026-10-03T09:04:42.481679Z","steps":["trace[189514884] 'process raft request' (duration: 104.915975ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.662949Z","caller":"traceutil/trace.go:171","msg":"trace[128914729] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:506; }","duration":"166.315117ms","start":"2026-10-03T09:04:42.496618Z","end":"2026-10-03T09:04:42.662933Z","steps":["trace[128914729] 'read index received' (duration: 46.555497ms)","trace[128914729] 'applied index is now lower than readState.Index' (duration: 119.75885ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:42.663029Z","caller":"traceutil/trace.go:171","msg":"trace[924986176] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"181.63464ms","start":"2026-10-03T09:04:42.481371Z","end":"2026-10-03T09:04:42.663006Z","steps":["trace[924986176] 'process raft request' (duration: 148.534878ms)","trace[924986176] 'compare' (duration: 32.829957ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:42.663162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.51958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4632"} {"level":"info","ts":"2026-10-03T09:04:42.66317Z","caller":"traceutil/trace.go:171","msg":"trace[404166260] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"166.408238ms","start":"2026-10-03T09:04:42.496727Z","end":"2026-10-03T09:04:42.663135Z","steps":["trace[404166260] 'process raft request' (duration: 166.164824ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.663243Z","caller":"traceutil/trace.go:171","msg":"trace[430583592] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:493; }","duration":"166.645142ms","start":"2026-10-03T09:04:42.496578Z","end":"2026-10-03T09:04:42.663223Z","steps":["trace[430583592] 'agreement among raft nodes before linearized reading' (duration: 166.467449ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:42.66318Z","caller":"traceutil/trace.go:171","msg":"trace[1596112350] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"175.104305ms","start":"2026-10-03T09:04:42.488055Z","end":"2026-10-03T09:04:42.663159Z","steps":["trace[1596112350] 'process raft request' (duration: 174.788989ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.332679Z","caller":"traceutil/trace.go:171","msg":"trace[717089436] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"148.746769ms","start":"2026-10-03T09:04:44.183919Z","end":"2026-10-03T09:04:44.332666Z","steps":["trace[717089436] 'process raft request' (duration: 148.676669ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.404296Z","caller":"traceutil/trace.go:171","msg":"trace[1481894790] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"213.521925ms","start":"2026-10-03T09:04:44.190718Z","end":"2026-10-03T09:04:44.40424Z","steps":["trace[1481894790] 'process raft request' (duration: 213.320952ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.404372Z","caller":"traceutil/trace.go:171","msg":"trace[1254970914] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"204.270972ms","start":"2026-10-03T09:04:44.20007Z","end":"2026-10-03T09:04:44.404341Z","steps":["trace[1254970914] 'process raft request' (duration: 204.10662ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.404388Z","caller":"traceutil/trace.go:171","msg":"trace[2022268068] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"207.532708ms","start":"2026-10-03T09:04:44.196834Z","end":"2026-10-03T09:04:44.404367Z","steps":["trace[2022268068] 'process raft request' (duration: 207.309095ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.404498Z","caller":"traceutil/trace.go:171","msg":"trace[58370920] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"197.20504ms","start":"2026-10-03T09:04:44.207284Z","end":"2026-10-03T09:04:44.404489Z","steps":["trace[58370920] 'process raft request' (duration: 196.978337ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.404646Z","caller":"traceutil/trace.go:171","msg":"trace[985510739] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"200.01867ms","start":"2026-10-03T09:04:44.204418Z","end":"2026-10-03T09:04:44.404437Z","steps":["trace[985510739] 'process raft request' (duration: 199.800797ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.404712Z","caller":"traceutil/trace.go:171","msg":"trace[1401692704] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"193.10842ms","start":"2026-10-03T09:04:44.211591Z","end":"2026-10-03T09:04:44.404699Z","steps":["trace[1401692704] 'process raft request' (duration: 192.710104ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.405051Z","caller":"traceutil/trace.go:171","msg":"trace[510455960] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"191.035822ms","start":"2026-10-03T09:04:44.214002Z","end":"2026-10-03T09:04:44.405037Z","steps":["trace[510455960] 'process raft request' (duration: 190.628295ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.405267Z","caller":"traceutil/trace.go:171","msg":"trace[1652713057] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"172.221859ms","start":"2026-10-03T09:04:44.233034Z","end":"2026-10-03T09:04:44.405256Z","steps":["trace[1652713057] 'process raft request' (duration: 171.901724ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.405594Z","caller":"traceutil/trace.go:171","msg":"trace[1733938023] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"168.274871ms","start":"2026-10-03T09:04:44.237306Z","end":"2026-10-03T09:04:44.405581Z","steps":["trace[1733938023] 'process raft request' (duration: 167.690203ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.405678Z","caller":"traceutil/trace.go:171","msg":"trace[37069496] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"147.898466ms","start":"2026-10-03T09:04:44.257763Z","end":"2026-10-03T09:04:44.405661Z","steps":["trace[37069496] 'process raft request' (duration: 147.737604ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:44.680052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.441853ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:04:44.680295Z","caller":"traceutil/trace.go:171","msg":"trace[1564370634] transaction","detail":"{read_only:false; number_of_response:1; response_revision:513; }","duration":"341.474465ms","start":"2026-10-03T09:04:44.33878Z","end":"2026-10-03T09:04:44.680254Z","steps":["trace[1564370634] 'process raft request' (duration: 341.430844ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:44.680399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.338775Z","time spent":"341.566126ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:44.680364Z","caller":"traceutil/trace.go:171","msg":"trace[1466790699] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"341.732878ms","start":"2026-10-03T09:04:44.338602Z","end":"2026-10-03T09:04:44.680335Z","steps":["trace[1466790699] 'process raft request' (duration: 341.544865ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.681283Z","caller":"traceutil/trace.go:171","msg":"trace[264666269] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"343.655196ms","start":"2026-10-03T09:04:44.336813Z","end":"2026-10-03T09:04:44.680468Z","steps":["trace[264666269] 'process raft request' (duration: 145.728296ms)","trace[264666269] 'compare' (duration: 197.295001ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:44.681336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.338594Z","time spent":"342.671091ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:04:44.681484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.336794Z","time spent":"344.550739ms","remote":"127.0.0.1:50962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:44.684082Z","caller":"traceutil/trace.go:171","msg":"trace[1762175886] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"252.315416ms","start":"2026-10-03T09:04:44.431741Z","end":"2026-10-03T09:04:44.684056Z","steps":["trace[1762175886] 'process raft request' (duration: 251.034037ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.684489Z","caller":"traceutil/trace.go:171","msg":"trace[754095991] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"264.42356ms","start":"2026-10-03T09:04:44.420045Z","end":"2026-10-03T09:04:44.684468Z","steps":["trace[754095991] 'process raft request' (duration: 262.568054ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.684752Z","caller":"traceutil/trace.go:171","msg":"trace[1611696092] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"268.985616ms","start":"2026-10-03T09:04:44.415739Z","end":"2026-10-03T09:04:44.684725Z","steps":["trace[1611696092] 'process raft request' (duration: 266.223436ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.685093Z","caller":"traceutil/trace.go:171","msg":"trace[1575552333] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"268.071154ms","start":"2026-10-03T09:04:44.416999Z","end":"2026-10-03T09:04:44.685071Z","steps":["trace[1575552333] 'process raft request' (duration: 265.535297ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.685366Z","caller":"traceutil/trace.go:171","msg":"trace[268759431] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"263.279094ms","start":"2026-10-03T09:04:44.422049Z","end":"2026-10-03T09:04:44.685328Z","steps":["trace[268759431] 'process raft request' (duration: 260.632016ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.685863Z","caller":"traceutil/trace.go:171","msg":"trace[1159335177] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"252.781142ms","start":"2026-10-03T09:04:44.433035Z","end":"2026-10-03T09:04:44.685816Z","steps":["trace[1159335177] 'process raft request' (duration: 250.189874ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.686545Z","caller":"traceutil/trace.go:171","msg":"trace[339842110] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"262.561895ms","start":"2026-10-03T09:04:44.423964Z","end":"2026-10-03T09:04:44.686526Z","steps":["trace[339842110] 'process raft request' (duration: 258.76973ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.687299Z","caller":"traceutil/trace.go:171","msg":"trace[1008818189] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"250.391118ms","start":"2026-10-03T09:04:44.43689Z","end":"2026-10-03T09:04:44.687282Z","steps":["trace[1008818189] 'process raft request' (duration: 248.714204ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.692189Z","caller":"traceutil/trace.go:171","msg":"trace[686154565] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"251.827199ms","start":"2026-10-03T09:04:44.440341Z","end":"2026-10-03T09:04:44.692168Z","steps":["trace[686154565] 'process raft request' (duration: 251.711908ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:44.692372Z","caller":"traceutil/trace.go:171","msg":"trace[2039544637] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"255.064285ms","start":"2026-10-03T09:04:44.437294Z","end":"2026-10-03T09:04:44.692358Z","steps":["trace[2039544637] 'process raft request' (duration: 254.517377ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.086046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.573661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-10-03T09:04:45.08622Z","caller":"traceutil/trace.go:171","msg":"trace[1240202884] transaction","detail":"{read_only:false; number_of_response:0; response_revision:523; }","duration":"390.120653ms","start":"2026-10-03T09:04:44.696083Z","end":"2026-10-03T09:04:45.086204Z","steps":["trace[1240202884] 'process raft request' (duration: 237.325169ms)","trace[1240202884] 'compare' (duration: 152.53611ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:45.086303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.696058Z","time spent":"390.220014ms","remote":"127.0.0.1:50962","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:45.100299Z","caller":"traceutil/trace.go:171","msg":"trace[1750618904] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"403.271363ms","start":"2026-10-03T09:04:44.696994Z","end":"2026-10-03T09:04:45.100266Z","steps":["trace[1750618904] 'process raft request' (duration: 402.955318ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.100344Z","caller":"traceutil/trace.go:171","msg":"trace[225709828] transaction","detail":"{read_only:false; number_of_response:0; response_revision:525; }","duration":"403.071381ms","start":"2026-10-03T09:04:44.697259Z","end":"2026-10-03T09:04:45.10033Z","steps":["trace[225709828] 'process raft request' (duration: 403.01451ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.100419Z","caller":"traceutil/trace.go:171","msg":"trace[445737774] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"403.277363ms","start":"2026-10-03T09:04:44.69712Z","end":"2026-10-03T09:04:45.100397Z","steps":["trace[445737774] 'process raft request' (duration: 402.990499ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.100469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.696968Z","time spent":"403.412645ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:04:45.100449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.697245Z","time spent":"403.139401ms","remote":"127.0.0.1:50962","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-03T09:04:45.100577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.697109Z","time spent":"403.372345ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:45.100744Z","caller":"traceutil/trace.go:171","msg":"trace[355398742] transaction","detail":"{read_only:false; number_of_response:0; response_revision:525; }","duration":"403.382976ms","start":"2026-10-03T09:04:44.697348Z","end":"2026-10-03T09:04:45.100731Z","steps":["trace[355398742] 'process raft request' (duration: 402.959649ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.10081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.697331Z","time spent":"403.450127ms","remote":"127.0.0.1:50962","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:45.100903Z","caller":"traceutil/trace.go:171","msg":"trace[101759637] transaction","detail":"{read_only:false; number_of_response:0; response_revision:525; }","duration":"403.514797ms","start":"2026-10-03T09:04:44.697381Z","end":"2026-10-03T09:04:45.100895Z","steps":["trace[101759637] 'process raft request' (duration: 403.256144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.100945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.697372Z","time spent":"403.556498ms","remote":"127.0.0.1:50962","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:45.101182Z","caller":"traceutil/trace.go:171","msg":"trace[276455350] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"395.255437ms","start":"2026-10-03T09:04:44.705917Z","end":"2026-10-03T09:04:45.101172Z","steps":["trace[276455350] 'process raft request' (duration: 394.843361ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.101255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.7059Z","time spent":"395.324068ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:45.101348Z","caller":"traceutil/trace.go:171","msg":"trace[1514616346] transaction","detail":"{read_only:false; number_of_response:1; response_revision:525; }","duration":"402.102836ms","start":"2026-10-03T09:04:44.699226Z","end":"2026-10-03T09:04:45.101329Z","steps":["trace[1514616346] 'process raft request' (duration: 401.461737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.101468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.699212Z","time spent":"402.187267ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7374,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:45.101504Z","caller":"traceutil/trace.go:171","msg":"trace[1527933401] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"383.499517ms","start":"2026-10-03T09:04:44.717994Z","end":"2026-10-03T09:04:45.101494Z","steps":["trace[1527933401] 'process raft request' (duration: 382.995401ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.101583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.717979Z","time spent":"383.550168ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:45.101612Z","caller":"traceutil/trace.go:171","msg":"trace[309113720] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:542; }","duration":"309.821003ms","start":"2026-10-03T09:04:44.791772Z","end":"2026-10-03T09:04:45.101593Z","steps":["trace[309113720] 'read index received' (duration: 141.764508ms)","trace[309113720] 'applied index is now lower than readState.Index' (duration: 168.055435ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:45.101673Z","caller":"traceutil/trace.go:171","msg":"trace[312849910] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"378.391863ms","start":"2026-10-03T09:04:44.723271Z","end":"2026-10-03T09:04:45.101663Z","steps":["trace[312849910] 'process raft request' (duration: 377.831915ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.101691Z","caller":"traceutil/trace.go:171","msg":"trace[1176281567] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"295.649618ms","start":"2026-10-03T09:04:44.806017Z","end":"2026-10-03T09:04:45.101667Z","steps":["trace[1176281567] 'process raft request' (duration: 295.328383ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.101758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.72324Z","time spent":"378.473444ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:04:45.101772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.998205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:45.101818Z","caller":"traceutil/trace.go:171","msg":"trace[1365027585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"310.071486ms","start":"2026-10-03T09:04:44.791732Z","end":"2026-10-03T09:04:45.101804Z","steps":["trace[1365027585] 'agreement among raft nodes before linearized reading' (duration: 309.970864ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.101636Z","caller":"traceutil/trace.go:171","msg":"trace[2113552210] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"319.451771ms","start":"2026-10-03T09:04:44.782169Z","end":"2026-10-03T09:04:45.101621Z","steps":["trace[2113552210] 'process raft request' (duration: 319.083956ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:45.101865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.791721Z","time spent":"310.133616ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-03T09:04:45.101947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:44.782139Z","time spent":"319.731046ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:45.267907Z","caller":"traceutil/trace.go:171","msg":"trace[2132247555] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"151.743446ms","start":"2026-10-03T09:04:45.116134Z","end":"2026-10-03T09:04:45.267878Z","steps":["trace[2132247555] 'process raft request' (duration: 130.631652ms)","trace[2132247555] 'compare' (duration: 20.85156ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:45.268187Z","caller":"traceutil/trace.go:171","msg":"trace[2071267733] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"151.683776ms","start":"2026-10-03T09:04:45.116472Z","end":"2026-10-03T09:04:45.268156Z","steps":["trace[2071267733] 'process raft request' (duration: 151.351671ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.268182Z","caller":"traceutil/trace.go:171","msg":"trace[1398423935] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"138.920642ms","start":"2026-10-03T09:04:45.129238Z","end":"2026-10-03T09:04:45.268159Z","steps":["trace[1398423935] 'process raft request' (duration: 138.79387ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.320159Z","caller":"traceutil/trace.go:171","msg":"trace[123955951] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"125.025252ms","start":"2026-10-03T09:04:45.195112Z","end":"2026-10-03T09:04:45.320137Z","steps":["trace[123955951] 'process raft request' (duration: 124.92016ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.320214Z","caller":"traceutil/trace.go:171","msg":"trace[109887804] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"143.148303ms","start":"2026-10-03T09:04:45.176963Z","end":"2026-10-03T09:04:45.320111Z","steps":["trace[109887804] 'process raft request' (duration: 142.846858ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:45.462802Z","caller":"traceutil/trace.go:171","msg":"trace[1986892067] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"127.035391ms","start":"2026-10-03T09:04:45.335743Z","end":"2026-10-03T09:04:45.462778Z","steps":["trace[1986892067] 'process raft request' (duration: 64.48961ms)","trace[1986892067] 'compare' (duration: 62.407929ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:46.139766Z","caller":"traceutil/trace.go:171","msg":"trace[1497074596] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"439.592119ms","start":"2026-10-03T09:04:45.700152Z","end":"2026-10-03T09:04:46.139744Z","steps":["trace[1497074596] 'process raft request' (duration: 439.326635ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:46.139904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:45.700123Z","time spent":"439.71026ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:46.260486Z","caller":"traceutil/trace.go:171","msg":"trace[1494060843] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"559.933369ms","start":"2026-10-03T09:04:45.700516Z","end":"2026-10-03T09:04:46.260449Z","steps":["trace[1494060843] 'process raft request' (duration: 487.562208ms)","trace[1494060843] 'compare' (duration: 72.061376ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:46.260611Z","caller":"traceutil/trace.go:171","msg":"trace[1510486616] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"559.493192ms","start":"2026-10-03T09:04:45.701088Z","end":"2026-10-03T09:04:46.260581Z","steps":["trace[1510486616] 'process raft request' (duration: 559.187468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:46.260675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:45.700496Z","time spent":"560.0906ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:46.260706Z","caller":"traceutil/trace.go:171","msg":"trace[1884513321] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:573; }","duration":"467.376615ms","start":"2026-10-03T09:04:45.793269Z","end":"2026-10-03T09:04:46.260645Z","steps":["trace[1884513321] 'read index received' (duration: 346.241274ms)","trace[1884513321] 'applied index is now lower than readState.Index' (duration: 121.129141ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:46.260766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:45.70108Z","time spent":"559.616204ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-03T09:04:46.260781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.511297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:46.260852Z","caller":"traceutil/trace.go:171","msg":"trace[1623237701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"467.633999ms","start":"2026-10-03T09:04:45.793202Z","end":"2026-10-03T09:04:46.260836Z","steps":["trace[1623237701] 'agreement among raft nodes before linearized reading' (duration: 467.532187ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:46.26089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:45.793182Z","time spent":"467.700339ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-03T09:04:46.261006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.921717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-03T09:04:46.261944Z","caller":"traceutil/trace.go:171","msg":"trace[627153641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"383.042119ms","start":"2026-10-03T09:04:45.878011Z","end":"2026-10-03T09:04:46.261053Z","steps":["trace[627153641] 'agreement among raft nodes before linearized reading' (duration: 382.869586ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:46.262022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:45.877987Z","time spent":"384.015573ms","remote":"127.0.0.1:50668","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-10-03T09:04:46.486311Z","caller":"traceutil/trace.go:171","msg":"trace[1873313965] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"110.04406ms","start":"2026-10-03T09:04:46.376243Z","end":"2026-10-03T09:04:46.486287Z","steps":["trace[1873313965] 'process raft request' (duration: 109.837178ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:46.552034Z","caller":"traceutil/trace.go:171","msg":"trace[1550812621] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"122.952137ms","start":"2026-10-03T09:04:46.429059Z","end":"2026-10-03T09:04:46.552011Z","steps":["trace[1550812621] 'process raft request' (duration: 122.753234ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:46.687498Z","caller":"traceutil/trace.go:171","msg":"trace[789848498] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"163.765684ms","start":"2026-10-03T09:04:46.523705Z","end":"2026-10-03T09:04:46.687471Z","steps":["trace[789848498] 'process raft request' (duration: 119.445757ms)","trace[789848498] 'compare' (duration: 44.151914ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:46.70562Z","caller":"traceutil/trace.go:171","msg":"trace[447685100] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"146.040778ms","start":"2026-10-03T09:04:46.559558Z","end":"2026-10-03T09:04:46.705599Z","steps":["trace[447685100] 'process raft request' (duration: 145.809575ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:46.706798Z","caller":"traceutil/trace.go:171","msg":"trace[504707313] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"138.43232ms","start":"2026-10-03T09:04:46.568346Z","end":"2026-10-03T09:04:46.706779Z","steps":["trace[504707313] 'process raft request' (duration: 137.626177ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:46.707206Z","caller":"traceutil/trace.go:171","msg":"trace[751726005] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"126.101112ms","start":"2026-10-03T09:04:46.581092Z","end":"2026-10-03T09:04:46.707193Z","steps":["trace[751726005] 'process raft request' (duration: 125.2768ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:46.885052Z","caller":"traceutil/trace.go:171","msg":"trace[1958182481] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"141.458913ms","start":"2026-10-03T09:04:46.743565Z","end":"2026-10-03T09:04:46.885024Z","steps":["trace[1958182481] 'process raft request' (duration: 90.605152ms)","trace[1958182481] 'compare' (duration: 50.612297ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:46.910763Z","caller":"traceutil/trace.go:171","msg":"trace[1241078419] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:587; }","duration":"117.60534ms","start":"2026-10-03T09:04:46.793137Z","end":"2026-10-03T09:04:46.910743Z","steps":["trace[1241078419] 'read index received' (duration: 41.339294ms)","trace[1241078419] 'applied index is now lower than readState.Index' (duration: 76.265156ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:46.910885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.734752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:46.910888Z","caller":"traceutil/trace.go:171","msg":"trace[315525510] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"124.243874ms","start":"2026-10-03T09:04:46.786617Z","end":"2026-10-03T09:04:46.910861Z","steps":["trace[315525510] 'process raft request' (duration: 123.775368ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:46.910921Z","caller":"traceutil/trace.go:171","msg":"trace[434219136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"117.812983ms","start":"2026-10-03T09:04:46.793097Z","end":"2026-10-03T09:04:46.91091Z","steps":["trace[434219136] 'agreement among raft nodes before linearized reading' (duration: 117.723962ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:47.167618Z","caller":"traceutil/trace.go:171","msg":"trace[1888976766] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"327.813954ms","start":"2026-10-03T09:04:46.83978Z","end":"2026-10-03T09:04:47.167594Z","steps":["trace[1888976766] 'process raft request' (duration: 254.359901ms)","trace[1888976766] 'compare' (duration: 73.298251ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:47.167785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:46.839761Z","time spent":"327.971837ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T09:04:47.180085Z","caller":"traceutil/trace.go:171","msg":"trace[1483344390] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"268.051996ms","start":"2026-10-03T09:04:46.91201Z","end":"2026-10-03T09:04:47.180062Z","steps":["trace[1483344390] 'process raft request' (duration: 267.751051ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:47.180204Z","caller":"traceutil/trace.go:171","msg":"trace[1654756141] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"242.765462ms","start":"2026-10-03T09:04:46.937417Z","end":"2026-10-03T09:04:47.180183Z","steps":["trace[1654756141] 'process raft request' (duration: 242.57696ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:47.323107Z","caller":"traceutil/trace.go:171","msg":"trace[1725170375] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"100.080805ms","start":"2026-10-03T09:04:47.222998Z","end":"2026-10-03T09:04:47.323079Z","steps":["trace[1725170375] 'process raft request' (duration: 52.348151ms)","trace[1725170375] 'compare' (duration: 47.616142ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:47.498353Z","caller":"traceutil/trace.go:171","msg":"trace[1790498766] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"111.419427ms","start":"2026-10-03T09:04:47.386908Z","end":"2026-10-03T09:04:47.498327Z","steps":["trace[1790498766] 'process raft request' (duration: 111.305326ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:47.498393Z","caller":"traceutil/trace.go:171","msg":"trace[635952911] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"129.897092ms","start":"2026-10-03T09:04:47.368467Z","end":"2026-10-03T09:04:47.498364Z","steps":["trace[635952911] 'process raft request' (duration: 55.185572ms)","trace[635952911] 'compare' (duration: 74.205093ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:47.655655Z","caller":"traceutil/trace.go:171","msg":"trace[1201565380] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"104.203523ms","start":"2026-10-03T09:04:47.551414Z","end":"2026-10-03T09:04:47.655617Z","steps":["trace[1201565380] 'process raft request' (duration: 53.681359ms)","trace[1201565380] 'compare' (duration: 50.312781ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:47.65621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.925586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-10-03T09:04:47.6563Z","caller":"traceutil/trace.go:171","msg":"trace[12152570] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:577; }","duration":"103.046787ms","start":"2026-10-03T09:04:47.553235Z","end":"2026-10-03T09:04:47.656282Z","steps":["trace[12152570] 'agreement among raft nodes before linearized reading' (duration: 102.864165ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:49.489943Z","caller":"traceutil/trace.go:171","msg":"trace[859463561] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"175.252748ms","start":"2026-10-03T09:04:49.314667Z","end":"2026-10-03T09:04:49.489919Z","steps":["trace[859463561] 'process raft request' (duration: 175.098986ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:49.545268Z","caller":"traceutil/trace.go:171","msg":"trace[1782344089] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"189.133786ms","start":"2026-10-03T09:04:49.356111Z","end":"2026-10-03T09:04:49.545245Z","steps":["trace[1782344089] 'process raft request' (duration: 188.950863ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:49.718221Z","caller":"traceutil/trace.go:171","msg":"trace[1595013328] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"132.344926ms","start":"2026-10-03T09:04:49.585853Z","end":"2026-10-03T09:04:49.718198Z","steps":["trace[1595013328] 'process raft request' (duration: 132.178234ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:49.766249Z","caller":"traceutil/trace.go:171","msg":"trace[1006469964] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"178.660197ms","start":"2026-10-03T09:04:49.58756Z","end":"2026-10-03T09:04:49.76622Z","steps":["trace[1006469964] 'process raft request' (duration: 178.419754ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:49.766344Z","caller":"traceutil/trace.go:171","msg":"trace[2098610877] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"178.581616ms","start":"2026-10-03T09:04:49.587739Z","end":"2026-10-03T09:04:49.766321Z","steps":["trace[2098610877] 'read index received' (duration: 130.274387ms)","trace[2098610877] 'applied index is now lower than readState.Index' (duration: 48.306229ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:04:49.766474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.718258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:49.766509Z","caller":"traceutil/trace.go:171","msg":"trace[1071576184] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:0; response_revision:611; }","duration":"178.788509ms","start":"2026-10-03T09:04:49.587708Z","end":"2026-10-03T09:04:49.766497Z","steps":["trace[1071576184] 'agreement among raft nodes before linearized reading' (duration: 178.718638ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:49.766535Z","caller":"traceutil/trace.go:171","msg":"trace[793386773] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"177.712254ms","start":"2026-10-03T09:04:49.588784Z","end":"2026-10-03T09:04:49.766496Z","steps":["trace[793386773] 'process raft request' (duration: 177.375269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:49.793941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.132497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-03T09:04:49.794033Z","caller":"traceutil/trace.go:171","msg":"trace[1548810233] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:612; }","duration":"135.252758ms","start":"2026-10-03T09:04:49.658754Z","end":"2026-10-03T09:04:49.794007Z","steps":["trace[1548810233] 'agreement among raft nodes before linearized reading' (duration: 134.974593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:49.794034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.352774ms","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-10-03T09:04:49.794077Z","caller":"traceutil/trace.go:171","msg":"trace[2045707720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"115.416476ms","start":"2026-10-03T09:04:49.678649Z","end":"2026-10-03T09:04:49.794066Z","steps":["trace[2045707720] 'agreement among raft nodes before linearized reading' (duration: 115.06278ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:51.007077Z","caller":"traceutil/trace.go:171","msg":"trace[1130942310] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"230.72537ms","start":"2026-10-03T09:04:50.776326Z","end":"2026-10-03T09:04:51.007052Z","steps":["trace[1130942310] 'process raft request' (duration: 230.579518ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:51.022029Z","caller":"traceutil/trace.go:171","msg":"trace[1997551410] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"238.075103ms","start":"2026-10-03T09:04:50.783916Z","end":"2026-10-03T09:04:51.021991Z","steps":["trace[1997551410] 'process raft request' (duration: 237.768178ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:51.025129Z","caller":"traceutil/trace.go:171","msg":"trace[613743435] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"237.033678ms","start":"2026-10-03T09:04:50.788072Z","end":"2026-10-03T09:04:51.025106Z","steps":["trace[613743435] 'read index received' (duration: 218.919001ms)","trace[613743435] 'applied index is now lower than readState.Index' (duration: 18.113757ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:51.025189Z","caller":"traceutil/trace.go:171","msg":"trace[1273347308] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"218.81582ms","start":"2026-10-03T09:04:50.806346Z","end":"2026-10-03T09:04:51.025161Z","steps":["trace[1273347308] 'process raft request' (duration: 216.219103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:51.025403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.337283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T09:04:51.025496Z","caller":"traceutil/trace.go:171","msg":"trace[1607022959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"237.477585ms","start":"2026-10-03T09:04:50.787994Z","end":"2026-10-03T09:04:51.025472Z","steps":["trace[1607022959] 'agreement among raft nodes before linearized reading' (duration: 237.214032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:51.025922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.276413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:51.026013Z","caller":"traceutil/trace.go:171","msg":"trace[1354282510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"230.412415ms","start":"2026-10-03T09:04:50.795585Z","end":"2026-10-03T09:04:51.025997Z","steps":["trace[1354282510] 'agreement among raft nodes before linearized reading' (duration: 229.729475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:52.05504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13331957822617184836,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-03T09:04:52.113711Z","caller":"traceutil/trace.go:171","msg":"trace[1678630610] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"559.668522ms","start":"2026-10-03T09:04:51.554019Z","end":"2026-10-03T09:04:52.113687Z","steps":["trace[1678630610] 'read index received' (duration: 558.457296ms)","trace[1678630610] 'applied index is now lower than readState.Index' (duration: 1.210136ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:52.113807Z","caller":"traceutil/trace.go:171","msg":"trace[67919638] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"598.884038ms","start":"2026-10-03T09:04:51.514898Z","end":"2026-10-03T09:04:52.113782Z","steps":["trace[67919638] 'process raft request' (duration: 597.872765ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:52.113916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.890386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-10-03T09:04:52.113961Z","caller":"traceutil/trace.go:171","msg":"trace[335662791] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:638; }","duration":"559.979477ms","start":"2026-10-03T09:04:51.553965Z","end":"2026-10-03T09:04:52.113944Z","steps":["trace[335662791] 'agreement among raft nodes before linearized reading' (duration: 559.843175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:52.113995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:51.553945Z","time spent":"560.042018ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-10-03T09:04:52.114025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.715941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"warn","ts":"2026-10-03T09:04:52.114074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.25936ms","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-10-03T09:04:52.114157Z","caller":"traceutil/trace.go:171","msg":"trace[1845721244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"299.368302ms","start":"2026-10-03T09:04:51.814768Z","end":"2026-10-03T09:04:52.114136Z","steps":["trace[1845721244] 'agreement among raft nodes before linearized reading' (duration: 299.18601ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:52.114071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.428204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"warn","ts":"2026-10-03T09:04:52.114178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.932886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-03T09:04:52.114266Z","caller":"traceutil/trace.go:171","msg":"trace[645224769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"297.052238ms","start":"2026-10-03T09:04:51.817196Z","end":"2026-10-03T09:04:52.114248Z","steps":["trace[645224769] 'agreement among raft nodes before linearized reading' (duration: 296.691734ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:52.114261Z","caller":"traceutil/trace.go:171","msg":"trace[443857677] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:638; }","duration":"359.672457ms","start":"2026-10-03T09:04:51.754569Z","end":"2026-10-03T09:04:52.114242Z","steps":["trace[443857677] 'agreement among raft nodes before linearized reading' (duration: 359.284111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:52.114426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:51.75455Z","time spent":"359.85903ms","remote":"127.0.0.1:50422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9342,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-10-03T09:04:52.114093Z","caller":"traceutil/trace.go:171","msg":"trace[911379688] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:638; }","duration":"159.808812ms","start":"2026-10-03T09:04:51.954266Z","end":"2026-10-03T09:04:52.114075Z","steps":["trace[911379688] 'agreement among raft nodes before linearized reading' (duration: 159.6587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:52.114032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:51.514878Z","time spent":"598.98775ms","remote":"127.0.0.1:50484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:04:57.517736Z","caller":"traceutil/trace.go:171","msg":"trace[446632351] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"457.584064ms","start":"2026-10-03T09:04:57.060125Z","end":"2026-10-03T09:04:57.517709Z","steps":["trace[446632351] 'read index received' (duration: 457.427242ms)","trace[446632351] 'applied index is now lower than readState.Index' (duration: 155.862µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:57.517818Z","caller":"traceutil/trace.go:171","msg":"trace[7207079] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"468.182341ms","start":"2026-10-03T09:04:57.049616Z","end":"2026-10-03T09:04:57.517798Z","steps":["trace[7207079] 'process raft request' (duration: 467.944758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:57.517987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:57.049591Z","time spent":"468.309253ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:04:57.518021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.873078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-03T09:04:57.518125Z","caller":"traceutil/trace.go:171","msg":"trace[1245908324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:678; }","duration":"457.980649ms","start":"2026-10-03T09:04:57.060111Z","end":"2026-10-03T09:04:57.518092Z","steps":["trace[1245908324] 'agreement among raft nodes before linearized reading' (duration: 457.725186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:57.518176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:57.060069Z","time spent":"458.098441ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-03T09:04:57.537937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.471931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mrblb\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-03T09:04:57.537994Z","caller":"traceutil/trace.go:171","msg":"trace[947645309] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mrblb; range_end:; response_count:1; response_revision:679; }","duration":"210.567143ms","start":"2026-10-03T09:04:57.327414Z","end":"2026-10-03T09:04:57.537981Z","steps":["trace[947645309] 'agreement among raft nodes before linearized reading' (duration: 210.45488ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:57.66937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.940915ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:04:57.669528Z","caller":"traceutil/trace.go:171","msg":"trace[590754841] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"142.542381ms","start":"2026-10-03T09:04:57.526964Z","end":"2026-10-03T09:04:57.669506Z","steps":["trace[590754841] 'process raft request' (duration: 30.382284ms)","trace[590754841] 'compare' (duration: 111.797552ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:57.682279Z","caller":"traceutil/trace.go:171","msg":"trace[1653996127] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"124.954717ms","start":"2026-10-03T09:04:57.557309Z","end":"2026-10-03T09:04:57.682264Z","steps":["trace[1653996127] 'process raft request' (duration: 124.50326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:58.11864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.185599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:04:58.118726Z","caller":"traceutil/trace.go:171","msg":"trace[1959450055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"325.30801ms","start":"2026-10-03T09:04:57.793399Z","end":"2026-10-03T09:04:58.118707Z","steps":["trace[1959450055] 'range keys from in-memory index tree' (duration: 325.101178ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:58.11877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:57.793366Z","time spent":"325.395542ms","remote":"127.0.0.1:50380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-03T09:04:59.737922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.366166192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-03T09:04:59.737952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.20514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-03T09:04:59.737973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.357504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-03T09:04:59.738011Z","caller":"traceutil/trace.go:171","msg":"trace[1452111718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:684; }","duration":"1.366303514s","start":"2026-10-03T09:04:58.371684Z","end":"2026-10-03T09:04:59.737987Z","steps":["trace[1452111718] 'range keys from in-memory index tree' (duration: 1.36599949s)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:59.738035Z","caller":"traceutil/trace.go:171","msg":"trace[1256287955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"944.343971ms","start":"2026-10-03T09:04:58.793672Z","end":"2026-10-03T09:04:59.738016Z","steps":["trace[1256287955] 'range keys from in-memory index tree' (duration: 944.126589ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:59.737973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330373662s","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-10-03T09:04:59.738071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:58.371658Z","time spent":"1.366397725s","remote":"127.0.0.1:50668","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":"warn","ts":"2026-10-03T09:04:59.73809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:58.793655Z","time spent":"944.424532ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-03T09:04:59.738089Z","caller":"traceutil/trace.go:171","msg":"trace[1314253632] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:684; }","duration":"1.330505704s","start":"2026-10-03T09:04:58.407567Z","end":"2026-10-03T09:04:59.738072Z","steps":["trace[1314253632] 'range keys from in-memory index tree' (duration: 1.330360702s)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:59.738037Z","caller":"traceutil/trace.go:171","msg":"trace[1072280485] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:684; }","duration":"212.464075ms","start":"2026-10-03T09:04:59.525556Z","end":"2026-10-03T09:04:59.738021Z","steps":["trace[1072280485] 'range keys from in-memory index tree' (duration: 212.205302ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:00.466254Z","caller":"traceutil/trace.go:171","msg":"trace[955815823] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"127.712322ms","start":"2026-10-03T09:05:00.338519Z","end":"2026-10-03T09:05:00.466232Z","steps":["trace[955815823] 'process raft request' (duration: 101.416307ms)","trace[955815823] 'compare' (duration: 26.178053ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:00.476382Z","caller":"traceutil/trace.go:171","msg":"trace[887552468] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"120.013915ms","start":"2026-10-03T09:05:00.356293Z","end":"2026-10-03T09:05:00.476307Z","steps":["trace[887552468] 'process raft request' (duration: 119.834633ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.348927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13331957822617185253,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-03T09:05:16.580786Z","caller":"traceutil/trace.go:171","msg":"trace[7684085] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"732.134147ms","start":"2026-10-03T09:05:15.848629Z","end":"2026-10-03T09:05:16.580763Z","steps":["trace[7684085] 'read index received' (duration: 732.012636ms)","trace[7684085] 'applied index is now lower than readState.Index' (duration: 120.571µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:16.580889Z","caller":"traceutil/trace.go:171","msg":"trace[1333965782] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"751.721551ms","start":"2026-10-03T09:05:15.829157Z","end":"2026-10-03T09:05:16.580879Z","steps":["trace[1333965782] 'process raft request' (duration: 751.476198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.580991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:15.829134Z","time spent":"751.780181ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:05:16.581165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.537834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T09:05:16.581198Z","caller":"traceutil/trace.go:171","msg":"trace[117067022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"732.616414ms","start":"2026-10-03T09:05:15.848573Z","end":"2026-10-03T09:05:16.581189Z","steps":["trace[117067022] 'agreement among raft nodes before linearized reading' (duration: 732.513483ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.581221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:15.848552Z","time spent":"732.663825ms","remote":"127.0.0.1:50668","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":"info","ts":"2026-10-03T09:05:16.768398Z","caller":"traceutil/trace.go:171","msg":"trace[1924242546] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"187.486638ms","start":"2026-10-03T09:05:16.580853Z","end":"2026-10-03T09:05:16.768339Z","steps":["trace[1924242546] 'read index received' (duration: 187.241765ms)","trace[1924242546] 'applied index is now lower than readState.Index' (duration: 243.803µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:16.768495Z","caller":"traceutil/trace.go:171","msg":"trace[499846176] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"302.947278ms","start":"2026-10-03T09:05:16.465516Z","end":"2026-10-03T09:05:16.768463Z","steps":["trace[499846176] 'process raft request' (duration: 302.642655ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.768554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.381921ms","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-10-03T09:05:16.768593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.884316ms","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-10-03T09:05:16.768647Z","caller":"traceutil/trace.go:171","msg":"trace[220088704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"375.508334ms","start":"2026-10-03T09:05:16.393117Z","end":"2026-10-03T09:05:16.768625Z","steps":["trace[220088704] 'agreement among raft nodes before linearized reading' (duration: 375.25193ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:16.768658Z","caller":"traceutil/trace.go:171","msg":"trace[741597514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"450.983457ms","start":"2026-10-03T09:05:16.317648Z","end":"2026-10-03T09:05:16.768632Z","steps":["trace[741597514] 'agreement among raft nodes before linearized reading' (duration: 450.844745ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.768661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.813597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-03T09:05:16.768655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:16.465498Z","time spent":"303.06812ms","remote":"127.0.0.1:50634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:05:16.768702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:16.317628Z","time spent":"451.066409ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-03T09:05:16.768702Z","caller":"traceutil/trace.go:171","msg":"trace[774949296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"919.91597ms","start":"2026-10-03T09:05:15.848776Z","end":"2026-10-03T09:05:16.768692Z","steps":["trace[774949296] 'agreement among raft nodes before linearized reading' (duration: 919.714467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.768761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:15.848736Z","time spent":"920.016951ms","remote":"127.0.0.1:50668","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":"warn","ts":"2026-10-03T09:05:16.768812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.730327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-03T09:05:16.768796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:16.393105Z","time spent":"375.674027ms","remote":"127.0.0.1:50668","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":"info","ts":"2026-10-03T09:05:16.768889Z","caller":"traceutil/trace.go:171","msg":"trace[210880985] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:800; }","duration":"722.88184ms","start":"2026-10-03T09:05:16.045993Z","end":"2026-10-03T09:05:16.768875Z","steps":["trace[210880985] 'agreement among raft nodes before linearized reading' (duration: 722.666106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:16.768996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:05:16.045969Z","time spent":"723.002951ms","remote":"127.0.0.1:50484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-10-03T09:05:16.775349Z","caller":"traceutil/trace.go:171","msg":"trace[1257909232] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"190.263046ms","start":"2026-10-03T09:05:16.585069Z","end":"2026-10-03T09:05:16.775332Z","steps":["trace[1257909232] 'process raft request' (duration: 190.148485ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:17.973648Z","caller":"traceutil/trace.go:171","msg":"trace[1604272255] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"180.066815ms","start":"2026-10-03T09:05:17.793547Z","end":"2026-10-03T09:05:17.973614Z","steps":["trace[1604272255] 'read index received' (duration: 157.425481ms)","trace[1604272255] 'applied index is now lower than readState.Index' (duration: 22.640464ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:17.973707Z","caller":"traceutil/trace.go:171","msg":"trace[499207530] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"198.891756ms","start":"2026-10-03T09:05:17.774786Z","end":"2026-10-03T09:05:17.973678Z","steps":["trace[499207530] 'process raft request' (duration: 176.223543ms)","trace[499207530] 'compare' (duration: 22.515281ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:05:17.973802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.243907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:05:17.973839Z","caller":"traceutil/trace.go:171","msg":"trace[1020049329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"180.317367ms","start":"2026-10-03T09:05:17.793511Z","end":"2026-10-03T09:05:17.973828Z","steps":["trace[1020049329] 'agreement among raft nodes before linearized reading' (duration: 180.244576ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:27.102873Z","caller":"traceutil/trace.go:171","msg":"trace[2106025666] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:951; }","duration":"135.266123ms","start":"2026-10-03T09:05:26.967577Z","end":"2026-10-03T09:05:27.102843Z","steps":["trace[2106025666] 'read index received' (duration: 120.57708ms)","trace[2106025666] 'applied index is now lower than readState.Index' (duration: 14.687793ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:27.102932Z","caller":"traceutil/trace.go:171","msg":"trace[898106866] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"157.040262ms","start":"2026-10-03T09:05:26.945859Z","end":"2026-10-03T09:05:27.102899Z","steps":["trace[898106866] 'process raft request' (duration: 142.255737ms)","trace[898106866] 'compare' (duration: 14.598643ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:05:27.10314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.945711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-03T09:05:27.103182Z","caller":"traceutil/trace.go:171","msg":"trace[1837271650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:918; }","duration":"135.025871ms","start":"2026-10-03T09:05:26.968145Z","end":"2026-10-03T09:05:27.103171Z","steps":["trace[1837271650] 'agreement among raft nodes before linearized reading' (duration: 134.859049ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:05:27.103715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.112825ms","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-10-03T09:05:27.103791Z","caller":"traceutil/trace.go:171","msg":"trace[1121311838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:918; }","duration":"136.227387ms","start":"2026-10-03T09:05:26.967546Z","end":"2026-10-03T09:05:27.103773Z","steps":["trace[1121311838] 'agreement among raft nodes before linearized reading' (duration: 135.426776ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:29.105458Z","caller":"traceutil/trace.go:171","msg":"trace[166025166] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"228.383235ms","start":"2026-10-03T09:05:28.877043Z","end":"2026-10-03T09:05:29.105426Z","steps":["trace[166025166] 'process raft request' (duration: 228.215783ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:51.625086Z","caller":"traceutil/trace.go:171","msg":"trace[497710434] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"183.99703ms","start":"2026-10-03T09:05:51.441062Z","end":"2026-10-03T09:05:51.625059Z","steps":["trace[497710434] 'process raft request' (duration: 93.840238ms)","trace[497710434] 'compare' (duration: 90.048741ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:53.109583Z","caller":"traceutil/trace.go:171","msg":"trace[1966029364] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"187.377479ms","start":"2026-10-03T09:05:52.922178Z","end":"2026-10-03T09:05:53.109556Z","steps":["trace[1966029364] 'read index received' (duration: 157.087762ms)","trace[1966029364] 'applied index is now lower than readState.Index' (duration: 30.288507ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:05:53.109814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.617092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-03T09:05:53.109852Z","caller":"traceutil/trace.go:171","msg":"trace[618755838] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1050; }","duration":"187.710113ms","start":"2026-10-03T09:05:52.922131Z","end":"2026-10-03T09:05:53.109841Z","steps":["trace[618755838] 'agreement among raft nodes before linearized reading' (duration: 187.524601ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:53.526126Z","caller":"traceutil/trace.go:171","msg":"trace[998560366] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"178.014419ms","start":"2026-10-03T09:05:53.348055Z","end":"2026-10-03T09:05:53.526069Z","steps":["trace[998560366] 'process raft request' (duration: 177.446732ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:06:07.573277Z","caller":"traceutil/trace.go:171","msg":"trace[531900299] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"306.833918ms","start":"2026-10-03T09:06:07.266417Z","end":"2026-10-03T09:06:07.573251Z","steps":["trace[531900299] 'read index received' (duration: 306.697276ms)","trace[531900299] 'applied index is now lower than readState.Index' (duration: 135.502µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:06:07.573529Z","caller":"traceutil/trace.go:171","msg":"trace[1598939811] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"324.521019ms","start":"2026-10-03T09:06:07.248979Z","end":"2026-10-03T09:06:07.5735Z","steps":["trace[1598939811] 'process raft request' (duration: 324.117704ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:07.573561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.125971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:06:07.573636Z","caller":"traceutil/trace.go:171","msg":"trace[823608098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1096; }","duration":"307.248663ms","start":"2026-10-03T09:06:07.266371Z","end":"2026-10-03T09:06:07.573619Z","steps":["trace[823608098] 'agreement among raft nodes before linearized reading' (duration: 307.09494ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:07.573677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:06:07.266351Z","time spent":"307.315604ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-03T09:06:07.573685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:06:07.248901Z","time spent":"324.717092ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:06:07.57389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.372098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T09:06:07.574143Z","caller":"traceutil/trace.go:171","msg":"trace[829731787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1096; }","duration":"188.738533ms","start":"2026-10-03T09:06:07.385385Z","end":"2026-10-03T09:06:07.574123Z","steps":["trace[829731787] 'agreement among raft nodes before linearized reading' (duration: 188.298768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:07.57394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.778845ms","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-10-03T09:06:07.57426Z","caller":"traceutil/trace.go:171","msg":"trace[1321597860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1096; }","duration":"162.124919ms","start":"2026-10-03T09:06:07.412113Z","end":"2026-10-03T09:06:07.574237Z","steps":["trace[1321597860] 'agreement among raft nodes before linearized reading' (duration: 161.729704ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:07.574041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.469324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-03T09:06:07.574418Z","caller":"traceutil/trace.go:171","msg":"trace[979739702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"170.889399ms","start":"2026-10-03T09:06:07.403516Z","end":"2026-10-03T09:06:07.574406Z","steps":["trace[979739702] 'agreement among raft nodes before linearized reading' (duration: 170.354842ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:06:36.011028Z","caller":"traceutil/trace.go:171","msg":"trace[1963366272] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"147.404487ms","start":"2026-10-03T09:06:35.863599Z","end":"2026-10-03T09:06:36.011004Z","steps":["trace[1963366272] 'process raft request' (duration: 147.242371ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:06:36.285098Z","caller":"traceutil/trace.go:171","msg":"trace[2034553048] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"421.387087ms","start":"2026-10-03T09:06:35.863687Z","end":"2026-10-03T09:06:36.285074Z","steps":["trace[2034553048] 'process raft request' (duration: 420.072705ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:36.285246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:06:35.863665Z","time spent":"421.497972ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:06:36.285325Z","caller":"traceutil/trace.go:171","msg":"trace[2104474127] linearizableReadLoop","detail":"{readStateIndex:1242; appliedIndex:1238; }","duration":"192.242685ms","start":"2026-10-03T09:06:36.093058Z","end":"2026-10-03T09:06:36.285301Z","steps":["trace[2104474127] 'read index received' (duration: 190.619651ms)","trace[2104474127] 'applied index is now lower than readState.Index' (duration: 1.621994ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:06:36.285464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.38341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-03T09:06:36.2855Z","caller":"traceutil/trace.go:171","msg":"trace[1448389774] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1194; }","duration":"192.470793ms","start":"2026-10-03T09:06:36.09302Z","end":"2026-10-03T09:06:36.285491Z","steps":["trace[1448389774] 'agreement among raft nodes before linearized reading' (duration: 192.38056ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:06:36.285535Z","caller":"traceutil/trace.go:171","msg":"trace[1662159303] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"421.535583ms","start":"2026-10-03T09:06:35.863985Z","end":"2026-10-03T09:06:36.28552Z","steps":["trace[1662159303] 'process raft request' (duration: 421.049974ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:06:36.285551Z","caller":"traceutil/trace.go:171","msg":"trace[209321736] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"421.259932ms","start":"2026-10-03T09:06:35.864267Z","end":"2026-10-03T09:06:36.285527Z","steps":["trace[209321736] 'process raft request' (duration: 420.942159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:36.285596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:06:35.863975Z","time spent":"421.587245ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:06:36.285636Z","caller":"traceutil/trace.go:171","msg":"trace[1546876416] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"378.447988ms","start":"2026-10-03T09:06:35.907169Z","end":"2026-10-03T09:06:36.285617Z","steps":["trace[1546876416] 'process raft request' (duration: 378.093645ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:36.285665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:06:35.864259Z","time spent":"421.350696ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:06:36.285733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:06:35.907154Z","time spent":"378.531422ms","remote":"127.0.0.1:50668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:06:52.581716Z","caller":"traceutil/trace.go:171","msg":"trace[743129087] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"101.896871ms","start":"2026-10-03T09:06:52.479797Z","end":"2026-10-03T09:06:52.581694Z","steps":["trace[743129087] 'read index received' (duration: 101.435254ms)","trace[743129087] 'applied index is now lower than readState.Index' (duration: 460.747µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:06:52.581825Z","caller":"traceutil/trace.go:171","msg":"trace[219599474] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"104.541479ms","start":"2026-10-03T09:06:52.477235Z","end":"2026-10-03T09:06:52.581795Z","steps":["trace[219599474] 'process raft request' (duration: 104.270139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:06:52.58192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.096968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T09:06:52.581962Z","caller":"traceutil/trace.go:171","msg":"trace[231753607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"102.178021ms","start":"2026-10-03T09:06:52.479772Z","end":"2026-10-03T09:06:52.58195Z","steps":["trace[231753607] 'agreement among raft nodes before linearized reading' (duration: 102.029796ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:07:12.688733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.223392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:07:12.688913Z","caller":"traceutil/trace.go:171","msg":"trace[318797338] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"147.151946ms","start":"2026-10-03T09:07:12.541737Z","end":"2026-10-03T09:07:12.688889Z","steps":["trace[318797338] 'process raft request' (duration: 43.670314ms)","trace[318797338] 'compare' (duration: 102.997405ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:07:12.843348Z","caller":"traceutil/trace.go:171","msg":"trace[895687589] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"150.071563ms","start":"2026-10-03T09:07:12.693252Z","end":"2026-10-03T09:07:12.843324Z","steps":["trace[895687589] 'process raft request' (duration: 100.592674ms)","trace[895687589] 'compare' (duration: 49.328774ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:07:12.843495Z","caller":"traceutil/trace.go:171","msg":"trace[1283935795] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"149.544616ms","start":"2026-10-03T09:07:12.693926Z","end":"2026-10-03T09:07:12.843471Z","steps":["trace[1283935795] 'process raft request' (duration: 149.35756ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:07:14.955419Z","caller":"traceutil/trace.go:171","msg":"trace[1189171099] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"102.525519ms","start":"2026-10-03T09:07:14.852868Z","end":"2026-10-03T09:07:14.955394Z","steps":["trace[1189171099] 'process raft request' (duration: 102.349723ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:07:15.004231Z","caller":"traceutil/trace.go:171","msg":"trace[281145710] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"151.27098ms","start":"2026-10-03T09:07:14.852934Z","end":"2026-10-03T09:07:15.004205Z","steps":["trace[281145710] 'process raft request' (duration: 132.903166ms)","trace[281145710] 'compare' (duration: 18.271531ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:07:46.448024Z","caller":"traceutil/trace.go:171","msg":"trace[211387430] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"116.448362ms","start":"2026-10-03T09:07:46.331549Z","end":"2026-10-03T09:07:46.447998Z","steps":["trace[211387430] 'process raft request' (duration: 116.215685ms)"],"step_count":1}