{"level":"warn","ts":"2026-07-01T00:44:45.17378Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T00:44:45.173905Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-07-01T00:44:45.173994Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T00:44:45.174009Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-07-01T00:44:45.174036Z","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-07-01T00:44:45.17485Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-07-01T00:44:45.174945Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-07-01T00:44:45.179652Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.424854ms"} {"level":"info","ts":"2026-07-01T00:44:45.19009Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-07-01T00:44:45.190181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T00:44:45.1902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-07-01T00:44:45.190218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T00:44:45.190233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-07-01T00:44:45.190276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-07-01T00:44:45.201291Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T00:44:45.203136Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T00:44:45.204414Z","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-07-01T00:44:45.207604Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T00:44:45.215605Z","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-07-01T00:44:45.215718Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T00:44:45.21593Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T00:44:45.215964Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T00:44:45.217075Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-07-01T00:44:45.218522Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-07-01T00:44:45.218763Z","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-07-01T00:44:45.218803Z","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-07-01T00:44:45.218936Z","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-07-01T00:44:45.219039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-07-01T00:44:45.219224Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-07-01T00:44:45.991726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T00:44:45.991822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T00:44:45.991879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-07-01T00:44:45.991906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-07-01T00:44:45.991922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-07-01T00:44:45.991939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-07-01T00:44:45.991957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-07-01T00:44:45.993179Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:44:45.994065Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T00:44:45.994266Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T00:44:45.994302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T00:44:45.994492Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T00:44:45.994564Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T00:44:45.994855Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:44:45.996119Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:44:45.996165Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:44:45.996707Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T00:44:46.002662Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-07-01T00:44:49.270317Z","caller":"traceutil/trace.go:171","msg":"trace[805916361] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"115.878972ms","start":"2026-07-01T00:44:49.154392Z","end":"2026-07-01T00:44:49.270271Z","steps":["trace[805916361] 'process raft request' (duration: 113.352986ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:44:59.791916Z","caller":"traceutil/trace.go:171","msg":"trace[1527127675] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"110.774ms","start":"2026-07-01T00:44:59.681123Z","end":"2026-07-01T00:44:59.791897Z","steps":["trace[1527127675] 'process raft request' (duration: 110.626438ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:00.145205Z","caller":"traceutil/trace.go:171","msg":"trace[583359185] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"124.289975ms","start":"2026-07-01T00:45:00.020889Z","end":"2026-07-01T00:45:00.145179Z","steps":["trace[583359185] 'process raft request' (duration: 124.114402ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:01.272472Z","caller":"traceutil/trace.go:171","msg":"trace[190595801] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"227.044197ms","start":"2026-07-01T00:45:01.045397Z","end":"2026-07-01T00:45:01.272442Z","steps":["trace[190595801] 'read index received' (duration: 226.860484ms)","trace[190595801] 'applied index is now lower than readState.Index' (duration: 181.873µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:01.272717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.27857ms","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-07-01T00:45:01.272865Z","caller":"traceutil/trace.go:171","msg":"trace[325091572] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:367; }","duration":"227.488983ms","start":"2026-07-01T00:45:01.045356Z","end":"2026-07-01T00:45:01.272845Z","steps":["trace[325091572] 'agreement among raft nodes before linearized reading' (duration: 227.199839ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:01.273394Z","caller":"traceutil/trace.go:171","msg":"trace[986933335] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"437.093988ms","start":"2026-07-01T00:45:00.83541Z","end":"2026-07-01T00:45:01.272504Z","steps":["trace[986933335] 'process raft request' (duration: 436.828344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:01.274134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:00.835398Z","time spent":"438.109871ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:01.275631Z","caller":"traceutil/trace.go:171","msg":"trace[2109389275] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"208.443389ms","start":"2026-07-01T00:45:01.067157Z","end":"2026-07-01T00:45:01.2756Z","steps":["trace[2109389275] 'process raft request' (duration: 208.277827ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:05.403867Z","caller":"traceutil/trace.go:171","msg":"trace[723864167] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"106.247115ms","start":"2026-07-01T00:45:05.29759Z","end":"2026-07-01T00:45:05.403837Z","steps":["trace[723864167] 'process raft request' (duration: 106.035441ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:06.168645Z","caller":"traceutil/trace.go:171","msg":"trace[361643175] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"111.246444ms","start":"2026-07-01T00:45:06.057368Z","end":"2026-07-01T00:45:06.168614Z","steps":["trace[361643175] 'process raft request' (duration: 111.012091ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:12.860893Z","caller":"traceutil/trace.go:171","msg":"trace[623101982] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"147.006616ms","start":"2026-07-01T00:45:12.713866Z","end":"2026-07-01T00:45:12.860872Z","steps":["trace[623101982] 'process raft request' (duration: 82.469158ms)","trace[623101982] 'compare' (duration: 64.354149ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:12.862316Z","caller":"traceutil/trace.go:171","msg":"trace[1446597797] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"144.927856ms","start":"2026-07-01T00:45:12.717373Z","end":"2026-07-01T00:45:12.862301Z","steps":["trace[1446597797] 'process raft request' (duration: 144.853952ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:12.862349Z","caller":"traceutil/trace.go:171","msg":"trace[1749418823] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"148.241792ms","start":"2026-07-01T00:45:12.714089Z","end":"2026-07-01T00:45:12.862331Z","steps":["trace[1749418823] 'process raft request' (duration: 148.031731ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:13.052116Z","caller":"traceutil/trace.go:171","msg":"trace[54939606] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"180.367196ms","start":"2026-07-01T00:45:12.871721Z","end":"2026-07-01T00:45:13.052088Z","steps":["trace[54939606] 'process raft request' (duration: 134.156455ms)","trace[54939606] 'compare' (duration: 45.960708ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:13.052413Z","caller":"traceutil/trace.go:171","msg":"trace[1153461338] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"180.63972ms","start":"2026-07-01T00:45:12.871737Z","end":"2026-07-01T00:45:13.052377Z","steps":["trace[1153461338] 'process raft request' (duration: 180.293682ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:13.052552Z","caller":"traceutil/trace.go:171","msg":"trace[515028696] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"179.709571ms","start":"2026-07-01T00:45:12.872825Z","end":"2026-07-01T00:45:13.052535Z","steps":["trace[515028696] 'process raft request' (duration: 179.578524ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:13.052557Z","caller":"traceutil/trace.go:171","msg":"trace[501710648] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"103.448272ms","start":"2026-07-01T00:45:12.949084Z","end":"2026-07-01T00:45:13.052533Z","steps":["trace[501710648] 'process raft request' (duration: 103.402479ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:13.052623Z","caller":"traceutil/trace.go:171","msg":"trace[727447146] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:420; }","duration":"106.308294ms","start":"2026-07-01T00:45:12.946287Z","end":"2026-07-01T00:45:13.052596Z","steps":["trace[727447146] 'read index received' (duration: 59.599817ms)","trace[727447146] 'applied index is now lower than readState.Index' (duration: 46.704807ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:13.052695Z","caller":"traceutil/trace.go:171","msg":"trace[1630860934] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"180.83007ms","start":"2026-07-01T00:45:12.871854Z","end":"2026-07-01T00:45:13.052684Z","steps":["trace[1630860934] 'process raft request' (duration: 180.43978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:13.052786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.481453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-llndx\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-07-01T00:45:13.052831Z","caller":"traceutil/trace.go:171","msg":"trace[1664413783] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-llndx; range_end:; response_count:1; response_revision:410; }","duration":"106.578378ms","start":"2026-07-01T00:45:12.946242Z","end":"2026-07-01T00:45:13.05282Z","steps":["trace[1664413783] 'agreement among raft nodes before linearized reading' (duration: 106.482443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:13.052843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.148573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-07-01T00:45:13.052916Z","caller":"traceutil/trace.go:171","msg":"trace[141156491] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:410; }","duration":"102.249688ms","start":"2026-07-01T00:45:12.950642Z","end":"2026-07-01T00:45:13.052892Z","steps":["trace[141156491] 'agreement among raft nodes before linearized reading' (duration: 102.108561ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:13.495339Z","caller":"traceutil/trace.go:171","msg":"trace[1627716543] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"179.142006ms","start":"2026-07-01T00:45:13.316168Z","end":"2026-07-01T00:45:13.49531Z","steps":["trace[1627716543] 'process raft request' (duration: 127.519811ms)","trace[1627716543] 'compare' (duration: 51.167851ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:13.610595Z","caller":"traceutil/trace.go:171","msg":"trace[510408480] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"107.241279ms","start":"2026-07-01T00:45:13.503328Z","end":"2026-07-01T00:45:13.610569Z","steps":["trace[510408480] 'process raft request' (duration: 99.317054ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:18.236267Z","caller":"traceutil/trace.go:171","msg":"trace[154466024] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:458; }","duration":"134.820168ms","start":"2026-07-01T00:45:18.101423Z","end":"2026-07-01T00:45:18.236243Z","steps":["trace[154466024] 'read index received' (duration: 134.606357ms)","trace[154466024] 'applied index is now lower than readState.Index' (duration: 212.561µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:18.236341Z","caller":"traceutil/trace.go:171","msg":"trace[1216290447] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"161.719505ms","start":"2026-07-01T00:45:18.074608Z","end":"2026-07-01T00:45:18.236327Z","steps":["trace[1216290447] 'process raft request' (duration: 161.490203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:18.236406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.976326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:18.236435Z","caller":"traceutil/trace.go:171","msg":"trace[1833963567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:441; }","duration":"135.04799ms","start":"2026-07-01T00:45:18.101376Z","end":"2026-07-01T00:45:18.236424Z","steps":["trace[1833963567] 'agreement among raft nodes before linearized reading' (duration: 134.993147ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:24.012865Z","caller":"traceutil/trace.go:171","msg":"trace[376002688] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"235.323397ms","start":"2026-07-01T00:45:23.777514Z","end":"2026-07-01T00:45:24.012838Z","steps":["trace[376002688] 'process raft request' (duration: 235.103797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:24.626936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.033634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T00:45:24.627076Z","caller":"traceutil/trace.go:171","msg":"trace[509421861] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"609.233137ms","start":"2026-07-01T00:45:24.017807Z","end":"2026-07-01T00:45:24.62704Z","steps":["trace[509421861] 'process raft request' (duration: 140.881149ms)","trace[509421861] 'compare' (duration: 467.934809ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:24.627159Z","caller":"traceutil/trace.go:171","msg":"trace[1562197071] linearizableReadLoop","detail":"{readStateIndex:473; appliedIndex:472; }","duration":"488.140613ms","start":"2026-07-01T00:45:24.138995Z","end":"2026-07-01T00:45:24.627135Z","steps":["trace[1562197071] 'read index received' (duration: 19.640507ms)","trace[1562197071] 'applied index is now lower than readState.Index' (duration: 468.498105ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:24.627242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:24.017781Z","time spent":"609.367733ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:45:24.780153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.146557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-01T00:45:24.780192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.150311ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-01T00:45:24.780236Z","caller":"traceutil/trace.go:171","msg":"trace[911180705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:454; }","duration":"641.275663ms","start":"2026-07-01T00:45:24.13894Z","end":"2026-07-01T00:45:24.780216Z","steps":["trace[911180705] 'agreement among raft nodes before linearized reading' (duration: 488.29187ms)","trace[911180705] 'range keys from in-memory index tree' (duration: 152.843697ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:24.780268Z","caller":"traceutil/trace.go:171","msg":"trace[1663002086] linearizableReadLoop","detail":"{readStateIndex:474; appliedIndex:473; }","duration":"153.047996ms","start":"2026-07-01T00:45:24.627203Z","end":"2026-07-01T00:45:24.780251Z","steps":["trace[1663002086] 'read index received' (duration: 54.722µs)","trace[1663002086] 'applied index is now lower than readState.Index' (duration: 152.991594ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:24.780279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:24.138918Z","time spent":"641.351857ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:24.78039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.100037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"warn","ts":"2026-07-01T00:45:24.780389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.689152ms","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-07-01T00:45:24.78044Z","caller":"traceutil/trace.go:171","msg":"trace[1996468792] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:454; }","duration":"595.188221ms","start":"2026-07-01T00:45:24.185239Z","end":"2026-07-01T00:45:24.780427Z","steps":["trace[1996468792] 'agreement among raft nodes before linearized reading' (duration: 595.071216ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:24.780465Z","caller":"traceutil/trace.go:171","msg":"trace[1258834662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:454; }","duration":"257.806737ms","start":"2026-07-01T00:45:24.522641Z","end":"2026-07-01T00:45:24.780448Z","steps":["trace[1258834662] 'agreement among raft nodes before linearized reading' (duration: 257.670141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:24.780488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:24.185219Z","time spent":"595.257545ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12693,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-07-01T00:45:25.088966Z","caller":"traceutil/trace.go:171","msg":"trace[1895275826] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"303.803425ms","start":"2026-07-01T00:45:24.785142Z","end":"2026-07-01T00:45:25.088945Z","steps":["trace[1895275826] 'process raft request' (duration: 303.661839ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:25.08914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:24.785117Z","time spent":"303.952592ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:45:26.15645Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.067599256s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T00:45:26.156828Z","caller":"traceutil/trace.go:171","msg":"trace[1793292410] linearizableReadLoop","detail":"{readStateIndex:476; appliedIndex:474; }","duration":"1.354513402s","start":"2026-07-01T00:45:24.80227Z","end":"2026-07-01T00:45:26.156784Z","steps":["trace[1793292410] 'read index received' (duration: 286.616952ms)","trace[1793292410] 'applied index is now lower than readState.Index' (duration: 1.06789512s)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:26.156948Z","caller":"traceutil/trace.go:171","msg":"trace[1380276587] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"1.370149441s","start":"2026-07-01T00:45:24.786764Z","end":"2026-07-01T00:45:26.156914Z","steps":["trace[1380276587] 'process raft request' (duration: 1.3698883s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:26.15699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354688249s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-07-01T00:45:26.157064Z","caller":"traceutil/trace.go:171","msg":"trace[1314870237] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:456; }","duration":"1.354807124s","start":"2026-07-01T00:45:24.802238Z","end":"2026-07-01T00:45:26.157045Z","steps":["trace[1314870237] 'agreement among raft nodes before linearized reading' (duration: 1.354667188s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:26.157104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:24.802221Z","time spent":"1.354873598s","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12693,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-07-01T00:45:26.157134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:24.786744Z","time spent":"1.370295298s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:45:26.157123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098613329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T00:45:26.157177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.069099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T00:45:26.15726Z","caller":"traceutil/trace.go:171","msg":"trace[1418203742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:456; }","duration":"1.098808227s","start":"2026-07-01T00:45:25.058408Z","end":"2026-07-01T00:45:26.157216Z","steps":["trace[1418203742] 'agreement among raft nodes before linearized reading' (duration: 1.098564856s)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:26.157271Z","caller":"traceutil/trace.go:171","msg":"trace[481991684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:456; }","duration":"140.261588ms","start":"2026-07-01T00:45:26.016991Z","end":"2026-07-01T00:45:26.157252Z","steps":["trace[481991684] 'agreement among raft nodes before linearized reading' (duration: 140.070549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:26.157367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055616221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:26.157472Z","caller":"traceutil/trace.go:171","msg":"trace[2026531749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:456; }","duration":"1.055709295s","start":"2026-07-01T00:45:25.101702Z","end":"2026-07-01T00:45:26.157411Z","steps":["trace[2026531749] 'agreement among raft nodes before linearized reading' (duration: 1.055389231s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:26.157559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:25.101685Z","time spent":"1.055823081s","remote":"127.0.0.1:60404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T00:45:26.157596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:25.058395Z","time spent":"1.099187915s","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T00:45:26.478078Z","caller":"traceutil/trace.go:171","msg":"trace[1027799091] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"316.061962ms","start":"2026-07-01T00:45:26.161982Z","end":"2026-07-01T00:45:26.478044Z","steps":["trace[1027799091] 'process raft request' (duration: 303.54247ms)","trace[1027799091] 'compare' (duration: 12.331224ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:26.478196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.770755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T00:45:26.478248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:26.161965Z","time spent":"316.197018ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:26.478273Z","caller":"traceutil/trace.go:171","msg":"trace[230164624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:457; }","duration":"311.904022ms","start":"2026-07-01T00:45:26.166349Z","end":"2026-07-01T00:45:26.478253Z","steps":["trace[230164624] 'agreement among raft nodes before linearized reading' (duration: 311.776046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:26.478331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:26.166336Z","time spent":"311.985495ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T00:45:26.478138Z","caller":"traceutil/trace.go:171","msg":"trace[1451450899] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"311.532685ms","start":"2026-07-01T00:45:26.166408Z","end":"2026-07-01T00:45:26.477941Z","steps":["trace[1451450899] 'read index received' (duration: 299.038763ms)","trace[1451450899] 'applied index is now lower than readState.Index' (duration: 12.492952ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:27.286519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.568575ms","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-07-01T00:45:27.286628Z","caller":"traceutil/trace.go:171","msg":"trace[82511072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:457; }","duration":"194.715821ms","start":"2026-07-01T00:45:27.091888Z","end":"2026-07-01T00:45:27.286604Z","steps":["trace[82511072] 'range keys from in-memory index tree' (duration: 194.445009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:27.287015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.036951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-01T00:45:27.287093Z","caller":"traceutil/trace.go:171","msg":"trace[1282473355] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:457; }","duration":"656.161456ms","start":"2026-07-01T00:45:26.630914Z","end":"2026-07-01T00:45:27.287076Z","steps":["trace[1282473355] 'range keys from in-memory index tree' (duration: 655.906225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:27.287136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:26.630886Z","time spent":"656.24198ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T00:45:27.496186Z","caller":"traceutil/trace.go:171","msg":"trace[328045794] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"204.220151ms","start":"2026-07-01T00:45:27.291938Z","end":"2026-07-01T00:45:27.496158Z","steps":["trace[328045794] 'process raft request' (duration: 204.050643ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:27.505809Z","caller":"traceutil/trace.go:171","msg":"trace[926665524] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:477; }","duration":"153.577138ms","start":"2026-07-01T00:45:27.352127Z","end":"2026-07-01T00:45:27.505704Z","steps":["trace[926665524] 'read index received' (duration: 143.841476ms)","trace[926665524] 'applied index is now lower than readState.Index' (duration: 9.734571ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:27.50587Z","caller":"traceutil/trace.go:171","msg":"trace[1804914597] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"213.828697ms","start":"2026-07-01T00:45:27.292014Z","end":"2026-07-01T00:45:27.505843Z","steps":["trace[1804914597] 'process raft request' (duration: 213.576245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:27.505926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.784476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:27.506067Z","caller":"traceutil/trace.go:171","msg":"trace[704123071] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:459; }","duration":"153.978385ms","start":"2026-07-01T00:45:27.352077Z","end":"2026-07-01T00:45:27.506055Z","steps":["trace[704123071] 'agreement among raft nodes before linearized reading' (duration: 153.795337ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.418574Z","caller":"traceutil/trace.go:171","msg":"trace[1724239848] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"115.609614ms","start":"2026-07-01T00:45:29.302942Z","end":"2026-07-01T00:45:29.418552Z","steps":["trace[1724239848] 'process raft request' (duration: 115.331392ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.418643Z","caller":"traceutil/trace.go:171","msg":"trace[1069521248] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"107.006212ms","start":"2026-07-01T00:45:29.311595Z","end":"2026-07-01T00:45:29.418601Z","steps":["trace[1069521248] 'process raft request' (duration: 106.858336ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.418695Z","caller":"traceutil/trace.go:171","msg":"trace[1523266785] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"106.983762ms","start":"2026-07-01T00:45:29.311663Z","end":"2026-07-01T00:45:29.418646Z","steps":["trace[1523266785] 'process raft request' (duration: 106.824154ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.418747Z","caller":"traceutil/trace.go:171","msg":"trace[767537537] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"113.887637ms","start":"2026-07-01T00:45:29.304818Z","end":"2026-07-01T00:45:29.418705Z","steps":["trace[767537537] 'process raft request' (duration: 113.573733ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.418909Z","caller":"traceutil/trace.go:171","msg":"trace[967790966] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"107.193161ms","start":"2026-07-01T00:45:29.311701Z","end":"2026-07-01T00:45:29.418894Z","steps":["trace[967790966] 'process raft request' (duration: 106.828934ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.419093Z","caller":"traceutil/trace.go:171","msg":"trace[1349642393] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"101.749859ms","start":"2026-07-01T00:45:29.317316Z","end":"2026-07-01T00:45:29.419066Z","steps":["trace[1349642393] 'process raft request' (duration: 101.264218ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.496979Z","caller":"traceutil/trace.go:171","msg":"trace[417271867] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"128.675835ms","start":"2026-07-01T00:45:29.368277Z","end":"2026-07-01T00:45:29.496952Z","steps":["trace[417271867] 'process raft request' (duration: 117.345212ms)","trace[417271867] 'compare' (duration: 11.113653ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:29.49697Z","caller":"traceutil/trace.go:171","msg":"trace[1921542048] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"125.274234ms","start":"2026-07-01T00:45:29.371675Z","end":"2026-07-01T00:45:29.496949Z","steps":["trace[1921542048] 'process raft request' (duration: 125.19942ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.729592Z","caller":"traceutil/trace.go:171","msg":"trace[366812453] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"134.197789ms","start":"2026-07-01T00:45:29.595371Z","end":"2026-07-01T00:45:29.729568Z","steps":["trace[366812453] 'process raft request' (duration: 119.556419ms)","trace[366812453] 'compare' (duration: 14.547046ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:29.731934Z","caller":"traceutil/trace.go:171","msg":"trace[516581338] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"125.386898ms","start":"2026-07-01T00:45:29.606531Z","end":"2026-07-01T00:45:29.731918Z","steps":["trace[516581338] 'process raft request' (duration: 124.875246ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.970956Z","caller":"traceutil/trace.go:171","msg":"trace[39241678] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"178.442515ms","start":"2026-07-01T00:45:29.792483Z","end":"2026-07-01T00:45:29.970926Z","steps":["trace[39241678] 'process raft request' (duration: 160.264078ms)","trace[39241678] 'compare' (duration: 17.684755ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:29.97101Z","caller":"traceutil/trace.go:171","msg":"trace[1267847063] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"151.884955ms","start":"2026-07-01T00:45:29.819107Z","end":"2026-07-01T00:45:29.970992Z","steps":["trace[1267847063] 'process raft request' (duration: 151.786331ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:29.971445Z","caller":"traceutil/trace.go:171","msg":"trace[1747520812] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"155.687534ms","start":"2026-07-01T00:45:29.815728Z","end":"2026-07-01T00:45:29.971416Z","steps":["trace[1747520812] 'process raft request' (duration: 154.953352ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:30.55701Z","caller":"traceutil/trace.go:171","msg":"trace[1632135322] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"125.698157ms","start":"2026-07-01T00:45:30.431276Z","end":"2026-07-01T00:45:30.556974Z","steps":["trace[1632135322] 'process raft request' (duration: 74.214733ms)","trace[1632135322] 'compare' (duration: 51.204402ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:30.557399Z","caller":"traceutil/trace.go:171","msg":"trace[152562479] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"107.847562ms","start":"2026-07-01T00:45:30.449515Z","end":"2026-07-01T00:45:30.557362Z","steps":["trace[152562479] 'process raft request' (duration: 107.362371ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:31.029443Z","caller":"traceutil/trace.go:171","msg":"trace[1245198472] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"209.92053ms","start":"2026-07-01T00:45:30.819493Z","end":"2026-07-01T00:45:31.029414Z","steps":["trace[1245198472] 'process raft request' (duration: 123.552693ms)","trace[1245198472] 'compare' (duration: 85.725169ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:31.034738Z","caller":"traceutil/trace.go:171","msg":"trace[1716130995] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"202.862398ms","start":"2026-07-01T00:45:30.831845Z","end":"2026-07-01T00:45:31.034708Z","steps":["trace[1716130995] 'process raft request' (duration: 201.920017ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:31.232034Z","caller":"traceutil/trace.go:171","msg":"trace[445898270] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"137.134642ms","start":"2026-07-01T00:45:31.094874Z","end":"2026-07-01T00:45:31.232008Z","steps":["trace[445898270] 'read index received' (duration: 132.842405ms)","trace[445898270] 'applied index is now lower than readState.Index' (duration: 4.291317ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:31.232272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.374612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-07-01T00:45:31.232314Z","caller":"traceutil/trace.go:171","msg":"trace[1214041988] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:572; }","duration":"137.460196ms","start":"2026-07-01T00:45:31.094843Z","end":"2026-07-01T00:45:31.232303Z","steps":["trace[1214041988] 'agreement among raft nodes before linearized reading' (duration: 137.261477ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:31.232121Z","caller":"traceutil/trace.go:171","msg":"trace[760443462] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"152.463909ms","start":"2026-07-01T00:45:31.079622Z","end":"2026-07-01T00:45:31.232086Z","steps":["trace[760443462] 'process raft request' (duration: 148.026756ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:34.999416Z","caller":"traceutil/trace.go:171","msg":"trace[2089849686] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"147.506909ms","start":"2026-07-01T00:45:34.851886Z","end":"2026-07-01T00:45:34.999393Z","steps":["trace[2089849686] 'process raft request' (duration: 147.371063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:35.943565Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279861118176094,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T00:45:36.40942Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.162474682s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T00:45:36.410288Z","caller":"traceutil/trace.go:171","msg":"trace[1664543584] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.163440122s","start":"2026-07-01T00:45:35.24683Z","end":"2026-07-01T00:45:36.41027Z","steps":["trace[1664543584] 'process raft request' (duration: 1.163326378s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.410402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.246811Z","time spent":"1.163540857s","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T00:45:36.422858Z","caller":"traceutil/trace.go:171","msg":"trace[2005800046] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"826.514041ms","start":"2026-07-01T00:45:35.596322Z","end":"2026-07-01T00:45:36.422836Z","steps":["trace[2005800046] 'process raft request' (duration: 826.047331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.422985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.596289Z","time spent":"826.630416ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:36.429165Z","caller":"traceutil/trace.go:171","msg":"trace[855155265] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"576.341028ms","start":"2026-07-01T00:45:35.852793Z","end":"2026-07-01T00:45:36.429134Z","steps":["trace[855155265] 'process raft request' (duration: 575.956803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.429288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.852767Z","time spent":"576.467325ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T00:45:36.429197Z","caller":"traceutil/trace.go:171","msg":"trace[657863560] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"986.398877ms","start":"2026-07-01T00:45:35.442777Z","end":"2026-07-01T00:45:36.429176Z","steps":["trace[657863560] 'read index received' (duration: 967.337856ms)","trace[657863560] 'applied index is now lower than readState.Index' (duration: 19.060261ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:36.429549Z","caller":"traceutil/trace.go:171","msg":"trace[1401625180] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"156.129159ms","start":"2026-07-01T00:45:36.273383Z","end":"2026-07-01T00:45:36.429512Z","steps":["trace[1401625180] 'process raft request' (duration: 155.557475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.429722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.919579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-07-01T00:45:36.429759Z","caller":"traceutil/trace.go:171","msg":"trace[1784449421] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"987.004123ms","start":"2026-07-01T00:45:35.442744Z","end":"2026-07-01T00:45:36.429748Z","steps":["trace[1784449421] 'agreement among raft nodes before linearized reading' (duration: 986.479111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.429898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.44273Z","time spent":"987.156609ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10401,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-07-01T00:45:36.430199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.771125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-01T00:45:36.43023Z","caller":"traceutil/trace.go:171","msg":"trace[1861636879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"840.834519ms","start":"2026-07-01T00:45:35.589387Z","end":"2026-07-01T00:45:36.430221Z","steps":["trace[1861636879] 'agreement among raft nodes before linearized reading' (duration: 840.63933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.430254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.589369Z","time spent":"840.87951ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T00:45:36.430415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.760734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T00:45:36.430441Z","caller":"traceutil/trace.go:171","msg":"trace[104990911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"175.829937ms","start":"2026-07-01T00:45:36.254603Z","end":"2026-07-01T00:45:36.430433Z","steps":["trace[104990911] 'agreement among raft nodes before linearized reading' (duration: 175.745024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.430559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.663122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-07-01T00:45:36.430658Z","caller":"traceutil/trace.go:171","msg":"trace[1632947083] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"787.815618ms","start":"2026-07-01T00:45:35.642817Z","end":"2026-07-01T00:45:36.430633Z","steps":["trace[1632947083] 'agreement among raft nodes before linearized reading' (duration: 787.565027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.430723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.642799Z","time spent":"787.910462ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4107,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-07-01T00:45:36.430837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.869834ms","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-07-01T00:45:36.43087Z","caller":"traceutil/trace.go:171","msg":"trace[194777986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"837.941747ms","start":"2026-07-01T00:45:35.59292Z","end":"2026-07-01T00:45:36.430862Z","steps":["trace[194777986] 'agreement among raft nodes before linearized reading' (duration: 837.835783ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.430893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:35.5929Z","time spent":"837.987189ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:36.430926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.872927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-07-01T00:45:36.430969Z","caller":"traceutil/trace.go:171","msg":"trace[1946794961] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"387.95301ms","start":"2026-07-01T00:45:36.043003Z","end":"2026-07-01T00:45:36.430956Z","steps":["trace[1946794961] 'agreement among raft nodes before linearized reading' (duration: 387.775633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:36.430993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:36.042984Z","time spent":"388.003362ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4204,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-07-01T00:45:42.981608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279861118176199,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T00:45:43.084321Z","caller":"traceutil/trace.go:171","msg":"trace[2065541266] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"603.03636ms","start":"2026-07-01T00:45:42.481259Z","end":"2026-07-01T00:45:43.084296Z","steps":["trace[2065541266] 'process raft request' (duration: 602.866903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.084469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:42.481237Z","time spent":"603.158685ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:43.557539Z","caller":"traceutil/trace.go:171","msg":"trace[1612358071] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:702; }","duration":"1.075999205s","start":"2026-07-01T00:45:42.481508Z","end":"2026-07-01T00:45:43.557507Z","steps":["trace[1612358071] 'read index received' (duration: 602.649234ms)","trace[1612358071] 'applied index is now lower than readState.Index' (duration: 473.348931ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:43.557827Z","caller":"traceutil/trace.go:171","msg":"trace[1622854986] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"813.848536ms","start":"2026-07-01T00:45:42.743896Z","end":"2026-07-01T00:45:43.557744Z","steps":["trace[1622854986] 'process raft request' (duration: 756.671142ms)","trace[1622854986] 'compare' (duration: 56.835551ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:43.557888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075917092s","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-07-01T00:45:43.557966Z","caller":"traceutil/trace.go:171","msg":"trace[912046925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"1.076016996s","start":"2026-07-01T00:45:42.481928Z","end":"2026-07-01T00:45:43.557945Z","steps":["trace[912046925] 'agreement among raft nodes before linearized reading' (duration: 1.075836569s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.557957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.076427412s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-01T00:45:43.558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:42.481918Z","time spent":"1.076075748s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:43.557972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.8914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:43.55801Z","caller":"traceutil/trace.go:171","msg":"trace[148955201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"1.076525506s","start":"2026-07-01T00:45:42.481472Z","end":"2026-07-01T00:45:43.557997Z","steps":["trace[148955201] 'agreement among raft nodes before linearized reading' (duration: 1.076238505s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.558032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.422225ms","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":"warn","ts":"2026-07-01T00:45:43.558052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:42.481454Z","time spent":"1.076589848s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-01T00:45:43.558063Z","caller":"traceutil/trace.go:171","msg":"trace[495870737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"458.062466ms","start":"2026-07-01T00:45:43.099978Z","end":"2026-07-01T00:45:43.558041Z","steps":["trace[495870737] 'agreement among raft nodes before linearized reading' (duration: 457.889339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.558081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:42.743868Z","time spent":"814.076095ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:43.558109Z","caller":"traceutil/trace.go:171","msg":"trace[1532728269] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"526.588852ms","start":"2026-07-01T00:45:43.031504Z","end":"2026-07-01T00:45:43.558092Z","steps":["trace[1532728269] 'agreement among raft nodes before linearized reading' (duration: 526.361463ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.55812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:43.099955Z","time spent":"458.156219ms","remote":"127.0.0.1:60404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T00:45:43.558169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:43.031482Z","time spent":"526.673975ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:43.558179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.524783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T00:45:43.558209Z","caller":"traceutil/trace.go:171","msg":"trace[958228911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:676; }","duration":"933.591876ms","start":"2026-07-01T00:45:42.624607Z","end":"2026-07-01T00:45:43.558199Z","steps":["trace[958228911] 'agreement among raft nodes before linearized reading' (duration: 933.528253ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.558232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:42.624586Z","time spent":"933.641518ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T00:45:43.558121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.511728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f89w4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-01T00:45:43.558331Z","caller":"traceutil/trace.go:171","msg":"trace[849128128] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f89w4; range_end:; response_count:1; response_revision:676; }","duration":"595.743677ms","start":"2026-07-01T00:45:42.962577Z","end":"2026-07-01T00:45:43.558321Z","steps":["trace[849128128] 'agreement among raft nodes before linearized reading' (duration: 595.490267ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.558367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:42.962562Z","time spent":"595.796798ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-f89w4\" "} {"level":"info","ts":"2026-07-01T00:45:43.989078Z","caller":"traceutil/trace.go:171","msg":"trace[1451930421] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"423.832645ms","start":"2026-07-01T00:45:43.565219Z","end":"2026-07-01T00:45:43.989051Z","steps":["trace[1451930421] 'process raft request' (duration: 423.71009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.989547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:43.565182Z","time spent":"424.078294ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:43.989093Z","caller":"traceutil/trace.go:171","msg":"trace[666409997] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"423.898738ms","start":"2026-07-01T00:45:43.565174Z","end":"2026-07-01T00:45:43.989072Z","steps":["trace[666409997] 'process raft request' (duration: 423.587906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.990358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:43.565162Z","time spent":"425.124585ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:43.989696Z","caller":"traceutil/trace.go:171","msg":"trace[1352751746] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"416.184797ms","start":"2026-07-01T00:45:43.57342Z","end":"2026-07-01T00:45:43.989605Z","steps":["trace[1352751746] 'process raft request' (duration: 415.774091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.990805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:43.573405Z","time spent":"417.348742ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:45:43.989706Z","caller":"traceutil/trace.go:171","msg":"trace[1936890870] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"424.386976ms","start":"2026-07-01T00:45:43.565291Z","end":"2026-07-01T00:45:43.989678Z","steps":["trace[1936890870] 'process raft request' (duration: 423.683549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:43.991133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:43.565286Z","time spent":"425.749959ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:45:44.89048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.929179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:44.890599Z","caller":"traceutil/trace.go:171","msg":"trace[1586798158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:681; }","duration":"790.094686ms","start":"2026-07-01T00:45:44.100481Z","end":"2026-07-01T00:45:44.890576Z","steps":["trace[1586798158] 'range keys from in-memory index tree' (duration: 789.782413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:44.89065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:44.100461Z","time spent":"790.176559ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T00:45:44.959296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.623994ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-01T00:45:45.317367Z","caller":"traceutil/trace.go:171","msg":"trace[923177739] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"216.647967ms","start":"2026-07-01T00:45:45.100699Z","end":"2026-07-01T00:45:45.317347Z","steps":["trace[923177739] 'read index received' (duration: 216.46298ms)","trace[923177739] 'applied index is now lower than readState.Index' (duration: 184.097µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:45.317436Z","caller":"traceutil/trace.go:171","msg":"trace[135974002] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"225.782976ms","start":"2026-07-01T00:45:45.091618Z","end":"2026-07-01T00:45:45.317401Z","steps":["trace[135974002] 'process raft request' (duration: 225.558547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:45.317489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.774581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:45.317536Z","caller":"traceutil/trace.go:171","msg":"trace[1116731560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"216.871025ms","start":"2026-07-01T00:45:45.100648Z","end":"2026-07-01T00:45:45.317519Z","steps":["trace[1116731560] 'agreement among raft nodes before linearized reading' (duration: 216.789672ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.535542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213088902s","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-07-01T00:45:48.535635Z","caller":"traceutil/trace.go:171","msg":"trace[166370541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:682; }","duration":"1.213217217s","start":"2026-07-01T00:45:47.322387Z","end":"2026-07-01T00:45:48.535604Z","steps":["trace[166370541] 'range keys from in-memory index tree' (duration: 1.212967987s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.535674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:47.322351Z","time spent":"1.213313141s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T00:45:48.535676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.938037042s","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-07-01T00:45:48.535744Z","caller":"traceutil/trace.go:171","msg":"trace[2017797646] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:682; }","duration":"2.938158657s","start":"2026-07-01T00:45:45.597568Z","end":"2026-07-01T00:45:48.535727Z","steps":["trace[2017797646] 'range keys from in-memory index tree' (duration: 2.937811443s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.535808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:45.597546Z","time spent":"2.93825269s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:48.536174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.541106608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T00:45:48.536212Z","caller":"traceutil/trace.go:171","msg":"trace[2126272141] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:682; }","duration":"2.541176411s","start":"2026-07-01T00:45:45.995026Z","end":"2026-07-01T00:45:48.536202Z","steps":["trace[2126272141] 'range keys from in-memory index tree' (duration: 2.541001524s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.536239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:45.994999Z","time spent":"2.541233733s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T00:45:48.536607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.541311426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-01T00:45:48.536704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.862138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:48.536715Z","caller":"traceutil/trace.go:171","msg":"trace[1411468476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:682; }","duration":"2.54144028s","start":"2026-07-01T00:45:45.995264Z","end":"2026-07-01T00:45:48.536705Z","steps":["trace[1411468476] 'range keys from in-memory index tree' (duration: 2.541019205s)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.536739Z","caller":"traceutil/trace.go:171","msg":"trace[841693866] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"434.92321ms","start":"2026-07-01T00:45:48.101805Z","end":"2026-07-01T00:45:48.536728Z","steps":["trace[841693866] 'range keys from in-memory index tree' (duration: 434.760084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.536746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:45.995257Z","time spent":"2.541480853s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:48.536765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:48.101788Z","time spent":"434.971081ms","remote":"127.0.0.1:60404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T00:45:48.537047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425537515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T00:45:48.537155Z","caller":"traceutil/trace.go:171","msg":"trace[470782477] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:682; }","duration":"1.425752303s","start":"2026-07-01T00:45:47.111376Z","end":"2026-07-01T00:45:48.537128Z","steps":["trace[470782477] 'count revisions from in-memory index tree' (duration: 1.425433371s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.537196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.436357709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T00:45:48.537214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:47.11135Z","time spent":"1.425851397s","remote":"127.0.0.1:60790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-01T00:45:48.537237Z","caller":"traceutil/trace.go:171","msg":"trace[2089019894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"2.436433123s","start":"2026-07-01T00:45:46.100794Z","end":"2026-07-01T00:45:48.537227Z","steps":["trace[2089019894] 'range keys from in-memory index tree' (duration: 2.436262886s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.537214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.541790094s","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-07-01T00:45:48.537348Z","caller":"traceutil/trace.go:171","msg":"trace[687257798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:682; }","duration":"2.54196555s","start":"2026-07-01T00:45:45.995359Z","end":"2026-07-01T00:45:48.537325Z","steps":["trace[687257798] 'range keys from in-memory index tree' (duration: 2.541575096s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.537401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:45.995343Z","time spent":"2.542048743s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T00:45:48.537264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:46.100773Z","time spent":"2.436485124s","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T00:45:48.66487Z","caller":"traceutil/trace.go:171","msg":"trace[1250454813] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"121.856374ms","start":"2026-07-01T00:45:48.542995Z","end":"2026-07-01T00:45:48.664851Z","steps":["trace[1250454813] 'process raft request' (duration: 121.689908ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.665912Z","caller":"traceutil/trace.go:171","msg":"trace[805954474] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"122.664673ms","start":"2026-07-01T00:45:48.543194Z","end":"2026-07-01T00:45:48.665859Z","steps":["trace[805954474] 'process raft request' (duration: 122.372262ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.665963Z","caller":"traceutil/trace.go:171","msg":"trace[567812807] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"122.616952ms","start":"2026-07-01T00:45:48.543284Z","end":"2026-07-01T00:45:48.665901Z","steps":["trace[567812807] 'process raft request' (duration: 122.459076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:48.666227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.304102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:48.666512Z","caller":"traceutil/trace.go:171","msg":"trace[1644921604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:688; }","duration":"118.650914ms","start":"2026-07-01T00:45:48.54785Z","end":"2026-07-01T00:45:48.666501Z","steps":["trace[1644921604] 'agreement among raft nodes before linearized reading' (duration: 118.121664ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.666372Z","caller":"traceutil/trace.go:171","msg":"trace[2050405066] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"122.858451ms","start":"2026-07-01T00:45:48.543492Z","end":"2026-07-01T00:45:48.666351Z","steps":["trace[2050405066] 'process raft request' (duration: 122.334341ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.666399Z","caller":"traceutil/trace.go:171","msg":"trace[1610420112] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"122.884502ms","start":"2026-07-01T00:45:48.543503Z","end":"2026-07-01T00:45:48.666387Z","steps":["trace[1610420112] 'process raft request' (duration: 122.355952ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.666442Z","caller":"traceutil/trace.go:171","msg":"trace[1547123312] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"123.053758ms","start":"2026-07-01T00:45:48.543371Z","end":"2026-07-01T00:45:48.666425Z","steps":["trace[1547123312] 'process raft request' (duration: 122.412724ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:48.665923Z","caller":"traceutil/trace.go:171","msg":"trace[85514268] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:711; }","duration":"118.008561ms","start":"2026-07-01T00:45:48.547891Z","end":"2026-07-01T00:45:48.6659Z","steps":["trace[85514268] 'read index received' (duration: 116.885969ms)","trace[85514268] 'applied index is now lower than readState.Index' (duration: 1.121722ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:46:04.593414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279861118176529,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T00:46:05.094057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279861118176529,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T00:46:05.433303Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.506201301s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T00:46:05.433717Z","caller":"traceutil/trace.go:171","msg":"trace[1786917157] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"1.506717318s","start":"2026-07-01T00:46:03.926981Z","end":"2026-07-01T00:46:05.433698Z","steps":["trace[1786917157] 'process raft request' (duration: 1.506595074s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.43384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:03.926954Z","time spent":"1.506821941s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:46:05.457927Z","caller":"traceutil/trace.go:171","msg":"trace[676908720] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:831; }","duration":"1.365108786s","start":"2026-07-01T00:46:04.092798Z","end":"2026-07-01T00:46:05.457907Z","steps":["trace[676908720] 'read index received' (duration: 1.340759338s)","trace[676908720] 'applied index is now lower than readState.Index' (duration: 24.348238ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:46:05.458122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.754868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T00:46:05.458208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.604848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-01T00:46:05.458244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.39921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:46:05.458289Z","caller":"traceutil/trace.go:171","msg":"trace[678187561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"399.461102ms","start":"2026-07-01T00:46:05.058804Z","end":"2026-07-01T00:46:05.458265Z","steps":["trace[678187561] 'agreement among raft nodes before linearized reading' (duration: 399.419051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.365408215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s5xcv\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-07-01T00:46:05.458326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:05.058786Z","time spent":"399.532664ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T00:46:05.458342Z","caller":"traceutil/trace.go:171","msg":"trace[944922073] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s5xcv; range_end:; response_count:1; response_revision:798; }","duration":"1.365575591s","start":"2026-07-01T00:46:04.09275Z","end":"2026-07-01T00:46:05.458325Z","steps":["trace[944922073] 'agreement among raft nodes before linearized reading' (duration: 1.365255321s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.59209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T00:46:05.458393Z","caller":"traceutil/trace.go:171","msg":"trace[451495406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"714.654313ms","start":"2026-07-01T00:46:04.74373Z","end":"2026-07-01T00:46:05.458385Z","steps":["trace[451495406] 'agreement among raft nodes before linearized reading' (duration: 714.581141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.814648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-01T00:46:05.458387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.09273Z","time spent":"1.365647073s","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s5xcv\" "} {"level":"warn","ts":"2026-07-01T00:46:05.458415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.199391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-01T00:46:05.458446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.743721Z","time spent":"714.718815ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T00:46:05.458442Z","caller":"traceutil/trace.go:171","msg":"trace[212403453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"714.912432ms","start":"2026-07-01T00:46:04.74351Z","end":"2026-07-01T00:46:05.458423Z","steps":["trace[212403453] 'agreement among raft nodes before linearized reading' (duration: 714.732786ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:05.458465Z","caller":"traceutil/trace.go:171","msg":"trace[1438129263] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"715.278694ms","start":"2026-07-01T00:46:04.743174Z","end":"2026-07-01T00:46:05.458452Z","steps":["trace[1438129263] 'agreement among raft nodes before linearized reading' (duration: 715.142409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.743495Z","time spent":"714.986603ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T00:46:05.458501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.743098Z","time spent":"715.395227ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T00:46:05.458151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.741189ms","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-07-01T00:46:05.458604Z","caller":"traceutil/trace.go:171","msg":"trace[1969319450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"716.255625ms","start":"2026-07-01T00:46:04.742338Z","end":"2026-07-01T00:46:05.458594Z","steps":["trace[1969319450] 'agreement among raft nodes before linearized reading' (duration: 715.693097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.742316Z","time spent":"716.308817ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-01T00:46:05.458201Z","caller":"traceutil/trace.go:171","msg":"trace[80490212] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:798; }","duration":"530.899623ms","start":"2026-07-01T00:46:04.927284Z","end":"2026-07-01T00:46:05.458183Z","steps":["trace[80490212] 'agreement among raft nodes before linearized reading' (duration: 530.777209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.927262Z","time spent":"531.45873ms","remote":"127.0.0.1:60846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-01T00:46:05.458231Z","caller":"traceutil/trace.go:171","msg":"trace[1217942525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"713.65019ms","start":"2026-07-01T00:46:04.744574Z","end":"2026-07-01T00:46:05.458224Z","steps":["trace[1217942525] 'agreement among raft nodes before linearized reading' (duration: 713.595218ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.198387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:46:05.459019Z","caller":"traceutil/trace.go:171","msg":"trace[1310192197] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"358.348572ms","start":"2026-07-01T00:46:05.100643Z","end":"2026-07-01T00:46:05.458992Z","steps":["trace[1310192197] 'agreement among raft nodes before linearized reading' (duration: 358.185627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:05.458914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:04.744562Z","time spent":"714.344262ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T00:46:05.459078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:05.100598Z","time spent":"358.467496ms","remote":"127.0.0.1:60404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T00:46:18.912743Z","caller":"traceutil/trace.go:171","msg":"trace[1922620707] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:988; }","duration":"104.35801ms","start":"2026-07-01T00:46:18.808355Z","end":"2026-07-01T00:46:18.912713Z","steps":["trace[1922620707] 'read index received' (duration: 104.194755ms)","trace[1922620707] 'applied index is now lower than readState.Index' (duration: 162.335µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:46:18.912953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.556956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:46:18.912981Z","caller":"traceutil/trace.go:171","msg":"trace[1189458035] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:952; }","duration":"104.669099ms","start":"2026-07-01T00:46:18.808304Z","end":"2026-07-01T00:46:18.912973Z","steps":["trace[1189458035] 'agreement among raft nodes before linearized reading' (duration: 104.547876ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:18.913369Z","caller":"traceutil/trace.go:171","msg":"trace[229554541] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"140.69877ms","start":"2026-07-01T00:46:18.772656Z","end":"2026-07-01T00:46:18.913355Z","steps":["trace[229554541] 'process raft request' (duration: 139.827894ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:19.877644Z","caller":"traceutil/trace.go:171","msg":"trace[1653520075] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"622.008685ms","start":"2026-07-01T00:46:19.255611Z","end":"2026-07-01T00:46:19.877619Z","steps":["trace[1653520075] 'process raft request' (duration: 621.863841ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.8778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.255597Z","time spent":"622.125828ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:46:19.946321Z","caller":"traceutil/trace.go:171","msg":"trace[1144564491] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"499.214847ms","start":"2026-07-01T00:46:19.447079Z","end":"2026-07-01T00:46:19.946294Z","steps":["trace[1144564491] 'process raft request' (duration: 494.499889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.946443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.447035Z","time spent":"499.347911ms","remote":"127.0.0.1:60490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T00:46:19.946348Z","caller":"traceutil/trace.go:171","msg":"trace[1392435342] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:992; }","duration":"414.839731ms","start":"2026-07-01T00:46:19.531439Z","end":"2026-07-01T00:46:19.946279Z","steps":["trace[1392435342] 'read index received' (duration: 346.113503ms)","trace[1392435342] 'applied index is now lower than readState.Index' (duration: 68.724718ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:46:19.946582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.13152ms","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-07-01T00:46:19.946665Z","caller":"traceutil/trace.go:171","msg":"trace[1128977069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:956; }","duration":"415.269174ms","start":"2026-07-01T00:46:19.531378Z","end":"2026-07-01T00:46:19.946648Z","steps":["trace[1128977069] 'agreement among raft nodes before linearized reading' (duration: 415.006307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.946715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.531353Z","time spent":"415.353147ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T00:46:19.946917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.58823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-mggp5\" ","response":"range_response_count:1 size:5673"} {"level":"info","ts":"2026-07-01T00:46:19.946953Z","caller":"traceutil/trace.go:171","msg":"trace[164937344] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-mggp5; range_end:; response_count:1; response_revision:956; }","duration":"407.634801ms","start":"2026-07-01T00:46:19.539309Z","end":"2026-07-01T00:46:19.946944Z","steps":["trace[164937344] 'agreement among raft nodes before linearized reading' (duration: 407.484316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.946974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.539256Z","time spent":"407.713404ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5697,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-mggp5\" "} {"level":"warn","ts":"2026-07-01T00:46:19.947105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.456946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-01T00:46:19.947138Z","caller":"traceutil/trace.go:171","msg":"trace[2065791646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:956; }","duration":"406.510678ms","start":"2026-07-01T00:46:19.540615Z","end":"2026-07-01T00:46:19.947125Z","steps":["trace[2065791646] 'agreement among raft nodes before linearized reading' (duration: 406.428786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.947162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.540599Z","time spent":"406.556349ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T00:46:19.947238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.177753ms","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-07-01T00:46:19.947263Z","caller":"traceutil/trace.go:171","msg":"trace[1516230858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"412.230915ms","start":"2026-07-01T00:46:19.535025Z","end":"2026-07-01T00:46:19.947256Z","steps":["trace[1516230858] 'agreement among raft nodes before linearized reading' (duration: 412.161743ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.947254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.809561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-01T00:46:19.947342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.668276ms","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-07-01T00:46:19.947364Z","caller":"traceutil/trace.go:171","msg":"trace[710982252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:956; }","duration":"414.752719ms","start":"2026-07-01T00:46:19.532605Z","end":"2026-07-01T00:46:19.947358Z","steps":["trace[710982252] 'agreement among raft nodes before linearized reading' (duration: 414.695917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.947442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.532561Z","time spent":"414.874083ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-01T00:46:19.947368Z","caller":"traceutil/trace.go:171","msg":"trace[34022685] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:956; }","duration":"415.040788ms","start":"2026-07-01T00:46:19.532305Z","end":"2026-07-01T00:46:19.947345Z","steps":["trace[34022685] 'agreement among raft nodes before linearized reading' (duration: 414.373528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:19.94756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.532276Z","time spent":"415.226673ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T00:46:19.947283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:19.53501Z","time spent":"412.268187ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T00:46:56.40642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.056686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T00:46:56.406557Z","caller":"traceutil/trace.go:171","msg":"trace[616712658] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"162.411587ms","start":"2026-07-01T00:46:56.244126Z","end":"2026-07-01T00:46:56.406537Z","steps":["trace[616712658] 'process raft request' (duration: 28.138415ms)","trace[616712658] 'compare' (duration: 133.957284ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:46:56.432635Z","caller":"traceutil/trace.go:171","msg":"trace[718190123] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"186.27925ms","start":"2026-07-01T00:46:56.246331Z","end":"2026-07-01T00:46:56.432611Z","steps":["trace[718190123] 'process raft request' (duration: 186.096035ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:56.43285Z","caller":"traceutil/trace.go:171","msg":"trace[1444957166] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"186.26588ms","start":"2026-07-01T00:46:56.24657Z","end":"2026-07-01T00:46:56.432836Z","steps":["trace[1444957166] 'process raft request' (duration: 185.992283ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:56.432876Z","caller":"traceutil/trace.go:171","msg":"trace[716490508] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"186.057855ms","start":"2026-07-01T00:46:56.246795Z","end":"2026-07-01T00:46:56.432853Z","steps":["trace[716490508] 'process raft request' (duration: 185.971643ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:58.500182Z","caller":"traceutil/trace.go:171","msg":"trace[175136235] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"252.55399ms","start":"2026-07-01T00:46:58.247602Z","end":"2026-07-01T00:46:58.500156Z","steps":["trace[175136235] 'process raft request' (duration: 252.387186ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:58.869057Z","caller":"traceutil/trace.go:171","msg":"trace[542218035] linearizableReadLoop","detail":"{readStateIndex:1152; appliedIndex:1151; }","duration":"368.877182ms","start":"2026-07-01T00:46:58.500124Z","end":"2026-07-01T00:46:58.869002Z","steps":["trace[542218035] 'read index received' (duration: 294.231315ms)","trace[542218035] 'applied index is now lower than readState.Index' (duration: 74.644817ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:46:58.869182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.371327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-01T00:46:58.869234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.843149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-01T00:46:58.869244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.817608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T00:46:58.869269Z","caller":"traceutil/trace.go:171","msg":"trace[880182655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"432.91621ms","start":"2026-07-01T00:46:58.436343Z","end":"2026-07-01T00:46:58.869259Z","steps":["trace[880182655] 'agreement among raft nodes before linearized reading' (duration: 432.776067ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:58.86927Z","caller":"traceutil/trace.go:171","msg":"trace[819448987] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1105; }","duration":"373.49857ms","start":"2026-07-01T00:46:58.495746Z","end":"2026-07-01T00:46:58.869245Z","steps":["trace[819448987] 'agreement among raft nodes before linearized reading' (duration: 373.317225ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:58.869285Z","caller":"traceutil/trace.go:171","msg":"trace[2053707754] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"383.509884ms","start":"2026-07-01T00:46:58.485761Z","end":"2026-07-01T00:46:58.869271Z","steps":["trace[2053707754] 'process raft request' (duration: 308.580521ms)","trace[2053707754] 'compare' (duration: 74.457902ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:46:58.869289Z","caller":"traceutil/trace.go:171","msg":"trace[1801738341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1105; }","duration":"432.881499ms","start":"2026-07-01T00:46:58.436395Z","end":"2026-07-01T00:46:58.869276Z","steps":["trace[1801738341] 'agreement among raft nodes before linearized reading' (duration: 432.750486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:58.869304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:58.436332Z","time spent":"432.964211ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T00:46:58.869327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:58.436387Z","time spent":"432.93212ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T00:46:58.869328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:58.495726Z","time spent":"373.587762ms","remote":"127.0.0.1:60842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-07-01T00:46:58.869353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:58.485737Z","time spent":"383.575675ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:46:58.869891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.276259ms","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-07-01T00:46:58.86994Z","caller":"traceutil/trace.go:171","msg":"trace[1944263931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"433.355811ms","start":"2026-07-01T00:46:58.436572Z","end":"2026-07-01T00:46:58.869927Z","steps":["trace[1944263931] 'agreement among raft nodes before linearized reading' (duration: 432.538902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:58.869988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:58.436555Z","time spent":"433.409012ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-01T00:46:58.89737Z","caller":"traceutil/trace.go:171","msg":"trace[1988058848] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"392.957295ms","start":"2026-07-01T00:46:58.50439Z","end":"2026-07-01T00:46:58.897347Z","steps":["trace[1988058848] 'process raft request' (duration: 392.838143ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:58.89756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:58.504366Z","time spent":"393.080908ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:47:00.5809Z","caller":"traceutil/trace.go:171","msg":"trace[1216477239] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"249.940165ms","start":"2026-07-01T00:47:00.330928Z","end":"2026-07-01T00:47:00.580868Z","steps":["trace[1216477239] 'process raft request' (duration: 249.468054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:00.798354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.193043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T00:47:00.798714Z","caller":"traceutil/trace.go:171","msg":"trace[2141034610] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"213.9204ms","start":"2026-07-01T00:47:00.584761Z","end":"2026-07-01T00:47:00.798681Z","steps":["trace[2141034610] 'process raft request' (duration: 69.313147ms)","trace[2141034610] 'compare' (duration: 143.948718ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:01.026534Z","caller":"traceutil/trace.go:171","msg":"trace[1547287618] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"124.600897ms","start":"2026-07-01T00:47:00.901909Z","end":"2026-07-01T00:47:01.02651Z","steps":["trace[1547287618] 'read index received' (duration: 86.748342ms)","trace[1547287618] 'applied index is now lower than readState.Index' (duration: 37.851535ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:01.026678Z","caller":"traceutil/trace.go:171","msg":"trace[1465413688] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"151.277396ms","start":"2026-07-01T00:47:00.875388Z","end":"2026-07-01T00:47:01.026665Z","steps":["trace[1465413688] 'process raft request' (duration: 113.322368ms)","trace[1465413688] 'compare' (duration: 37.688292ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:47:01.026856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.10541ms","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-07-01T00:47:01.026926Z","caller":"traceutil/trace.go:171","msg":"trace[104059415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1113; }","duration":"119.218792ms","start":"2026-07-01T00:47:00.907691Z","end":"2026-07-01T00:47:01.02691Z","steps":["trace[104059415] 'agreement among raft nodes before linearized reading' (duration: 119.000907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:01.02708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.17467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T00:47:01.027109Z","caller":"traceutil/trace.go:171","msg":"trace[449443747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1113; }","duration":"125.243462ms","start":"2026-07-01T00:47:00.901858Z","end":"2026-07-01T00:47:01.027101Z","steps":["trace[449443747] 'agreement among raft nodes before linearized reading' (duration: 125.16951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:01.027217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.68888ms","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-07-01T00:47:01.027245Z","caller":"traceutil/trace.go:171","msg":"trace[1756343584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1113; }","duration":"118.740201ms","start":"2026-07-01T00:47:00.908498Z","end":"2026-07-01T00:47:01.027238Z","steps":["trace[1756343584] 'agreement among raft nodes before linearized reading' (duration: 118.67143ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:01.027373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.200411ms","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-07-01T00:47:01.027402Z","caller":"traceutil/trace.go:171","msg":"trace[1375437493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1113; }","duration":"119.244433ms","start":"2026-07-01T00:47:00.908151Z","end":"2026-07-01T00:47:01.027395Z","steps":["trace[1375437493] 'agreement among raft nodes before linearized reading' (duration: 119.169311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:01.54281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.007125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T00:47:01.542915Z","caller":"traceutil/trace.go:171","msg":"trace[1780325208] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"512.303794ms","start":"2026-07-01T00:47:01.03059Z","end":"2026-07-01T00:47:01.542894Z","steps":["trace[1780325208] 'process raft request' (duration: 108.127416ms)","trace[1780325208] 'compare' (duration: 403.767749ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:47:01.542982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:47:01.03057Z","time spent":"512.377757ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:47:01.76666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.74211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T00:47:01.767012Z","caller":"traceutil/trace.go:171","msg":"trace[2125829624] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1161; }","duration":"661.428887ms","start":"2026-07-01T00:47:01.105563Z","end":"2026-07-01T00:47:01.766992Z","steps":["trace[2125829624] 'read index received' (duration: 33.166356ms)","trace[2125829624] 'applied index is now lower than readState.Index' (duration: 628.261471ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:01.767243Z","caller":"traceutil/trace.go:171","msg":"trace[891503413] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"735.736992ms","start":"2026-07-01T00:47:01.031468Z","end":"2026-07-01T00:47:01.767205Z","steps":["trace[891503413] 'process raft request' (duration: 735.369224ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:01.767233Z","caller":"traceutil/trace.go:171","msg":"trace[1294503288] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"736.285805ms","start":"2026-07-01T00:47:01.030894Z","end":"2026-07-01T00:47:01.76718Z","steps":["trace[1294503288] 'process raft request' (duration: 623.939191ms)","trace[1294503288] 'compare' (duration: 111.585076ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:01.767316Z","caller":"traceutil/trace.go:171","msg":"trace[455948226] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"735.778433ms","start":"2026-07-01T00:47:01.031517Z","end":"2026-07-01T00:47:01.767296Z","steps":["trace[455948226] 'process raft request' (duration: 735.429685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:01.767406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:47:01.031461Z","time spent":"735.856545ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:47:01.76743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:47:01.031494Z","time spent":"735.891737ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:47:01.767447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:47:01.030879Z","time spent":"736.456259ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:47:01.767751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.184775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:47:01.767953Z","caller":"traceutil/trace.go:171","msg":"trace[979706277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1117; }","duration":"662.279627ms","start":"2026-07-01T00:47:01.105529Z","end":"2026-07-01T00:47:01.767809Z","steps":["trace[979706277] 'agreement among raft nodes before linearized reading' (duration: 661.53093ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:01.768043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:47:01.105516Z","time spent":"662.516382ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T00:47:06.045765Z","caller":"traceutil/trace.go:171","msg":"trace[2035252768] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"162.322758ms","start":"2026-07-01T00:47:05.883415Z","end":"2026-07-01T00:47:06.045738Z","steps":["trace[2035252768] 'process raft request' (duration: 118.968969ms)","trace[2035252768] 'compare' (duration: 43.241426ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:07.117862Z","caller":"traceutil/trace.go:171","msg":"trace[130705847] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"267.583334ms","start":"2026-07-01T00:47:06.850257Z","end":"2026-07-01T00:47:07.117841Z","steps":["trace[130705847] 'process raft request' (duration: 267.444931ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:07.29737Z","caller":"traceutil/trace.go:171","msg":"trace[1647864049] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1179; }","duration":"196.50978ms","start":"2026-07-01T00:47:07.100842Z","end":"2026-07-01T00:47:07.297351Z","steps":["trace[1647864049] 'read index received' (duration: 16.87143ms)","trace[1647864049] 'applied index is now lower than readState.Index' (duration: 179.63728ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:47:07.297469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.615843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:47:07.29749Z","caller":"traceutil/trace.go:171","msg":"trace[880724100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"196.683514ms","start":"2026-07-01T00:47:07.1008Z","end":"2026-07-01T00:47:07.297483Z","steps":["trace[880724100] 'agreement among raft nodes before linearized reading' (duration: 196.622623ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:07.297456Z","caller":"traceutil/trace.go:171","msg":"trace[1148650572] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"238.657658ms","start":"2026-07-01T00:47:07.058763Z","end":"2026-07-01T00:47:07.297421Z","steps":["trace[1148650572] 'process raft request' (duration: 235.243881ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:15.465307Z","caller":"traceutil/trace.go:171","msg":"trace[12333363] linearizableReadLoop","detail":"{readStateIndex:1208; appliedIndex:1207; }","duration":"162.95161ms","start":"2026-07-01T00:47:15.302333Z","end":"2026-07-01T00:47:15.465284Z","steps":["trace[12333363] 'read index received' (duration: 162.773366ms)","trace[12333363] 'applied index is now lower than readState.Index' (duration: 176.804µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:15.465436Z","caller":"traceutil/trace.go:171","msg":"trace[991829711] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"263.173004ms","start":"2026-07-01T00:47:15.202234Z","end":"2026-07-01T00:47:15.465407Z","steps":["trace[991829711] 'process raft request' (duration: 262.873467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:15.465474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.106274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:47:15.465514Z","caller":"traceutil/trace.go:171","msg":"trace[939821240] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1157; }","duration":"163.175755ms","start":"2026-07-01T00:47:15.302326Z","end":"2026-07-01T00:47:15.465502Z","steps":["trace[939821240] 'agreement among raft nodes before linearized reading' (duration: 163.057982ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:15.496536Z","caller":"traceutil/trace.go:171","msg":"trace[859513952] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"135.980653ms","start":"2026-07-01T00:47:15.360534Z","end":"2026-07-01T00:47:15.496514Z","steps":["trace[859513952] 'process raft request' (duration: 135.86357ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:20.333209Z","caller":"traceutil/trace.go:171","msg":"trace[666369869] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"116.42717ms","start":"2026-07-01T00:47:20.216757Z","end":"2026-07-01T00:47:20.333185Z","steps":["trace[666369869] 'read index received' (duration: 116.160324ms)","trace[666369869] 'applied index is now lower than readState.Index' (duration: 265.616µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:20.33328Z","caller":"traceutil/trace.go:171","msg":"trace[166906129] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"134.491407ms","start":"2026-07-01T00:47:20.198745Z","end":"2026-07-01T00:47:20.333236Z","steps":["trace[166906129] 'process raft request' (duration: 134.260662ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:20.333612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.85024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4219"} {"level":"info","ts":"2026-07-01T00:47:20.333661Z","caller":"traceutil/trace.go:171","msg":"trace[2047441734] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:1175; }","duration":"116.969042ms","start":"2026-07-01T00:47:20.216679Z","end":"2026-07-01T00:47:20.333648Z","steps":["trace[2047441734] 'agreement among raft nodes before linearized reading' (duration: 116.627525ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:22.25056Z","caller":"traceutil/trace.go:171","msg":"trace[418363823] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"261.140398ms","start":"2026-07-01T00:47:21.989394Z","end":"2026-07-01T00:47:22.250534Z","steps":["trace[418363823] 'process raft request' (duration: 260.974595ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:23.970084Z","caller":"traceutil/trace.go:171","msg":"trace[1704904758] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"108.140969ms","start":"2026-07-01T00:47:23.861928Z","end":"2026-07-01T00:47:23.970069Z","steps":["trace[1704904758] 'process raft request' (duration: 108.043167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:51.058264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.810629ms","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-07-01T00:47:51.058348Z","caller":"traceutil/trace.go:171","msg":"trace[1626320721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1305; }","duration":"263.933111ms","start":"2026-07-01T00:47:50.794398Z","end":"2026-07-01T00:47:51.058331Z","steps":["trace[1626320721] 'range keys from in-memory index tree' (duration: 263.671746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:51.058497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.240948ms","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-07-01T00:47:51.058555Z","caller":"traceutil/trace.go:171","msg":"trace[371420286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1305; }","duration":"147.362641ms","start":"2026-07-01T00:47:50.911179Z","end":"2026-07-01T00:47:51.058542Z","steps":["trace[371420286] 'range keys from in-memory index tree' (duration: 147.061725ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:51.170338Z","caller":"traceutil/trace.go:171","msg":"trace[1662653490] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"108.406425ms","start":"2026-07-01T00:47:51.06191Z","end":"2026-07-01T00:47:51.170316Z","steps":["trace[1662653490] 'process raft request' (duration: 107.516718ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:47:56.808454Z","caller":"traceutil/trace.go:171","msg":"trace[1395385427] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"195.263567ms","start":"2026-07-01T00:47:56.613165Z","end":"2026-07-01T00:47:56.808429Z","steps":["trace[1395385427] 'read index received' (duration: 195.124544ms)","trace[1395385427] 'applied index is now lower than readState.Index' (duration: 137.893µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:47:56.80875Z","caller":"traceutil/trace.go:171","msg":"trace[1313207359] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"573.148497ms","start":"2026-07-01T00:47:56.235575Z","end":"2026-07-01T00:47:56.808723Z","steps":["trace[1313207359] 'process raft request' (duration: 572.710858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:47:56.808793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.610184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-01T00:47:56.808887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:47:56.235557Z","time spent":"573.257448ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:47:56.808926Z","caller":"traceutil/trace.go:171","msg":"trace[1328009875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1330; }","duration":"195.696746ms","start":"2026-07-01T00:47:56.613127Z","end":"2026-07-01T00:47:56.808824Z","steps":["trace[1328009875] 'agreement among raft nodes before linearized reading' (duration: 195.39982ms)"],"step_count":1}