{"level":"warn","ts":"2026-07-02T05:02:20.5253Z","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-02T05:02:20.525393Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-02T05:02:20.525461Z","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-02T05:02:20.525469Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-07-02T05:02:20.525489Z","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-02T05:02:20.526233Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-07-02T05:02:20.526309Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-02T05:02:20.532178Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.687633ms"} {"level":"info","ts":"2026-07-02T05:02:20.540019Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-07-02T05:02:20.540105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T05:02:20.540193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-07-02T05:02:20.540217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T05:02:20.54023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-07-02T05:02:20.540285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-07-02T05:02:20.550009Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T05:02:20.551604Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T05:02:20.552898Z","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-02T05:02:20.55515Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T05:02:20.555767Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T05:02:20.555865Z","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-02T05:02:20.555911Z","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-02T05:02:20.55592Z","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-02T05:02:20.562873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-07-02T05:02:20.563224Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-07-02T05:02:20.565644Z","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-02T05:02:20.56594Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-07-02T05:02:20.565988Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-07-02T05:02:20.56623Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T05:02:20.566278Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T05:02:20.640754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T05:02:20.640793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T05:02:20.640812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-07-02T05:02:20.640954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-07-02T05:02:20.64097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-07-02T05:02:20.641034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-07-02T05:02:20.641092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-07-02T05:02:20.642321Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T05:02:20.642369Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:02:20.642931Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:02:20.642963Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:02:20.643269Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T05:02:20.643328Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T05:02:20.644262Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:02:20.644467Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:02:20.644513Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:02:20.645056Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-07-02T05:02:20.647583Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T05:03:02.763676Z","caller":"traceutil/trace.go:171","msg":"trace[793249064] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"104.035111ms","start":"2026-07-02T05:03:02.659624Z","end":"2026-07-02T05:03:02.763659Z","steps":["trace[793249064] 'read index received' (duration: 103.899784ms)","trace[793249064] 'applied index is now lower than readState.Index' (duration: 134.687µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:02.763847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.170648ms","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-02T05:03:02.763925Z","caller":"traceutil/trace.go:171","msg":"trace[249293654] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"104.286263ms","start":"2026-07-02T05:03:02.659595Z","end":"2026-07-02T05:03:02.763881Z","steps":["trace[249293654] 'agreement among raft nodes before linearized reading' (duration: 104.149976ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:02.764223Z","caller":"traceutil/trace.go:171","msg":"trace[129850161] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"105.624584ms","start":"2026-07-02T05:03:02.658591Z","end":"2026-07-02T05:03:02.764215Z","steps":["trace[129850161] 'process raft request' (duration: 104.98096ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:03.025678Z","caller":"traceutil/trace.go:171","msg":"trace[413230448] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"256.305364ms","start":"2026-07-02T05:03:02.769337Z","end":"2026-07-02T05:03:03.025642Z","steps":["trace[413230448] 'process raft request' (duration: 256.106674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.602452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.767164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:19.602735Z","caller":"traceutil/trace.go:171","msg":"trace[1837462953] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"436.080165ms","start":"2026-07-02T05:03:19.166615Z","end":"2026-07-02T05:03:19.602695Z","steps":["trace[1837462953] 'process raft request' (duration: 15.216283ms)","trace[1837462953] 'compare' (duration: 419.554565ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:19.60292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.166585Z","time spent":"436.232832ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:19.603035Z","caller":"traceutil/trace.go:171","msg":"trace[1885305375] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"432.621834ms","start":"2026-07-02T05:03:19.170367Z","end":"2026-07-02T05:03:19.602989Z","steps":["trace[1885305375] 'process raft request' (duration: 432.374853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.603218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.170355Z","time spent":"432.76873ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:19.603362Z","caller":"traceutil/trace.go:171","msg":"trace[1791899960] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"432.670876ms","start":"2026-07-02T05:03:19.170657Z","end":"2026-07-02T05:03:19.603327Z","steps":["trace[1791899960] 'process raft request' (duration: 432.272008ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:19.60342Z","caller":"traceutil/trace.go:171","msg":"trace[1351853580] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:625; }","duration":"429.748559ms","start":"2026-07-02T05:03:19.173545Z","end":"2026-07-02T05:03:19.603293Z","steps":["trace[1351853580] 'read index received' (duration: 4.620932ms)","trace[1351853580] 'applied index is now lower than readState.Index' (duration: 425.126597ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:19.603563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.170634Z","time spent":"432.795121ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:19.603594Z","caller":"traceutil/trace.go:171","msg":"trace[1165706468] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"418.670716ms","start":"2026-07-02T05:03:19.184902Z","end":"2026-07-02T05:03:19.603572Z","steps":["trace[1165706468] 'process raft request' (duration: 418.273149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.60367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.184834Z","time spent":"418.793462ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:19.603699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.137016ms","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-02T05:03:19.603787Z","caller":"traceutil/trace.go:171","msg":"trace[1605004698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"430.249911ms","start":"2026-07-02T05:03:19.173513Z","end":"2026-07-02T05:03:19.603763Z","steps":["trace[1605004698] 'agreement among raft nodes before linearized reading' (duration: 429.984999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.603865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.173502Z","time spent":"430.349585ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-02T05:03:19.604173Z","caller":"traceutil/trace.go:171","msg":"trace[2011506811] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"399.088473ms","start":"2026-07-02T05:03:19.205065Z","end":"2026-07-02T05:03:19.604153Z","steps":["trace[2011506811] 'process raft request' (duration: 398.401893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.604195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.227136ms","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-02T05:03:19.60425Z","caller":"traceutil/trace.go:171","msg":"trace[1801191758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"429.31103ms","start":"2026-07-02T05:03:19.174924Z","end":"2026-07-02T05:03:19.604235Z","steps":["trace[1801191758] 'agreement among raft nodes before linearized reading' (duration: 429.190445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.604278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.205036Z","time spent":"399.178566ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:19.604293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.174912Z","time spent":"429.369522ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T05:03:19.604384Z","caller":"traceutil/trace.go:171","msg":"trace[2095404758] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"312.398264ms","start":"2026-07-02T05:03:19.291975Z","end":"2026-07-02T05:03:19.604373Z","steps":["trace[2095404758] 'process raft request' (duration: 311.974416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:19.604518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:19.291933Z","time spent":"312.519ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:03:21.890857Z","caller":"traceutil/trace.go:171","msg":"trace[435434175] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"260.71583ms","start":"2026-07-02T05:03:21.630121Z","end":"2026-07-02T05:03:21.890837Z","steps":["trace[435434175] 'process raft request' (duration: 260.592765ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:21.914537Z","caller":"traceutil/trace.go:171","msg":"trace[2015693930] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"283.649219ms","start":"2026-07-02T05:03:21.630834Z","end":"2026-07-02T05:03:21.914484Z","steps":["trace[2015693930] 'process raft request' (duration: 283.489442ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:24.528663Z","caller":"traceutil/trace.go:171","msg":"trace[2032371826] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"241.910416ms","start":"2026-07-02T05:03:24.286729Z","end":"2026-07-02T05:03:24.528639Z","steps":["trace[2032371826] 'process raft request' (duration: 241.366194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.425043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870468879483336,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T05:03:26.56175Z","caller":"traceutil/trace.go:171","msg":"trace[693589099] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"647.751455ms","start":"2026-07-02T05:03:25.913967Z","end":"2026-07-02T05:03:26.561718Z","steps":["trace[693589099] 'process raft request' (duration: 647.573317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.561973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:25.913943Z","time spent":"647.895911ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:26.610317Z","caller":"traceutil/trace.go:171","msg":"trace[316973601] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"686.362108ms","start":"2026-07-02T05:03:25.923926Z","end":"2026-07-02T05:03:26.610288Z","steps":["trace[316973601] 'read index received' (duration: 638.152531ms)","trace[316973601] 'applied index is now lower than readState.Index' (duration: 48.208467ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:26.610447Z","caller":"traceutil/trace.go:171","msg":"trace[1664298979] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"613.146037ms","start":"2026-07-02T05:03:25.997267Z","end":"2026-07-02T05:03:26.610413Z","steps":["trace[1664298979] 'process raft request' (duration: 612.506421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.610808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.224778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T05:03:26.610857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.925941ms","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-02T05:03:26.610963Z","caller":"traceutil/trace.go:171","msg":"trace[1407029900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:683; }","duration":"687.088778ms","start":"2026-07-02T05:03:25.923855Z","end":"2026-07-02T05:03:26.610944Z","steps":["trace[1407029900] 'agreement among raft nodes before linearized reading' (duration: 686.701012ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:26.610958Z","caller":"traceutil/trace.go:171","msg":"trace[2011682275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"494.339132ms","start":"2026-07-02T05:03:26.116523Z","end":"2026-07-02T05:03:26.610862Z","steps":["trace[2011682275] 'agreement among raft nodes before linearized reading' (duration: 494.188246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:26.611078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:25.923825Z","time spent":"687.235493ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T05:03:26.611075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:26.116508Z","time spent":"494.550041ms","remote":"127.0.0.1:38636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T05:03:26.610982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:25.997234Z","time spent":"613.548433ms","remote":"127.0.0.1:38740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:27.064371Z","caller":"traceutil/trace.go:171","msg":"trace[591984876] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"448.552218ms","start":"2026-07-02T05:03:26.615747Z","end":"2026-07-02T05:03:27.064299Z","steps":["trace[591984876] 'process raft request' (duration: 361.789962ms)","trace[591984876] 'compare' (duration: 86.048798ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:27.064633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.993117ms","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-02T05:03:27.0647Z","caller":"traceutil/trace.go:171","msg":"trace[299796917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:687; }","duration":"124.106752ms","start":"2026-07-02T05:03:26.94058Z","end":"2026-07-02T05:03:27.064686Z","steps":["trace[299796917] 'agreement among raft nodes before linearized reading' (duration: 123.891373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:27.064625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:26.615726Z","time spent":"448.767057ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:27.064412Z","caller":"traceutil/trace.go:171","msg":"trace[1856541945] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:711; }","duration":"123.759738ms","start":"2026-07-02T05:03:26.940623Z","end":"2026-07-02T05:03:27.064383Z","steps":["trace[1856541945] 'read index received' (duration: 36.935419ms)","trace[1856541945] 'applied index is now lower than readState.Index' (duration: 86.822959ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:27.06496Z","caller":"traceutil/trace.go:171","msg":"trace[1716673988] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"435.77916ms","start":"2026-07-02T05:03:26.62915Z","end":"2026-07-02T05:03:27.064929Z","steps":["trace[1716673988] 'process raft request' (duration: 435.012969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:27.065061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:26.62913Z","time spent":"435.887844ms","remote":"127.0.0.1:38812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:27.065034Z","caller":"traceutil/trace.go:171","msg":"trace[172990291] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"401.666226ms","start":"2026-07-02T05:03:26.663315Z","end":"2026-07-02T05:03:27.064981Z","steps":["trace[172990291] 'process raft request' (duration: 400.979618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:27.065216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:26.663292Z","time spent":"401.830592ms","remote":"127.0.0.1:39160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:03:27.06561Z","caller":"traceutil/trace.go:171","msg":"trace[1432470100] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"117.14573ms","start":"2026-07-02T05:03:26.947784Z","end":"2026-07-02T05:03:27.06493Z","steps":["trace[1432470100] 'process raft request' (duration: 116.553806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:27.669952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.000525ms","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-02T05:03:27.670064Z","caller":"traceutil/trace.go:171","msg":"trace[1407267668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:688; }","duration":"468.211765ms","start":"2026-07-02T05:03:27.201828Z","end":"2026-07-02T05:03:27.670039Z","steps":["trace[1407267668] 'range keys from in-memory index tree' (duration: 467.714514ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:27.67012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:27.201807Z","time spent":"468.302407ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:03:28.672464Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.13146706s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T05:03:28.673553Z","caller":"traceutil/trace.go:171","msg":"trace[1232560970] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"1.133973551s","start":"2026-07-02T05:03:27.539555Z","end":"2026-07-02T05:03:28.673528Z","steps":["trace[1232560970] 'process raft request' (duration: 1.133424359s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:28.673747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:27.539529Z","time spent":"1.134090385s","remote":"127.0.0.1:38740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:03:28.692975Z","caller":"traceutil/trace.go:171","msg":"trace[1294130664] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:716; }","duration":"126.217172ms","start":"2026-07-02T05:03:28.566735Z","end":"2026-07-02T05:03:28.692952Z","steps":["trace[1294130664] 'read index received' (duration: 106.048119ms)","trace[1294130664] 'applied index is now lower than readState.Index' (duration: 20.167973ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:28.693036Z","caller":"traceutil/trace.go:171","msg":"trace[328035168] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"1.018522443s","start":"2026-07-02T05:03:27.674493Z","end":"2026-07-02T05:03:28.693015Z","steps":["trace[328035168] 'process raft request' (duration: 1.001931523s)","trace[328035168] 'compare' (duration: 16.428154ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:28.693144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:27.674466Z","time spent":"1.018615658s","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:28.693169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.417079ms","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-02T05:03:28.693204Z","caller":"traceutil/trace.go:171","msg":"trace[1692533025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:690; }","duration":"126.495143ms","start":"2026-07-02T05:03:28.5667Z","end":"2026-07-02T05:03:28.693195Z","steps":["trace[1692533025] 'agreement among raft nodes before linearized reading' (duration: 126.375679ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:29.937232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.887547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:29.937316Z","caller":"traceutil/trace.go:171","msg":"trace[421391044] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:703; }","duration":"147.994131ms","start":"2026-07-02T05:03:29.789304Z","end":"2026-07-02T05:03:29.937298Z","steps":["trace[421391044] 'count revisions from in-memory index tree' (duration: 147.842854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:29.937412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.23866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:29.937554Z","caller":"traceutil/trace.go:171","msg":"trace[289547504] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:703; }","duration":"148.387797ms","start":"2026-07-02T05:03:29.789113Z","end":"2026-07-02T05:03:29.937501Z","steps":["trace[289547504] 'range keys from in-memory index tree' (duration: 148.036382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:29.937196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.900497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:29.938025Z","caller":"traceutil/trace.go:171","msg":"trace[1636408772] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:703; }","duration":"148.749431ms","start":"2026-07-02T05:03:29.789233Z","end":"2026-07-02T05:03:29.937982Z","steps":["trace[1636408772] 'range keys from in-memory index tree' (duration: 147.852385ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:33.915484Z","caller":"traceutil/trace.go:171","msg":"trace[1696601820] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"111.759506ms","start":"2026-07-02T05:03:33.803706Z","end":"2026-07-02T05:03:33.915465Z","steps":["trace[1696601820] 'process raft request' (duration: 111.648452ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:38.858361Z","caller":"traceutil/trace.go:171","msg":"trace[919213513] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"108.640659ms","start":"2026-07-02T05:03:38.749703Z","end":"2026-07-02T05:03:38.858344Z","steps":["trace[919213513] 'read index received' (duration: 108.555006ms)","trace[919213513] 'applied index is now lower than readState.Index' (duration: 84.633µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:38.858426Z","caller":"traceutil/trace.go:171","msg":"trace[622190841] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"125.170996ms","start":"2026-07-02T05:03:38.733206Z","end":"2026-07-02T05:03:38.858377Z","steps":["trace[622190841] 'process raft request' (duration: 124.99338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:38.858793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.056364ms","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-02T05:03:38.858884Z","caller":"traceutil/trace.go:171","msg":"trace[104770643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"109.194269ms","start":"2026-07-02T05:03:38.74967Z","end":"2026-07-02T05:03:38.858864Z","steps":["trace[104770643] 'agreement among raft nodes before linearized reading' (duration: 108.763563ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:39.025529Z","caller":"traceutil/trace.go:171","msg":"trace[1937516256] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"161.469721ms","start":"2026-07-02T05:03:38.864035Z","end":"2026-07-02T05:03:39.025505Z","steps":["trace[1937516256] 'process raft request' (duration: 66.032768ms)","trace[1937516256] 'compare' (duration: 95.310778ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:39.455487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.90846ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T05:03:39.455574Z","caller":"traceutil/trace.go:171","msg":"trace[1483133171] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:835; }","duration":"310.064908ms","start":"2026-07-02T05:03:39.145495Z","end":"2026-07-02T05:03:39.45556Z","steps":["trace[1483133171] 'read index received' (duration: 136.50896ms)","trace[1483133171] 'applied index is now lower than readState.Index' (duration: 173.554598ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:39.455795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.175313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T05:03:39.455857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.514649ms","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-02T05:03:39.455894Z","caller":"traceutil/trace.go:171","msg":"trace[432135281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"310.39138ms","start":"2026-07-02T05:03:39.145483Z","end":"2026-07-02T05:03:39.455875Z","steps":["trace[432135281] 'agreement among raft nodes before linearized reading' (duration: 310.133231ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:39.455887Z","caller":"traceutil/trace.go:171","msg":"trace[611397150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"309.55334ms","start":"2026-07-02T05:03:39.146326Z","end":"2026-07-02T05:03:39.455879Z","steps":["trace[611397150] 'agreement among raft nodes before linearized reading' (duration: 309.311612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:39.455984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:39.146266Z","time spent":"309.710076ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T05:03:39.45598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:39.145478Z","time spent":"310.487543ms","remote":"127.0.0.1:38636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T05:03:39.456216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.039026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T05:03:39.456336Z","caller":"traceutil/trace.go:171","msg":"trace[733765764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"272.276385ms","start":"2026-07-02T05:03:39.184044Z","end":"2026-07-02T05:03:39.456321Z","steps":["trace[733765764] 'agreement among raft nodes before linearized reading' (duration: 271.758827ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:40.313774Z","caller":"traceutil/trace.go:171","msg":"trace[824069178] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"127.504606ms","start":"2026-07-02T05:03:40.186243Z","end":"2026-07-02T05:03:40.313747Z","steps":["trace[824069178] 'process raft request' (duration: 127.308519ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:40.406146Z","caller":"traceutil/trace.go:171","msg":"trace[2108685703] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"140.171766ms","start":"2026-07-02T05:03:40.265937Z","end":"2026-07-02T05:03:40.406109Z","steps":["trace[2108685703] 'process raft request' (duration: 130.598146ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:40.423455Z","caller":"traceutil/trace.go:171","msg":"trace[2037636222] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"103.928219ms","start":"2026-07-02T05:03:40.319495Z","end":"2026-07-02T05:03:40.423424Z","steps":["trace[2037636222] 'process raft request' (duration: 103.836036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:40.423754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.451998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6kzqr\" ","response":"range_response_count:1 size:3043"} {"level":"info","ts":"2026-07-02T05:03:40.423789Z","caller":"traceutil/trace.go:171","msg":"trace[999087376] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6kzqr; range_end:; response_count:1; response_revision:816; }","duration":"104.519171ms","start":"2026-07-02T05:03:40.319258Z","end":"2026-07-02T05:03:40.423777Z","steps":["trace[999087376] 'agreement among raft nodes before linearized reading' (duration: 104.393576ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:40.579412Z","caller":"traceutil/trace.go:171","msg":"trace[1980602381] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"145.595658ms","start":"2026-07-02T05:03:40.433755Z","end":"2026-07-02T05:03:40.579351Z","steps":["trace[1980602381] 'process raft request' (duration: 139.985059ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:41.035591Z","caller":"traceutil/trace.go:171","msg":"trace[1827067204] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"168.011724ms","start":"2026-07-02T05:03:40.867554Z","end":"2026-07-02T05:03:41.035566Z","steps":["trace[1827067204] 'process raft request' (duration: 167.887339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:41.232019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.562064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:41.232111Z","caller":"traceutil/trace.go:171","msg":"trace[1001126464] linearizableReadLoop","detail":"{readStateIndex:852; appliedIndex:851; }","duration":"122.139235ms","start":"2026-07-02T05:03:41.109958Z","end":"2026-07-02T05:03:41.232097Z","steps":["trace[1001126464] 'read index received' (duration: 10.294432ms)","trace[1001126464] 'applied index is now lower than readState.Index' (duration: 111.843703ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:41.23215Z","caller":"traceutil/trace.go:171","msg":"trace[2088990095] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"193.247516ms","start":"2026-07-02T05:03:41.038887Z","end":"2026-07-02T05:03:41.232134Z","steps":["trace[2088990095] 'process raft request' (duration: 81.482296ms)","trace[2088990095] 'compare' (duration: 111.4662ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:41.23216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.212558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:41.232186Z","caller":"traceutil/trace.go:171","msg":"trace[780799595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:819; }","duration":"122.286271ms","start":"2026-07-02T05:03:41.109891Z","end":"2026-07-02T05:03:41.232177Z","steps":["trace[780799595] 'agreement among raft nodes before linearized reading' (duration: 122.242979ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:41.392428Z","caller":"traceutil/trace.go:171","msg":"trace[661014939] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"138.214722ms","start":"2026-07-02T05:03:41.254167Z","end":"2026-07-02T05:03:41.392382Z","steps":["trace[661014939] 'process raft request' (duration: 117.437601ms)","trace[661014939] 'compare' (duration: 20.550663ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:45.177985Z","caller":"traceutil/trace.go:171","msg":"trace[1442902700] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"106.988441ms","start":"2026-07-02T05:03:45.07097Z","end":"2026-07-02T05:03:45.177959Z","steps":["trace[1442902700] 'process raft request' (duration: 106.787244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:49.396196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430535347s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:49.396317Z","caller":"traceutil/trace.go:171","msg":"trace[1338702965] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:897; }","duration":"1.375716915s","start":"2026-07-02T05:03:48.02058Z","end":"2026-07-02T05:03:49.396296Z","steps":["trace[1338702965] 'read index received' (duration: 44.081µs)","trace[1338702965] 'applied index is now lower than readState.Index' (duration: 1.375670664s)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:49.396499Z","caller":"traceutil/trace.go:171","msg":"trace[1177516706] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"1.677377549s","start":"2026-07-02T05:03:47.719099Z","end":"2026-07-02T05:03:49.396477Z","steps":["trace[1177516706] 'process raft request' (duration: 246.433908ms)","trace[1177516706] 'compare' (duration: 1.430109164s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:49.396617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:47.719077Z","time spent":"1.677481793s","remote":"127.0.0.1:38812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4022,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:03:49.396629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376003184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:03:49.396781Z","caller":"traceutil/trace.go:171","msg":"trace[1718639447] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:864; }","duration":"1.376190221s","start":"2026-07-02T05:03:48.020533Z","end":"2026-07-02T05:03:49.396723Z","steps":["trace[1718639447] 'agreement among raft nodes before linearized reading' (duration: 1.375986584s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:49.39692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:48.020514Z","time spent":"1.376382737s","remote":"127.0.0.1:38810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:03:49.530295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.516224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:03:49.530353Z","caller":"traceutil/trace.go:171","msg":"trace[2063882852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:864; }","duration":"417.624987ms","start":"2026-07-02T05:03:49.112718Z","end":"2026-07-02T05:03:49.530343Z","steps":["trace[2063882852] 'agreement among raft nodes before linearized reading' (duration: 417.508233ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:49.530348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.935261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T05:03:49.530396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:49.1127Z","time spent":"417.689119ms","remote":"127.0.0.1:38642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T05:03:49.530421Z","caller":"traceutil/trace.go:171","msg":"trace[47045359] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:864; }","duration":"783.020574ms","start":"2026-07-02T05:03:48.74738Z","end":"2026-07-02T05:03:49.5304Z","steps":["trace[47045359] 'agreement among raft nodes before linearized reading' (duration: 782.89435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:49.530419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.428211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-02T05:03:49.530472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:48.747323Z","time spent":"783.139348ms","remote":"127.0.0.1:38838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-07-02T05:03:49.530499Z","caller":"traceutil/trace.go:171","msg":"trace[1462674643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:864; }","duration":"327.553126ms","start":"2026-07-02T05:03:49.202928Z","end":"2026-07-02T05:03:49.530481Z","steps":["trace[1462674643] 'agreement among raft nodes before linearized reading' (duration: 327.292467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:49.530539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:49.202912Z","time spent":"327.619427ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:03:49.53061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.95868ms","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-02T05:03:49.530692Z","caller":"traceutil/trace.go:171","msg":"trace[83597130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:864; }","duration":"253.083174ms","start":"2026-07-02T05:03:49.277592Z","end":"2026-07-02T05:03:49.530675Z","steps":["trace[83597130] 'agreement among raft nodes before linearized reading' (duration: 252.6671ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:49.530196Z","caller":"traceutil/trace.go:171","msg":"trace[241263179] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:898; }","duration":"133.818636ms","start":"2026-07-02T05:03:49.396352Z","end":"2026-07-02T05:03:49.53017Z","steps":["trace[241263179] 'read index received' (duration: 34.558672ms)","trace[241263179] 'applied index is now lower than readState.Index' (duration: 99.258404ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:49.530948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.245433ms","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-02T05:03:49.531018Z","caller":"traceutil/trace.go:171","msg":"trace[1787951856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:864; }","duration":"986.353046ms","start":"2026-07-02T05:03:48.544654Z","end":"2026-07-02T05:03:49.531007Z","steps":["trace[1787951856] 'agreement among raft nodes before linearized reading' (duration: 986.218552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:49.531047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:03:48.544636Z","time spent":"986.403608ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T05:03:55.843473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.601034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:03:55.843736Z","caller":"traceutil/trace.go:171","msg":"trace[1557598699] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"206.120523ms","start":"2026-07-02T05:03:55.637599Z","end":"2026-07-02T05:03:55.84372Z","steps":["trace[1557598699] 'process raft request' (duration: 206.009739ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:55.843714Z","caller":"traceutil/trace.go:171","msg":"trace[248926623] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:964; }","duration":"204.989678ms","start":"2026-07-02T05:03:55.638698Z","end":"2026-07-02T05:03:55.843688Z","steps":["trace[248926623] 'read index received' (duration: 19.073924ms)","trace[248926623] 'applied index is now lower than readState.Index' (duration: 185.914014ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:55.843856Z","caller":"traceutil/trace.go:171","msg":"trace[294643152] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"206.626869ms","start":"2026-07-02T05:03:55.637212Z","end":"2026-07-02T05:03:55.843839Z","steps":["trace[294643152] 'process raft request' (duration: 20.55705ms)","trace[294643152] 'compare' (duration: 185.358926ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:03:55.843917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.218505ms","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-02T05:03:55.843967Z","caller":"traceutil/trace.go:171","msg":"trace[1657356380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:930; }","duration":"205.296637ms","start":"2026-07-02T05:03:55.638652Z","end":"2026-07-02T05:03:55.843948Z","steps":["trace[1657356380] 'agreement among raft nodes before linearized reading' (duration: 205.147472ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:56.041051Z","caller":"traceutil/trace.go:171","msg":"trace[1459324861] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"185.567344ms","start":"2026-07-02T05:03:55.855382Z","end":"2026-07-02T05:03:56.04095Z","steps":["trace[1459324861] 'process raft request' (duration: 125.815391ms)","trace[1459324861] 'compare' (duration: 59.583368ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:56.354316Z","caller":"traceutil/trace.go:171","msg":"trace[981302102] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"110.706942ms","start":"2026-07-02T05:03:56.243578Z","end":"2026-07-02T05:03:56.354285Z","steps":["trace[981302102] 'process raft request' (duration: 107.394759ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:56.479682Z","caller":"traceutil/trace.go:171","msg":"trace[2093396278] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"235.653913ms","start":"2026-07-02T05:03:56.243992Z","end":"2026-07-02T05:03:56.479646Z","steps":["trace[2093396278] 'process raft request' (duration: 211.407003ms)","trace[2093396278] 'compare' (duration: 23.971812ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:56.479923Z","caller":"traceutil/trace.go:171","msg":"trace[883041902] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:971; }","duration":"119.449292ms","start":"2026-07-02T05:03:56.360452Z","end":"2026-07-02T05:03:56.479902Z","steps":["trace[883041902] 'read index received' (duration: 94.965035ms)","trace[883041902] 'applied index is now lower than readState.Index' (duration: 24.483277ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:03:56.480008Z","caller":"traceutil/trace.go:171","msg":"trace[891458693] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"232.476215ms","start":"2026-07-02T05:03:56.247524Z","end":"2026-07-02T05:03:56.48Z","steps":["trace[891458693] 'process raft request' (duration: 232.037511ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:03:56.480096Z","caller":"traceutil/trace.go:171","msg":"trace[1289255480] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"119.168533ms","start":"2026-07-02T05:03:56.360905Z","end":"2026-07-02T05:03:56.480074Z","steps":["trace[1289255480] 'process raft request' (duration: 118.924076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:03:56.480408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.926936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-nmk2k\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-07-02T05:03:56.480463Z","caller":"traceutil/trace.go:171","msg":"trace[1194276791] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-nmk2k; range_end:; response_count:1; response_revision:938; }","duration":"120.03827ms","start":"2026-07-02T05:03:56.360411Z","end":"2026-07-02T05:03:56.48045Z","steps":["trace[1194276791] 'agreement among raft nodes before linearized reading' (duration: 119.570525ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:03.320586Z","caller":"traceutil/trace.go:171","msg":"trace[1886212039] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"151.19481ms","start":"2026-07-02T05:04:03.169371Z","end":"2026-07-02T05:04:03.320565Z","steps":["trace[1886212039] 'process raft request' (duration: 151.077206ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:03.684268Z","caller":"traceutil/trace.go:171","msg":"trace[53820156] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"268.808298ms","start":"2026-07-02T05:04:03.415434Z","end":"2026-07-02T05:04:03.684242Z","steps":["trace[53820156] 'read index received' (duration: 268.749066ms)","trace[53820156] 'applied index is now lower than readState.Index' (duration: 58.062µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:03.684398Z","caller":"traceutil/trace.go:171","msg":"trace[1245849711] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"322.760955ms","start":"2026-07-02T05:04:03.361625Z","end":"2026-07-02T05:04:03.684386Z","steps":["trace[1245849711] 'process raft request' (duration: 322.539889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:03.684501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:03.361605Z","time spent":"322.823328ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:04:03.684567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.323195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-wk65s\" ","response":"range_response_count:1 size:4881"} {"level":"info","ts":"2026-07-02T05:04:03.68457Z","caller":"traceutil/trace.go:171","msg":"trace[1400564133] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"355.904334ms","start":"2026-07-02T05:04:03.328642Z","end":"2026-07-02T05:04:03.684546Z","steps":["trace[1400564133] 'process raft request' (duration: 355.389519ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:03.684624Z","caller":"traceutil/trace.go:171","msg":"trace[1088167056] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-wk65s; range_end:; response_count:1; response_revision:1023; }","duration":"201.421098ms","start":"2026-07-02T05:04:03.48319Z","end":"2026-07-02T05:04:03.684611Z","steps":["trace[1088167056] 'agreement among raft nodes before linearized reading' (duration: 201.251863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:03.684634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.178039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-wk65s\" ","response":"range_response_count:1 size:2274"} {"level":"warn","ts":"2026-07-02T05:04:03.684705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:04:03.328617Z","time spent":"356.015378ms","remote":"127.0.0.1:39116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:04:03.684715Z","caller":"traceutil/trace.go:171","msg":"trace[283177946] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-wk65s; range_end:; response_count:1; response_revision:1023; }","duration":"269.265701ms","start":"2026-07-02T05:04:03.415429Z","end":"2026-07-02T05:04:03.684694Z","steps":["trace[283177946] 'agreement among raft nodes before linearized reading' (duration: 269.037235ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:26.167238Z","caller":"traceutil/trace.go:171","msg":"trace[2137345834] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"128.834604ms","start":"2026-07-02T05:04:26.038378Z","end":"2026-07-02T05:04:26.167213Z","steps":["trace[2137345834] 'process raft request' (duration: 53.515651ms)","trace[2137345834] 'compare' (duration: 75.146389ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:26.167273Z","caller":"traceutil/trace.go:171","msg":"trace[524182203] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"126.762863ms","start":"2026-07-02T05:04:26.040472Z","end":"2026-07-02T05:04:26.167234Z","steps":["trace[524182203] 'process raft request' (duration: 126.692171ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:26.356809Z","caller":"traceutil/trace.go:171","msg":"trace[2120966175] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"158.523123ms","start":"2026-07-02T05:04:26.198258Z","end":"2026-07-02T05:04:26.356781Z","steps":["trace[2120966175] 'read index received' (duration: 133.374448ms)","trace[2120966175] 'applied index is now lower than readState.Index' (duration: 25.143715ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:26.35683Z","caller":"traceutil/trace.go:171","msg":"trace[551011129] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"185.062933ms","start":"2026-07-02T05:04:26.171742Z","end":"2026-07-02T05:04:26.356805Z","steps":["trace[551011129] 'process raft request' (duration: 159.817585ms)","trace[551011129] 'compare' (duration: 25.073104ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:26.357114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.836691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T05:04:26.357239Z","caller":"traceutil/trace.go:171","msg":"trace[964300978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1118; }","duration":"159.021565ms","start":"2026-07-02T05:04:26.198182Z","end":"2026-07-02T05:04:26.357204Z","steps":["trace[964300978] 'agreement among raft nodes before linearized reading' (duration: 158.689397ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.172154Z","caller":"traceutil/trace.go:171","msg":"trace[308889216] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"227.820759ms","start":"2026-07-02T05:04:31.944277Z","end":"2026-07-02T05:04:32.172098Z","steps":["trace[308889216] 'process raft request' (duration: 227.641445ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.356955Z","caller":"traceutil/trace.go:171","msg":"trace[1069591151] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1177; }","duration":"244.336426ms","start":"2026-07-02T05:04:32.112571Z","end":"2026-07-02T05:04:32.356907Z","steps":["trace[1069591151] 'read index received' (duration: 59.339422ms)","trace[1069591151] 'applied index is now lower than readState.Index' (duration: 184.994554ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:04:32.357428Z","caller":"traceutil/trace.go:171","msg":"trace[358265058] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"294.213882ms","start":"2026-07-02T05:04:32.063182Z","end":"2026-07-02T05:04:32.357396Z","steps":["trace[358265058] 'process raft request' (duration: 195.345552ms)","trace[358265058] 'compare' (duration: 98.135553ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:32.357664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.068624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:04:32.357747Z","caller":"traceutil/trace.go:171","msg":"trace[1890775659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1135; }","duration":"245.201717ms","start":"2026-07-02T05:04:32.112529Z","end":"2026-07-02T05:04:32.35773Z","steps":["trace[1890775659] 'agreement among raft nodes before linearized reading' (duration: 245.063694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:32.357832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.803584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:04:32.357881Z","caller":"traceutil/trace.go:171","msg":"trace[486367191] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1135; }","duration":"233.889147ms","start":"2026-07-02T05:04:32.12398Z","end":"2026-07-02T05:04:32.35787Z","steps":["trace[486367191] 'agreement among raft nodes before linearized reading' (duration: 233.793614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:32.358282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.918829ms","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-02T05:04:32.358359Z","caller":"traceutil/trace.go:171","msg":"trace[1069273347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1135; }","duration":"169.018352ms","start":"2026-07-02T05:04:32.189331Z","end":"2026-07-02T05:04:32.358349Z","steps":["trace[1069273347] 'agreement among raft nodes before linearized reading' (duration: 168.880619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:32.358528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.415823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-02T05:04:32.35859Z","caller":"traceutil/trace.go:171","msg":"trace[468588432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1135; }","duration":"147.499406ms","start":"2026-07-02T05:04:32.211083Z","end":"2026-07-02T05:04:32.358583Z","steps":["trace[468588432] 'agreement among raft nodes before linearized reading' (duration: 147.406073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:04:32.655188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.984181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:04:32.655618Z","caller":"traceutil/trace.go:171","msg":"trace[1971530214] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1179; }","duration":"273.280571ms","start":"2026-07-02T05:04:32.38231Z","end":"2026-07-02T05:04:32.655591Z","steps":["trace[1971530214] 'read index received' (duration: 57.785676ms)","trace[1971530214] 'applied index is now lower than readState.Index' (duration: 215.490895ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:32.655833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.518086ms","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-02T05:04:32.655909Z","caller":"traceutil/trace.go:171","msg":"trace[321185409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1137; }","duration":"273.641219ms","start":"2026-07-02T05:04:32.382249Z","end":"2026-07-02T05:04:32.65589Z","steps":["trace[321185409] 'agreement among raft nodes before linearized reading' (duration: 273.445304ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:04:32.655664Z","caller":"traceutil/trace.go:171","msg":"trace[1039276700] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"293.325521ms","start":"2026-07-02T05:04:32.362297Z","end":"2026-07-02T05:04:32.655622Z","steps":["trace[1039276700] 'process raft request' (duration: 113.806387ms)","trace[1039276700] 'compare' (duration: 178.370446ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:04:32.656439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.704198ms","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-02T05:04:32.656605Z","caller":"traceutil/trace.go:171","msg":"trace[1806378206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1137; }","duration":"227.910283ms","start":"2026-07-02T05:04:32.428677Z","end":"2026-07-02T05:04:32.656588Z","steps":["trace[1806378206] 'agreement among raft nodes before linearized reading' (duration: 227.609736ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:01.152053Z","caller":"traceutil/trace.go:171","msg":"trace[1559318822] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"159.752408ms","start":"2026-07-02T05:05:00.992278Z","end":"2026-07-02T05:05:01.152031Z","steps":["trace[1559318822] 'process raft request' (duration: 156.46736ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:08.877087Z","caller":"traceutil/trace.go:171","msg":"trace[682723087] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"146.997686ms","start":"2026-07-02T05:05:08.730069Z","end":"2026-07-02T05:05:08.877066Z","steps":["trace[682723087] 'process raft request' (duration: 146.862393ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:13.511916Z","caller":"traceutil/trace.go:171","msg":"trace[1333649974] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"239.549776ms","start":"2026-07-02T05:05:13.272332Z","end":"2026-07-02T05:05:13.511881Z","steps":["trace[1333649974] 'read index received' (duration: 239.446474ms)","trace[1333649974] 'applied index is now lower than readState.Index' (duration: 102.712µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:13.511941Z","caller":"traceutil/trace.go:171","msg":"trace[1273334002] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"365.927129ms","start":"2026-07-02T05:05:13.145987Z","end":"2026-07-02T05:05:13.511914Z","steps":["trace[1273334002] 'process raft request' (duration: 365.790666ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:13.51206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.72083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T05:05:13.512082Z","caller":"traceutil/trace.go:171","msg":"trace[2131653062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1270; }","duration":"239.789441ms","start":"2026-07-02T05:05:13.272287Z","end":"2026-07-02T05:05:13.512077Z","steps":["trace[2131653062] 'agreement among raft nodes before linearized reading' (duration: 239.687379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:13.512121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:05:13.145933Z","time spent":"366.119313ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:05:14.560955Z","caller":"traceutil/trace.go:171","msg":"trace[870354487] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"107.652426ms","start":"2026-07-02T05:05:14.453281Z","end":"2026-07-02T05:05:14.560934Z","steps":["trace[870354487] 'process raft request' (duration: 107.489903ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:16.142085Z","caller":"traceutil/trace.go:171","msg":"trace[657804480] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"203.666521ms","start":"2026-07-02T05:05:15.938391Z","end":"2026-07-02T05:05:16.142057Z","steps":["trace[657804480] 'read index received' (duration: 139.914953ms)","trace[657804480] 'applied index is now lower than readState.Index' (duration: 63.750578ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:16.142135Z","caller":"traceutil/trace.go:171","msg":"trace[1128562564] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"561.13093ms","start":"2026-07-02T05:05:15.58097Z","end":"2026-07-02T05:05:16.142101Z","steps":["trace[1128562564] 'process raft request' (duration: 497.430903ms)","trace[1128562564] 'compare' (duration: 63.495203ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:05:16.142304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:05:15.580956Z","time spent":"561.263062ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:05:16.142328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.262281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:05:16.142402Z","caller":"traceutil/trace.go:171","msg":"trace[682697149] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1278; }","duration":"148.380892ms","start":"2026-07-02T05:05:15.994Z","end":"2026-07-02T05:05:16.142381Z","steps":["trace[682697149] 'agreement among raft nodes before linearized reading' (duration: 148.25634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:16.143092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.687741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-07-02T05:05:16.143141Z","caller":"traceutil/trace.go:171","msg":"trace[1876330238] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1278; }","duration":"204.794153ms","start":"2026-07-02T05:05:15.938335Z","end":"2026-07-02T05:05:16.143129Z","steps":["trace[1876330238] 'agreement among raft nodes before linearized reading' (duration: 203.861975ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:17.069443Z","caller":"traceutil/trace.go:171","msg":"trace[466365954] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"116.840726ms","start":"2026-07-02T05:05:16.952587Z","end":"2026-07-02T05:05:17.069428Z","steps":["trace[466365954] 'read index received' (duration: 116.746764ms)","trace[466365954] 'applied index is now lower than readState.Index' (duration: 93.312µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:17.069523Z","caller":"traceutil/trace.go:171","msg":"trace[1930986230] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"123.25808ms","start":"2026-07-02T05:05:16.946238Z","end":"2026-07-02T05:05:17.069496Z","steps":["trace[1930986230] 'process raft request' (duration: 123.093357ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:17.069622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.013099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:1 size:1086"} {"level":"info","ts":"2026-07-02T05:05:17.069658Z","caller":"traceutil/trace.go:171","msg":"trace[737368251] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:1; response_revision:1282; }","duration":"117.08026ms","start":"2026-07-02T05:05:16.952568Z","end":"2026-07-02T05:05:17.069648Z","steps":["trace[737368251] 'agreement among raft nodes before linearized reading' (duration: 116.937877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:23.499026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.274694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:05:23.499116Z","caller":"traceutil/trace.go:171","msg":"trace[1719796338] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"334.183513ms","start":"2026-07-02T05:05:23.164918Z","end":"2026-07-02T05:05:23.499102Z","steps":["trace[1719796338] 'process raft request' (duration: 169.773467ms)","trace[1719796338] 'compare' (duration: 164.187522ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:05:23.499164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:05:23.164895Z","time spent":"334.248194ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:05:24.916971Z","caller":"traceutil/trace.go:171","msg":"trace[1660068435] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"167.24843ms","start":"2026-07-02T05:05:24.749693Z","end":"2026-07-02T05:05:24.916942Z","steps":["trace[1660068435] 'process raft request' (duration: 167.043666ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:27.376627Z","caller":"traceutil/trace.go:171","msg":"trace[629889396] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"199.837377ms","start":"2026-07-02T05:05:27.176758Z","end":"2026-07-02T05:05:27.376595Z","steps":["trace[629889396] 'process raft request' (duration: 199.675874ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:28.199931Z","caller":"traceutil/trace.go:171","msg":"trace[1084932300] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"260.203625ms","start":"2026-07-02T05:05:27.939693Z","end":"2026-07-02T05:05:28.199897Z","steps":["trace[1084932300] 'process raft request' (duration: 224.892676ms)","trace[1084932300] 'compare' (duration: 34.883921ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:28.781444Z","caller":"traceutil/trace.go:171","msg":"trace[1916137187] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"114.338531ms","start":"2026-07-02T05:05:28.667063Z","end":"2026-07-02T05:05:28.781402Z","steps":["trace[1916137187] 'read index received' (duration: 114.175998ms)","trace[1916137187] 'applied index is now lower than readState.Index' (duration: 161.703µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:28.781499Z","caller":"traceutil/trace.go:171","msg":"trace[942989736] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"165.687179ms","start":"2026-07-02T05:05:28.615782Z","end":"2026-07-02T05:05:28.781469Z","steps":["trace[942989736] 'process raft request' (duration: 165.484975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:28.781637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.549735ms","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-02T05:05:28.781674Z","caller":"traceutil/trace.go:171","msg":"trace[966962928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1323; }","duration":"114.638697ms","start":"2026-07-02T05:05:28.667026Z","end":"2026-07-02T05:05:28.781665Z","steps":["trace[966962928] 'agreement among raft nodes before linearized reading' (duration: 114.494475ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:28.930159Z","caller":"traceutil/trace.go:171","msg":"trace[471835444] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1379; }","duration":"145.147786ms","start":"2026-07-02T05:05:28.784987Z","end":"2026-07-02T05:05:28.930135Z","steps":["trace[471835444] 'read index received' (duration: 49.372901ms)","trace[471835444] 'applied index is now lower than readState.Index' (duration: 95.773895ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:28.930204Z","caller":"traceutil/trace.go:171","msg":"trace[837811993] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"145.262018ms","start":"2026-07-02T05:05:28.784909Z","end":"2026-07-02T05:05:28.930171Z","steps":["trace[837811993] 'process raft request' (duration: 83.897414ms)","trace[837811993] 'compare' (duration: 61.197301ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:05:28.930497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.486922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5548"} {"level":"info","ts":"2026-07-02T05:05:28.930583Z","caller":"traceutil/trace.go:171","msg":"trace[1050961261] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1325; }","duration":"145.624085ms","start":"2026-07-02T05:05:28.784939Z","end":"2026-07-02T05:05:28.930563Z","steps":["trace[1050961261] 'agreement among raft nodes before linearized reading' (duration: 145.308299ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:30.009867Z","caller":"traceutil/trace.go:171","msg":"trace[1854208486] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"108.374664ms","start":"2026-07-02T05:05:29.901468Z","end":"2026-07-02T05:05:30.009843Z","steps":["trace[1854208486] 'process raft request' (duration: 108.230261ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:37.156317Z","caller":"traceutil/trace.go:171","msg":"trace[478569798] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"124.248225ms","start":"2026-07-02T05:05:37.032041Z","end":"2026-07-02T05:05:37.15629Z","steps":["trace[478569798] 'process raft request' (duration: 124.081022ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:45.403933Z","caller":"traceutil/trace.go:171","msg":"trace[2019392853] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"222.248327ms","start":"2026-07-02T05:05:45.181658Z","end":"2026-07-02T05:05:45.403906Z","steps":["trace[2019392853] 'process raft request' (duration: 222.099324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:46.022462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.525304ms","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-02T05:05:46.022576Z","caller":"traceutil/trace.go:171","msg":"trace[719592224] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1413; }","duration":"243.700567ms","start":"2026-07-02T05:05:45.778854Z","end":"2026-07-02T05:05:46.022554Z","steps":["trace[719592224] 'range keys from in-memory index tree' (duration: 243.328251ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:46.022719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.873741ms","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-02T05:05:46.022835Z","caller":"traceutil/trace.go:171","msg":"trace[708257655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1413; }","duration":"172.323009ms","start":"2026-07-02T05:05:45.85049Z","end":"2026-07-02T05:05:46.022813Z","steps":["trace[708257655] 'range keys from in-memory index tree' (duration: 171.693378ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:46.218719Z","caller":"traceutil/trace.go:171","msg":"trace[1321447201] linearizableReadLoop","detail":"{readStateIndex:1475; appliedIndex:1473; }","duration":"118.00214ms","start":"2026-07-02T05:05:46.10069Z","end":"2026-07-02T05:05:46.218692Z","steps":["trace[1321447201] 'read index received' (duration: 20.86862ms)","trace[1321447201] 'applied index is now lower than readState.Index' (duration: 97.13261ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:05:46.218912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.200644ms","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":"info","ts":"2026-07-02T05:05:46.218918Z","caller":"traceutil/trace.go:171","msg":"trace[1322973491] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"192.009132ms","start":"2026-07-02T05:05:46.026868Z","end":"2026-07-02T05:05:46.218877Z","steps":["trace[1322973491] 'process raft request' (duration: 147.718947ms)","trace[1322973491] 'compare' (duration: 43.984119ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:46.218954Z","caller":"traceutil/trace.go:171","msg":"trace[1469178434] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1415; }","duration":"118.289816ms","start":"2026-07-02T05:05:46.100648Z","end":"2026-07-02T05:05:46.218938Z","steps":["trace[1469178434] 'agreement among raft nodes before linearized reading' (duration: 118.197764ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:46.473475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.290364ms","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-02T05:05:46.473552Z","caller":"traceutil/trace.go:171","msg":"trace[572813430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1415; }","duration":"118.411156ms","start":"2026-07-02T05:05:46.355117Z","end":"2026-07-02T05:05:46.473529Z","steps":["trace[572813430] 'range keys from in-memory index tree' (duration: 118.105741ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:47.230356Z","caller":"traceutil/trace.go:171","msg":"trace[868334134] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"118.264609ms","start":"2026-07-02T05:05:47.112071Z","end":"2026-07-02T05:05:47.230335Z","steps":["trace[868334134] 'process raft request' (duration: 118.141197ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:47.728792Z","caller":"traceutil/trace.go:171","msg":"trace[22297775] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"165.378992ms","start":"2026-07-02T05:05:47.563391Z","end":"2026-07-02T05:05:47.72877Z","steps":["trace[22297775] 'process raft request' (duration: 165.2525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:49.434526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.240548ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T05:05:49.434624Z","caller":"traceutil/trace.go:171","msg":"trace[305639456] linearizableReadLoop","detail":"{readStateIndex:1490; appliedIndex:1489; }","duration":"110.164597ms","start":"2026-07-02T05:05:49.324443Z","end":"2026-07-02T05:05:49.434608Z","steps":["trace[305639456] 'read index received' (duration: 3.792927ms)","trace[305639456] 'applied index is now lower than readState.Index' (duration: 106.37ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:05:49.434722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.262169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:05:49.434757Z","caller":"traceutil/trace.go:171","msg":"trace[2108906410] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1428; }","duration":"110.33512ms","start":"2026-07-02T05:05:49.32441Z","end":"2026-07-02T05:05:49.434745Z","steps":["trace[2108906410] 'agreement among raft nodes before linearized reading' (duration: 110.261279ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:49.446009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.993381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-07-02T05:05:49.446166Z","caller":"traceutil/trace.go:171","msg":"trace[747344831] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1429; }","duration":"103.145223ms","start":"2026-07-02T05:05:49.342968Z","end":"2026-07-02T05:05:49.446113Z","steps":["trace[747344831] 'agreement among raft nodes before linearized reading' (duration: 102.662205ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:51.263503Z","caller":"traceutil/trace.go:171","msg":"trace[902371675] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"160.080641ms","start":"2026-07-02T05:05:51.103397Z","end":"2026-07-02T05:05:51.263478Z","steps":["trace[902371675] 'process raft request' (duration: 159.932319ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:51.938327Z","caller":"traceutil/trace.go:171","msg":"trace[1710740332] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"106.653276ms","start":"2026-07-02T05:05:51.831611Z","end":"2026-07-02T05:05:51.938265Z","steps":["trace[1710740332] 'process raft request' (duration: 106.323901ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:56.383898Z","caller":"traceutil/trace.go:171","msg":"trace[1517587866] linearizableReadLoop","detail":"{readStateIndex:1514; appliedIndex:1513; }","duration":"111.922307ms","start":"2026-07-02T05:05:56.271951Z","end":"2026-07-02T05:05:56.383874Z","steps":["trace[1517587866] 'read index received' (duration: 111.784154ms)","trace[1517587866] 'applied index is now lower than readState.Index' (duration: 136.973µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:56.383936Z","caller":"traceutil/trace.go:171","msg":"trace[1291656715] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"118.49902ms","start":"2026-07-02T05:05:56.265419Z","end":"2026-07-02T05:05:56.383918Z","steps":["trace[1291656715] 'process raft request' (duration: 118.275107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:56.384032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.067919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:693"} {"level":"info","ts":"2026-07-02T05:05:56.384402Z","caller":"traceutil/trace.go:171","msg":"trace[1501621742] range","detail":"{range_begin:/registry/clusterroles/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1451; }","duration":"112.240792ms","start":"2026-07-02T05:05:56.271922Z","end":"2026-07-02T05:05:56.384163Z","steps":["trace[1501621742] 'agreement among raft nodes before linearized reading' (duration: 112.053728ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:05:58.546391Z","caller":"traceutil/trace.go:171","msg":"trace[1943128160] linearizableReadLoop","detail":"{readStateIndex:1522; appliedIndex:1521; }","duration":"104.858986ms","start":"2026-07-02T05:05:58.441503Z","end":"2026-07-02T05:05:58.546362Z","steps":["trace[1943128160] 'read index received' (duration: 81.225769ms)","trace[1943128160] 'applied index is now lower than readState.Index' (duration: 23.631837ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:05:58.546439Z","caller":"traceutil/trace.go:171","msg":"trace[768969361] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"119.242994ms","start":"2026-07-02T05:05:58.427169Z","end":"2026-07-02T05:05:58.546412Z","steps":["trace[768969361] 'process raft request' (duration: 95.649388ms)","trace[768969361] 'compare' (duration: 23.443153ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:05:58.546579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.068329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:1 size:647"} {"level":"info","ts":"2026-07-02T05:05:58.546639Z","caller":"traceutil/trace.go:171","msg":"trace[355687883] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:1; response_revision:1459; }","duration":"105.164552ms","start":"2026-07-02T05:05:58.441456Z","end":"2026-07-02T05:05:58.546621Z","steps":["trace[355687883] 'agreement among raft nodes before linearized reading' (duration: 105.05754ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:58.546579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.768023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"info","ts":"2026-07-02T05:05:58.546789Z","caller":"traceutil/trace.go:171","msg":"trace[1444041211] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1459; }","duration":"101.968957ms","start":"2026-07-02T05:05:58.44478Z","end":"2026-07-02T05:05:58.546749Z","steps":["trace[1444041211] 'agreement among raft nodes before linearized reading' (duration: 101.753213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:59.020758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.253455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-07-02T05:05:59.020846Z","caller":"traceutil/trace.go:171","msg":"trace[903332472] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:generic-garbage-collector; range_end:; response_count:1; response_revision:1460; }","duration":"115.379117ms","start":"2026-07-02T05:05:58.905444Z","end":"2026-07-02T05:05:59.020823Z","steps":["trace[903332472] 'range keys from in-memory index tree' (duration: 115.156983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:05:59.020973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.176627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" ","response":"range_response_count:1 size:743"} {"level":"info","ts":"2026-07-02T05:05:59.021049Z","caller":"traceutil/trace.go:171","msg":"trace[358471661] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:expand-controller; range_end:; response_count:1; response_revision:1460; }","duration":"121.294279ms","start":"2026-07-02T05:05:58.899736Z","end":"2026-07-02T05:05:59.02103Z","steps":["trace[358471661] 'range keys from in-memory index tree' (duration: 121.080325ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:04.573251Z","caller":"traceutil/trace.go:171","msg":"trace[1374276907] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"125.398133ms","start":"2026-07-02T05:06:04.44783Z","end":"2026-07-02T05:06:04.573228Z","steps":["trace[1374276907] 'process raft request' (duration: 125.232241ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:04.839029Z","caller":"traceutil/trace.go:171","msg":"trace[1712058680] linearizableReadLoop","detail":"{readStateIndex:1545; appliedIndex:1544; }","duration":"192.78017ms","start":"2026-07-02T05:06:04.646227Z","end":"2026-07-02T05:06:04.839007Z","steps":["trace[1712058680] 'read index received' (duration: 180.156156ms)","trace[1712058680] 'applied index is now lower than readState.Index' (duration: 12.623104ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:04.839238Z","caller":"traceutil/trace.go:171","msg":"trace[722576836] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"245.079499ms","start":"2026-07-02T05:06:04.594145Z","end":"2026-07-02T05:06:04.839224Z","steps":["trace[722576836] 'process raft request' (duration: 232.284691ms)","trace[722576836] 'compare' (duration: 12.477523ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:04.839453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.215428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-07-02T05:06:04.839494Z","caller":"traceutil/trace.go:171","msg":"trace[1129753770] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1480; }","duration":"193.294838ms","start":"2026-07-02T05:06:04.646188Z","end":"2026-07-02T05:06:04.839483Z","steps":["trace[1129753770] 'agreement among raft nodes before linearized reading' (duration: 193.212397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.839696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.521581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/default/\" range_end:\"/registry/jobs/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:04.839787Z","caller":"traceutil/trace.go:171","msg":"trace[2131147459] range","detail":"{range_begin:/registry/jobs/default/; range_end:/registry/jobs/default0; response_count:0; response_revision:1480; }","duration":"190.657563ms","start":"2026-07-02T05:06:04.649111Z","end":"2026-07-02T05:06:04.839768Z","steps":["trace[2131147459] 'agreement among raft nodes before linearized reading' (duration: 190.45003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:04.839805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.931007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/\" range_end:\"/registry/pods/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:5484"} {"level":"info","ts":"2026-07-02T05:06:04.839862Z","caller":"traceutil/trace.go:171","msg":"trace[1920856850] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/; range_end:/registry/pods/envoy-gateway-system0; response_count:1; response_revision:1480; }","duration":"175.028828ms","start":"2026-07-02T05:06:04.664817Z","end":"2026-07-02T05:06:04.839845Z","steps":["trace[1920856850] 'agreement among raft nodes before linearized reading' (duration: 174.859515ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.127801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.43183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:05.127868Z","caller":"traceutil/trace.go:171","msg":"trace[609389973] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:1481; }","duration":"115.605063ms","start":"2026-07-02T05:06:05.012248Z","end":"2026-07-02T05:06:05.127853Z","steps":["trace[609389973] 'range keys from in-memory index tree' (duration: 115.316138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.127862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.686664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-hxn6p\" ","response":"range_response_count:1 size:5484"} {"level":"info","ts":"2026-07-02T05:06:05.127935Z","caller":"traceutil/trace.go:171","msg":"trace[1183594413] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-hxn6p; range_end:; response_count:1; response_revision:1481; }","duration":"182.813067ms","start":"2026-07-02T05:06:04.9451Z","end":"2026-07-02T05:06:05.127913Z","steps":["trace[1183594413] 'range keys from in-memory index tree' (duration: 182.503791ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:05.579028Z","caller":"traceutil/trace.go:171","msg":"trace[303325293] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"138.39918ms","start":"2026-07-02T05:06:05.440574Z","end":"2026-07-02T05:06:05.578973Z","steps":["trace[303325293] 'process raft request' (duration: 138.138965ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:05.794703Z","caller":"traceutil/trace.go:171","msg":"trace[2116437632] linearizableReadLoop","detail":"{readStateIndex:1548; appliedIndex:1547; }","duration":"172.497448ms","start":"2026-07-02T05:06:05.622181Z","end":"2026-07-02T05:06:05.794678Z","steps":["trace[2116437632] 'read index received' (duration: 169.839483ms)","trace[2116437632] 'applied index is now lower than readState.Index' (duration: 2.657045ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:05.794763Z","caller":"traceutil/trace.go:171","msg":"trace[924288691] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"196.789242ms","start":"2026-07-02T05:06:05.597955Z","end":"2026-07-02T05:06:05.794745Z","steps":["trace[924288691] 'process raft request' (duration: 194.113926ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.794946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.790128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/envoy-gateway-system/\" range_end:\"/registry/services/specs/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:1910"} {"level":"warn","ts":"2026-07-02T05:06:05.794952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.367018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:1 size:1111"} {"level":"warn","ts":"2026-07-02T05:06:05.794955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.757424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-07-02T05:06:05.794983Z","caller":"traceutil/trace.go:171","msg":"trace[1835237542] range","detail":"{range_begin:/registry/services/specs/envoy-gateway-system/; range_end:/registry/services/specs/envoy-gateway-system0; response_count:1; response_revision:1483; }","duration":"128.878708ms","start":"2026-07-02T05:06:05.666095Z","end":"2026-07-02T05:06:05.794974Z","steps":["trace[1835237542] 'agreement among raft nodes before linearized reading' (duration: 128.760076ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:05.794992Z","caller":"traceutil/trace.go:171","msg":"trace[1061620200] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:1; response_revision:1483; }","duration":"132.449549ms","start":"2026-07-02T05:06:05.662529Z","end":"2026-07-02T05:06:05.794979Z","steps":["trace[1061620200] 'agreement among raft nodes before linearized reading' (duration: 132.298487ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:05.795021Z","caller":"traceutil/trace.go:171","msg":"trace[1325533504] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/; range_end:/registry/persistentvolumeclaims/default0; response_count:1; response_revision:1483; }","duration":"172.861775ms","start":"2026-07-02T05:06:05.622142Z","end":"2026-07-02T05:06:05.795004Z","steps":["trace[1325533504] 'agreement among raft nodes before linearized reading' (duration: 172.660652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:05.795017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.907599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:1 size:1304"} {"level":"info","ts":"2026-07-02T05:06:05.795084Z","caller":"traceutil/trace.go:171","msg":"trace[619620777] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:1; response_revision:1483; }","duration":"129.004331ms","start":"2026-07-02T05:06:05.666061Z","end":"2026-07-02T05:06:05.795065Z","steps":["trace[619620777] 'agreement among raft nodes before linearized reading' (duration: 128.800928ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:12.998392Z","caller":"traceutil/trace.go:171","msg":"trace[529679987] linearizableReadLoop","detail":"{readStateIndex:1571; appliedIndex:1570; }","duration":"344.076837ms","start":"2026-07-02T05:06:12.654292Z","end":"2026-07-02T05:06:12.998369Z","steps":["trace[529679987] 'read index received' (duration: 343.857443ms)","trace[529679987] 'applied index is now lower than readState.Index' (duration: 218.334µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:12.99851Z","caller":"traceutil/trace.go:171","msg":"trace[820198746] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"356.523796ms","start":"2026-07-02T05:06:12.641948Z","end":"2026-07-02T05:06:12.998471Z","steps":["trace[820198746] 'process raft request' (duration: 356.277361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:12.998579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.375712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:618"} {"level":"warn","ts":"2026-07-02T05:06:12.998588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.2736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:625"} {"level":"info","ts":"2026-07-02T05:06:12.998685Z","caller":"traceutil/trace.go:171","msg":"trace[946871990] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1505; }","duration":"344.408693ms","start":"2026-07-02T05:06:12.654257Z","end":"2026-07-02T05:06:12.998666Z","steps":["trace[946871990] 'agreement among raft nodes before linearized reading' (duration: 344.23819ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:12.998735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:12.654244Z","time spent":"344.479804ms","remote":"127.0.0.1:38946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":647,"request content":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" "} {"level":"info","ts":"2026-07-02T05:06:12.99863Z","caller":"traceutil/trace.go:171","msg":"trace[1304363552] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1505; }","duration":"341.457863ms","start":"2026-07-02T05:06:12.657157Z","end":"2026-07-02T05:06:12.998615Z","steps":["trace[1304363552] 'agreement among raft nodes before linearized reading' (duration: 341.348401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:12.998793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:12.657149Z","time spent":"341.630216ms","remote":"127.0.0.1:38946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":640,"request content":"key:\"/registry/roles/kube-system/system:controller:bootstrap-signer\" "} {"level":"warn","ts":"2026-07-02T05:06:12.998781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:12.641934Z","time spent":"356.669148ms","remote":"127.0.0.1:38888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:17.959362Z","caller":"traceutil/trace.go:171","msg":"trace[151257668] linearizableReadLoop","detail":"{readStateIndex:1588; appliedIndex:1587; }","duration":"182.29207ms","start":"2026-07-02T05:06:17.777053Z","end":"2026-07-02T05:06:17.959346Z","steps":["trace[151257668] 'read index received' (duration: 182.084366ms)","trace[151257668] 'applied index is now lower than readState.Index' (duration: 207.194µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:17.959496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.422462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-07-02T05:06:17.959515Z","caller":"traceutil/trace.go:171","msg":"trace[445215899] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1521; }","duration":"182.495303ms","start":"2026-07-02T05:06:17.777012Z","end":"2026-07-02T05:06:17.959507Z","steps":["trace[445215899] 'agreement among raft nodes before linearized reading' (duration: 182.395202ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:17.959686Z","caller":"traceutil/trace.go:171","msg":"trace[736970445] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"230.618453ms","start":"2026-07-02T05:06:17.729032Z","end":"2026-07-02T05:06:17.95965Z","steps":["trace[736970445] 'process raft request' (duration: 230.166725ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:21.22081Z","caller":"traceutil/trace.go:171","msg":"trace[2081806916] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"123.124773ms","start":"2026-07-02T05:06:21.097647Z","end":"2026-07-02T05:06:21.220772Z","steps":["trace[2081806916] 'process raft request' (duration: 122.951981ms)"],"step_count":1}