{"level":"warn","ts":"2026-05-20T03:13:59.833307Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T03:13:59.833394Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.30: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.30:2380","--initial-cluster=instance=https://199.204.45.30:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.30:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.30: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-05-20T03:13:59.833585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T03:13:59.833599Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.30:2380"]} {"level":"info","ts":"2026-05-20T03:13:59.83362Z","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-05-20T03:13:59.835438Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.30:2379"]} {"level":"info","ts":"2026-05-20T03:13:59.835937Z","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.30:2380"],"listen-peer-urls":["https://199.204.45.30:2380"],"advertise-client-urls":["https://199.204.45.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.30: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-05-20T03:13:59.842486Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.560286ms"} {"level":"info","ts":"2026-05-20T03:13:59.859517Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c6cf68dde442ffa5","cluster-id":"98b7ecdca9045526"} {"level":"info","ts":"2026-05-20T03:13:59.859615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T03:13:59.859638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became follower at term 0"} {"level":"info","ts":"2026-05-20T03:13:59.859657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c6cf68dde442ffa5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T03:13:59.859666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became follower at term 1"} {"level":"info","ts":"2026-05-20T03:13:59.859746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 switched to configuration voters=(14325784241915494309)"} {"level":"warn","ts":"2026-05-20T03:13:59.870269Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T03:13:59.87158Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T03:13:59.877673Z","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-05-20T03:13:59.884403Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c6cf68dde442ffa5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T03:13:59.884836Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c6cf68dde442ffa5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T03:13:59.885008Z","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-05-20T03:13:59.885096Z","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-05-20T03:13:59.88511Z","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-05-20T03:13:59.88917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 switched to configuration voters=(14325784241915494309)"} {"level":"info","ts":"2026-05-20T03:13:59.889779Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"98b7ecdca9045526","local-member-id":"c6cf68dde442ffa5","added-peer-id":"c6cf68dde442ffa5","added-peer-peer-urls":["https://199.204.45.30:2380"]} {"level":"info","ts":"2026-05-20T03:13:59.89065Z","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-05-20T03:13:59.890739Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.30:2380"} {"level":"info","ts":"2026-05-20T03:13:59.890819Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.30:2380"} {"level":"info","ts":"2026-05-20T03:13:59.890924Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c6cf68dde442ffa5","initial-advertise-peer-urls":["https://199.204.45.30:2380"],"listen-peer-urls":["https://199.204.45.30:2380"],"advertise-client-urls":["https://199.204.45.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T03:13:59.890979Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T03:14:00.66006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T03:14:00.66012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T03:14:00.660156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 received MsgPreVoteResp from c6cf68dde442ffa5 at term 1"} {"level":"info","ts":"2026-05-20T03:14:00.660189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became candidate at term 2"} {"level":"info","ts":"2026-05-20T03:14:00.660205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 received MsgVoteResp from c6cf68dde442ffa5 at term 2"} {"level":"info","ts":"2026-05-20T03:14:00.660226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became leader at term 2"} {"level":"info","ts":"2026-05-20T03:14:00.660244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c6cf68dde442ffa5 elected leader c6cf68dde442ffa5 at term 2"} {"level":"info","ts":"2026-05-20T03:14:00.661238Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c6cf68dde442ffa5","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.30:2379]}","request-path":"/0/members/c6cf68dde442ffa5/attributes","cluster-id":"98b7ecdca9045526","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T03:14:00.661262Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T03:14:00.661294Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T03:14:00.661323Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T03:14:00.662145Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"98b7ecdca9045526","local-member-id":"c6cf68dde442ffa5","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T03:14:00.662292Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T03:14:00.662338Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T03:14:00.662417Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T03:14:00.662486Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T03:14:00.664485Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.30:2379"} {"level":"info","ts":"2026-05-20T03:14:00.664585Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T03:14:04.821604Z","caller":"traceutil/trace.go:171","msg":"trace[1519223974] linearizableReadLoop","detail":"{readStateIndex:213; appliedIndex:212; }","duration":"372.215949ms","start":"2026-05-20T03:14:04.449364Z","end":"2026-05-20T03:14:04.82158Z","steps":["trace[1519223974] 'read index received' (duration: 372.032485ms)","trace[1519223974] 'applied index is now lower than readState.Index' (duration: 182.584µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:04.821785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.393443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-05-20T03:14:04.821863Z","caller":"traceutil/trace.go:171","msg":"trace[227603366] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:208; }","duration":"372.529077ms","start":"2026-05-20T03:14:04.449324Z","end":"2026-05-20T03:14:04.821853Z","steps":["trace[227603366] 'agreement among raft nodes before linearized reading' (duration: 372.362373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:04.821901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:04.449304Z","time spent":"372.587078ms","remote":"127.0.0.1:39924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-20T03:14:04.821942Z","caller":"traceutil/trace.go:171","msg":"trace[1339847593] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"606.135082ms","start":"2026-05-20T03:14:04.215767Z","end":"2026-05-20T03:14:04.821902Z","steps":["trace[1339847593] 'process raft request' (duration: 605.679441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:04.822737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:04.215738Z","time spent":"606.276486ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T03:14:05.548274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.437138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:14:05.548424Z","caller":"traceutil/trace.go:171","msg":"trace[997153174] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"715.6951ms","start":"2026-05-20T03:14:04.832711Z","end":"2026-05-20T03:14:05.548406Z","steps":["trace[997153174] 'process raft request' (duration: 35.388071ms)","trace[997153174] 'compare' (duration: 679.300594ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:05.548486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:04.832693Z","time spent":"715.765101ms","remote":"127.0.0.1:39924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3694,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:05.834306Z","caller":"traceutil/trace.go:171","msg":"trace[1150368537] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:214; }","duration":"257.991375ms","start":"2026-05-20T03:14:05.576282Z","end":"2026-05-20T03:14:05.834274Z","steps":["trace[1150368537] 'read index received' (duration: 257.37666ms)","trace[1150368537] 'applied index is now lower than readState.Index' (duration: 613.785µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:14:05.834407Z","caller":"traceutil/trace.go:171","msg":"trace[1619517870] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"278.525861ms","start":"2026-05-20T03:14:05.555871Z","end":"2026-05-20T03:14:05.834396Z","steps":["trace[1619517870] 'process raft request' (duration: 277.755102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:05.834792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.494257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:05.834907Z","caller":"traceutil/trace.go:171","msg":"trace[590724546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:210; }","duration":"258.674452ms","start":"2026-05-20T03:14:05.576214Z","end":"2026-05-20T03:14:05.834888Z","steps":["trace[590724546] 'agreement among raft nodes before linearized reading' (duration: 258.340964ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:27.427528Z","caller":"traceutil/trace.go:171","msg":"trace[399673850] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"279.236828ms","start":"2026-05-20T03:14:27.148266Z","end":"2026-05-20T03:14:27.427503Z","steps":["trace[399673850] 'process raft request' (duration: 279.112705ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:31.218748Z","caller":"traceutil/trace.go:171","msg":"trace[190256964] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"192.840711ms","start":"2026-05-20T03:14:31.025882Z","end":"2026-05-20T03:14:31.218723Z","steps":["trace[190256964] 'process raft request' (duration: 114.834989ms)","trace[190256964] 'compare' (duration: 77.788406ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:14:31.218828Z","caller":"traceutil/trace.go:171","msg":"trace[2027393910] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"178.221941ms","start":"2026-05-20T03:14:31.040583Z","end":"2026-05-20T03:14:31.218805Z","steps":["trace[2027393910] 'process raft request' (duration: 178.038716ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:31.220437Z","caller":"traceutil/trace.go:171","msg":"trace[1517611747] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"162.283178ms","start":"2026-05-20T03:14:31.058125Z","end":"2026-05-20T03:14:31.220408Z","steps":["trace[1517611747] 'process raft request' (duration: 160.617637ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:31.226782Z","caller":"traceutil/trace.go:171","msg":"trace[148029821] transaction","detail":"{read_only:false; number_of_response:1; response_revision:518; }","duration":"119.697249ms","start":"2026-05-20T03:14:31.107071Z","end":"2026-05-20T03:14:31.226769Z","steps":["trace[148029821] 'process raft request' (duration: 119.528214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:31.867535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.983612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:14:31.867826Z","caller":"traceutil/trace.go:171","msg":"trace[2034321507] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"625.335784ms","start":"2026-05-20T03:14:31.242456Z","end":"2026-05-20T03:14:31.867792Z","steps":["trace[2034321507] 'process raft request' (duration: 180.042085ms)","trace[2034321507] 'compare' (duration: 444.882349ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:31.867988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:31.242432Z","time spent":"625.446947ms","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":855,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T03:14:31.868004Z","caller":"traceutil/trace.go:171","msg":"trace[845818812] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"618.801512ms","start":"2026-05-20T03:14:31.249197Z","end":"2026-05-20T03:14:31.867999Z","steps":["trace[845818812] 'process raft request' (duration: 618.433393ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:31.868253Z","caller":"traceutil/trace.go:171","msg":"trace[1656197947] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:539; }","duration":"386.642445ms","start":"2026-05-20T03:14:31.481603Z","end":"2026-05-20T03:14:31.868246Z","steps":["trace[1656197947] 'read index received' (duration: 361.376082ms)","trace[1656197947] 'applied index is now lower than readState.Index' (duration: 25.265793ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:31.868296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.688746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:31.868309Z","caller":"traceutil/trace.go:171","msg":"trace[1902105192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"386.733468ms","start":"2026-05-20T03:14:31.481572Z","end":"2026-05-20T03:14:31.868305Z","steps":["trace[1902105192] 'agreement among raft nodes before linearized reading' (duration: 386.704307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:31.868324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:31.481556Z","time spent":"386.764768ms","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T03:14:31.868308Z","caller":"traceutil/trace.go:171","msg":"trace[1076775093] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"580.845279ms","start":"2026-05-20T03:14:31.287438Z","end":"2026-05-20T03:14:31.868283Z","steps":["trace[1076775093] 'process raft request' (duration: 580.534161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:31.868412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:31.287412Z","time spent":"580.941372ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:31.868402Z","caller":"traceutil/trace.go:171","msg":"trace[1752768596] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"564.834034ms","start":"2026-05-20T03:14:31.303522Z","end":"2026-05-20T03:14:31.868357Z","steps":["trace[1752768596] 'process raft request' (duration: 564.639478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:31.868548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:31.303496Z","time spent":"564.979738ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T03:14:31.869016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:31.249183Z","time spent":"619.132581ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:32.336136Z","caller":"traceutil/trace.go:171","msg":"trace[1050230398] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:557; }","duration":"108.034162ms","start":"2026-05-20T03:14:32.228075Z","end":"2026-05-20T03:14:32.336109Z","steps":["trace[1050230398] 'read index received' (duration: 17.150643ms)","trace[1050230398] 'applied index is now lower than readState.Index' (duration: 90.882419ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:32.336295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.210716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:32.336328Z","caller":"traceutil/trace.go:171","msg":"trace[1610327955] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:539; }","duration":"108.308678ms","start":"2026-05-20T03:14:32.228009Z","end":"2026-05-20T03:14:32.336318Z","steps":["trace[1610327955] 'agreement among raft nodes before linearized reading' (duration: 108.215676ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:32.336499Z","caller":"traceutil/trace.go:171","msg":"trace[1048682462] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"112.932183ms","start":"2026-05-20T03:14:32.2235Z","end":"2026-05-20T03:14:32.336432Z","steps":["trace[1048682462] 'process raft request' (duration: 56.494762ms)","trace[1048682462] 'compare' (duration: 55.928658ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:32.71855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.103993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:14:32.718658Z","caller":"traceutil/trace.go:171","msg":"trace[2104138532] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:559; }","duration":"377.607372ms","start":"2026-05-20T03:14:32.341034Z","end":"2026-05-20T03:14:32.718641Z","steps":["trace[2104138532] 'read index received' (duration: 107.329764ms)","trace[2104138532] 'applied index is now lower than readState.Index' (duration: 270.276568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:32.718732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.692964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:32.718763Z","caller":"traceutil/trace.go:171","msg":"trace[606921825] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:540; }","duration":"377.767006ms","start":"2026-05-20T03:14:32.340988Z","end":"2026-05-20T03:14:32.718755Z","steps":["trace[606921825] 'agreement among raft nodes before linearized reading' (duration: 377.693065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:32.718812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:32.340969Z","time spent":"377.831277ms","remote":"127.0.0.1:39824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-20T03:14:32.718922Z","caller":"traceutil/trace.go:171","msg":"trace[1916174367] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"350.7248ms","start":"2026-05-20T03:14:32.368173Z","end":"2026-05-20T03:14:32.718898Z","steps":["trace[1916174367] 'process raft request' (duration: 350.556236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:32.719036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:32.368153Z","time spent":"350.828912ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:32.719166Z","caller":"traceutil/trace.go:171","msg":"trace[66193442] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"458.911595ms","start":"2026-05-20T03:14:32.26024Z","end":"2026-05-20T03:14:32.719152Z","steps":["trace[66193442] 'process raft request' (duration: 188.115315ms)","trace[66193442] 'compare' (duration: 270.002651ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:32.719237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:32.260191Z","time spent":"459.010527ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:32.740501Z","caller":"traceutil/trace.go:171","msg":"trace[1194956263] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"284.586011ms","start":"2026-05-20T03:14:32.455891Z","end":"2026-05-20T03:14:32.740477Z","steps":["trace[1194956263] 'process raft request' (duration: 284.175441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:33.837248Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18421303863043176364,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T03:14:33.848707Z","caller":"traceutil/trace.go:171","msg":"trace[185599312] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"516.332888ms","start":"2026-05-20T03:14:33.332349Z","end":"2026-05-20T03:14:33.848682Z","steps":["trace[185599312] 'process raft request' (duration: 514.84792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:33.850353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:33.332324Z","time spent":"517.129639ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:33.854279Z","caller":"traceutil/trace.go:171","msg":"trace[1090731940] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"503.69969ms","start":"2026-05-20T03:14:33.350548Z","end":"2026-05-20T03:14:33.854248Z","steps":["trace[1090731940] 'process raft request' (duration: 503.184737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:33.857042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:33.350524Z","time spent":"506.414459ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:33.857084Z","caller":"traceutil/trace.go:171","msg":"trace[2081892584] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"106.376179ms","start":"2026-05-20T03:14:33.750682Z","end":"2026-05-20T03:14:33.857059Z","steps":["trace[2081892584] 'process raft request' (duration: 103.914448ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:33.857074Z","caller":"traceutil/trace.go:171","msg":"trace[122687547] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"304.6283ms","start":"2026-05-20T03:14:33.552408Z","end":"2026-05-20T03:14:33.857036Z","steps":["trace[122687547] 'process raft request' (duration: 302.065746ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:33.857153Z","caller":"traceutil/trace.go:171","msg":"trace[451180348] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"505.746923ms","start":"2026-05-20T03:14:33.351311Z","end":"2026-05-20T03:14:33.857058Z","steps":["trace[451180348] 'process raft request' (duration: 502.85791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:33.85732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:33.351302Z","time spent":"505.922638ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T03:14:33.857365Z","caller":"traceutil/trace.go:171","msg":"trace[634237067] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:582; }","duration":"520.526408ms","start":"2026-05-20T03:14:33.336766Z","end":"2026-05-20T03:14:33.857292Z","steps":["trace[634237067] 'read index received' (duration: 509.693453ms)","trace[634237067] 'applied index is now lower than readState.Index' (duration: 10.829005ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:33.857467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:33.552378Z","time spent":"304.9892ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T03:14:33.857572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.386261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:33.857614Z","caller":"traceutil/trace.go:171","msg":"trace[1195481147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"376.474364ms","start":"2026-05-20T03:14:33.481126Z","end":"2026-05-20T03:14:33.8576Z","steps":["trace[1195481147] 'agreement among raft nodes before linearized reading' (duration: 376.345801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:33.857597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.812365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:20866"} {"level":"warn","ts":"2026-05-20T03:14:33.857652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:33.481108Z","time spent":"376.536726ms","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T03:14:33.857665Z","caller":"traceutil/trace.go:171","msg":"trace[1130652102] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:567; }","duration":"520.911847ms","start":"2026-05-20T03:14:33.336733Z","end":"2026-05-20T03:14:33.857645Z","steps":["trace[1130652102] 'agreement among raft nodes before linearized reading' (duration: 520.708212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:33.857697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:33.336722Z","time spent":"520.968119ms","remote":"127.0.0.1:39796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":20890,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-05-20T03:14:33.857796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.082005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.30\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-20T03:14:33.857842Z","caller":"traceutil/trace.go:171","msg":"trace[686591720] range","detail":"{range_begin:/registry/masterleases/199.204.45.30; range_end:; response_count:1; response_revision:567; }","duration":"168.181928ms","start":"2026-05-20T03:14:33.689649Z","end":"2026-05-20T03:14:33.85783Z","steps":["trace[686591720] 'agreement among raft nodes before linearized reading' (duration: 167.984313ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:38.292978Z","caller":"traceutil/trace.go:171","msg":"trace[575297499] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"552.419248ms","start":"2026-05-20T03:14:37.740544Z","end":"2026-05-20T03:14:38.292963Z","steps":["trace[575297499] 'process raft request' (duration: 552.250284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.293061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.534616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.293108Z","caller":"traceutil/trace.go:171","msg":"trace[1995217947] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:610; }","duration":"473.629428ms","start":"2026-05-20T03:14:37.819466Z","end":"2026-05-20T03:14:38.293095Z","steps":["trace[1995217947] 'agreement among raft nodes before linearized reading' (duration: 473.540406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.293163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.81945Z","time spent":"473.695321ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:38.293072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.740531Z","time spent":"552.488389ms","remote":"127.0.0.1:39924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4558,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:14:38.292956Z","caller":"traceutil/trace.go:171","msg":"trace[1953743397] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"473.426303ms","start":"2026-05-20T03:14:37.819505Z","end":"2026-05-20T03:14:38.292931Z","steps":["trace[1953743397] 'read index received' (duration: 473.363202ms)","trace[1953743397] 'applied index is now lower than readState.Index' (duration: 62.091µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:14:38.375425Z","caller":"traceutil/trace.go:171","msg":"trace[740491574] transaction","detail":"{read_only:false; number_of_response:1; response_revision:610; }","duration":"450.858041ms","start":"2026-05-20T03:14:37.924283Z","end":"2026-05-20T03:14:38.375141Z","steps":["trace[740491574] 'process raft request' (duration: 450.672136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.375594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.924273Z","time spent":"451.23727ms","remote":"127.0.0.1:39924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30,"response count":0,"response size":4607,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:14:38.376431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.7989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:38.376461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.031343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.376528Z","caller":"traceutil/trace.go:171","msg":"trace[1123964800] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:611; }","duration":"430.126645ms","start":"2026-05-20T03:14:37.946385Z","end":"2026-05-20T03:14:38.376512Z","steps":["trace[1123964800] 'agreement among raft nodes before linearized reading' (duration: 430.007372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.376555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.027377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:38.376564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.946379Z","time spent":"430.175826ms","remote":"127.0.0.1:47694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"info","ts":"2026-05-20T03:14:38.376607Z","caller":"traceutil/trace.go:171","msg":"trace[77743993] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:611; }","duration":"457.13804ms","start":"2026-05-20T03:14:37.919439Z","end":"2026-05-20T03:14:38.376577Z","steps":["trace[77743993] 'agreement among raft nodes before linearized reading' (duration: 457.072868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.376616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.658922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-20T03:14:38.37663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.646443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-20T03:14:38.376666Z","caller":"traceutil/trace.go:171","msg":"trace[268316036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"239.735534ms","start":"2026-05-20T03:14:38.136909Z","end":"2026-05-20T03:14:38.376644Z","steps":["trace[268316036] 'agreement among raft nodes before linearized reading' (duration: 239.57744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.376641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.919416Z","time spent":"457.218102ms","remote":"127.0.0.1:47682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:38.376679Z","caller":"traceutil/trace.go:171","msg":"trace[1076514219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"189.744905ms","start":"2026-05-20T03:14:38.186922Z","end":"2026-05-20T03:14:38.376667Z","steps":["trace[1076514219] 'agreement among raft nodes before linearized reading' (duration: 189.576091ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:38.37679Z","caller":"traceutil/trace.go:171","msg":"trace[1654930260] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"365.106985ms","start":"2026-05-20T03:14:38.011674Z","end":"2026-05-20T03:14:38.376781Z","steps":["trace[1654930260] 'process raft request' (duration: 364.053248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.376796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.669614ms","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-05-20T03:14:38.376827Z","caller":"traceutil/trace.go:171","msg":"trace[1308088878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"271.721105ms","start":"2026-05-20T03:14:38.105096Z","end":"2026-05-20T03:14:38.376817Z","steps":["trace[1308088878] 'agreement among raft nodes before linearized reading' (duration: 271.630703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.376863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:38.011651Z","time spent":"365.158616ms","remote":"127.0.0.1:39838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T03:14:38.376886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.280251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:38.376897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.277129ms","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-05-20T03:14:38.376912Z","caller":"traceutil/trace.go:171","msg":"trace[2100932776] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:611; }","duration":"434.315231ms","start":"2026-05-20T03:14:37.942586Z","end":"2026-05-20T03:14:38.376901Z","steps":["trace[2100932776] 'agreement among raft nodes before linearized reading' (duration: 434.28032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.376933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.942579Z","time spent":"434.348892ms","remote":"127.0.0.1:47694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:38.376969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.825845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377Z","caller":"traceutil/trace.go:171","msg":"trace[1769361053] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:611; }","duration":"369.890966ms","start":"2026-05-20T03:14:38.0071Z","end":"2026-05-20T03:14:38.376991Z","steps":["trace[1769361053] 'agreement among raft nodes before linearized reading' (duration: 369.843995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:38.007085Z","time spent":"369.934607ms","remote":"127.0.0.1:47696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-05-20T03:14:38.377041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.495305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377062Z","caller":"traceutil/trace.go:171","msg":"trace[199137869] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:611; }","duration":"434.538117ms","start":"2026-05-20T03:14:37.942518Z","end":"2026-05-20T03:14:38.377056Z","steps":["trace[199137869] 'agreement among raft nodes before linearized reading' (duration: 434.506666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.942502Z","time spent":"434.574087ms","remote":"127.0.0.1:47694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:38.377131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.207334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:38.377177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.484919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:38.377178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.131823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377176Z","caller":"traceutil/trace.go:171","msg":"trace[1381950145] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:611; }","duration":"541.270936ms","start":"2026-05-20T03:14:37.835894Z","end":"2026-05-20T03:14:38.377165Z","steps":["trace[1381950145] 'agreement among raft nodes before linearized reading' (duration: 541.211024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.609572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377217Z","caller":"traceutil/trace.go:171","msg":"trace[1822057849] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:611; }","duration":"370.170974ms","start":"2026-05-20T03:14:38.007029Z","end":"2026-05-20T03:14:38.3772Z","steps":["trace[1822057849] 'agreement among raft nodes before linearized reading' (duration: 370.124362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.37722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.835885Z","time spent":"541.326717ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 "} {"level":"info","ts":"2026-05-20T03:14:38.377238Z","caller":"traceutil/trace.go:171","msg":"trace[1774068568] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:611; }","duration":"457.652603ms","start":"2026-05-20T03:14:37.91958Z","end":"2026-05-20T03:14:38.377232Z","steps":["trace[1774068568] 'agreement among raft nodes before linearized reading' (duration: 457.626853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:38.007025Z","time spent":"370.214975ms","remote":"127.0.0.1:47696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:38.377256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.919566Z","time spent":"457.685914ms","remote":"127.0.0.1:47682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "} {"level":"info","ts":"2026-05-20T03:14:38.376928Z","caller":"traceutil/trace.go:171","msg":"trace[528255927] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"203.34351ms","start":"2026-05-20T03:14:38.173574Z","end":"2026-05-20T03:14:38.376917Z","steps":["trace[528255927] 'agreement among raft nodes before linearized reading' (duration: 203.261478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.583233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:38.377374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.45197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377389Z","caller":"traceutil/trace.go:171","msg":"trace[99296201] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:611; }","duration":"370.631855ms","start":"2026-05-20T03:14:38.006749Z","end":"2026-05-20T03:14:38.377381Z","steps":["trace[99296201] 'agreement among raft nodes before linearized reading' (duration: 370.590964ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:38.377403Z","caller":"traceutil/trace.go:171","msg":"trace[375458210] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:611; }","duration":"541.500121ms","start":"2026-05-20T03:14:37.835894Z","end":"2026-05-20T03:14:38.377394Z","steps":["trace[375458210] 'agreement among raft nodes before linearized reading' (duration: 541.45454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:38.006735Z","time spent":"370.675146ms","remote":"127.0.0.1:47696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:38.377431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.835882Z","time spent":"541.541542ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:38.377195Z","caller":"traceutil/trace.go:171","msg":"trace[1479505138] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:611; }","duration":"457.5589ms","start":"2026-05-20T03:14:37.919631Z","end":"2026-05-20T03:14:38.37719Z","steps":["trace[1479505138] 'agreement among raft nodes before linearized reading' (duration: 457.53016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.919617Z","time spent":"457.966411ms","remote":"127.0.0.1:47682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:38.377883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.971152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377906Z","caller":"traceutil/trace.go:171","msg":"trace[1539224397] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:611; }","duration":"542.015584ms","start":"2026-05-20T03:14:37.835884Z","end":"2026-05-20T03:14:38.377899Z","steps":["trace[1539224397] 'agreement among raft nodes before linearized reading' (duration: 541.979463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.835873Z","time spent":"542.048295ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:38.37792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.966388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:38.377953Z","caller":"traceutil/trace.go:171","msg":"trace[547767345] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:611; }","duration":"558.001179ms","start":"2026-05-20T03:14:37.819942Z","end":"2026-05-20T03:14:38.377943Z","steps":["trace[547767345] 'agreement among raft nodes before linearized reading' (duration: 557.949838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.377985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.819911Z","time spent":"558.062701ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:38.378057Z","caller":"traceutil/trace.go:171","msg":"trace[728382950] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:611; }","duration":"556.890172ms","start":"2026-05-20T03:14:37.819592Z","end":"2026-05-20T03:14:38.376482Z","steps":["trace[728382950] 'agreement among raft nodes before linearized reading' (duration: 556.773339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:38.378082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:37.819588Z","time spent":"558.487771ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:40.346228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.276796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.346281Z","caller":"traceutil/trace.go:171","msg":"trace[436187579] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"102.367938ms","start":"2026-05-20T03:14:40.243903Z","end":"2026-05-20T03:14:40.346271Z","steps":["trace[436187579] 'range keys from in-memory index tree' (duration: 102.200424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.346496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.546073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.346549Z","caller":"traceutil/trace.go:171","msg":"trace[1711645559] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"102.631714ms","start":"2026-05-20T03:14:40.243906Z","end":"2026-05-20T03:14:40.346538Z","steps":["trace[1711645559] 'count revisions from in-memory index tree' (duration: 102.460651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.346705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.520002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.346751Z","caller":"traceutil/trace.go:171","msg":"trace[198041912] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:627; }","duration":"102.899832ms","start":"2026-05-20T03:14:40.243843Z","end":"2026-05-20T03:14:40.346743Z","steps":["trace[198041912] 'range keys from in-memory index tree' (duration: 102.432349ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:40.613691Z","caller":"traceutil/trace.go:171","msg":"trace[1787840465] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"124.321075ms","start":"2026-05-20T03:14:40.489343Z","end":"2026-05-20T03:14:40.613664Z","steps":["trace[1787840465] 'process raft request' (duration: 123.821582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.840761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.782426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.84082Z","caller":"traceutil/trace.go:171","msg":"trace[1045848130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:632; }","duration":"178.874769ms","start":"2026-05-20T03:14:40.661934Z","end":"2026-05-20T03:14:40.840809Z","steps":["trace[1045848130] 'range keys from in-memory index tree' (duration: 178.755896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.840875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.006762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:40.840891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.206093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:40.840906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.374111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.840948Z","caller":"traceutil/trace.go:171","msg":"trace[999167246] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:632; }","duration":"179.089134ms","start":"2026-05-20T03:14:40.661842Z","end":"2026-05-20T03:14:40.840931Z","steps":["trace[999167246] 'count revisions from in-memory index tree' (duration: 178.979911ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:40.840974Z","caller":"traceutil/trace.go:171","msg":"trace[1992840581] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:632; }","duration":"190.574476ms","start":"2026-05-20T03:14:40.650375Z","end":"2026-05-20T03:14:40.840949Z","steps":["trace[1992840581] 'range keys from in-memory index tree' (duration: 190.303489ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:40.840971Z","caller":"traceutil/trace.go:171","msg":"trace[586333411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:632; }","duration":"193.322176ms","start":"2026-05-20T03:14:40.647621Z","end":"2026-05-20T03:14:40.840943Z","steps":["trace[586333411] 'range keys from in-memory index tree' (duration: 193.138161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.841044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.314755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.841068Z","caller":"traceutil/trace.go:171","msg":"trace[1992807378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:632; }","duration":"193.377148ms","start":"2026-05-20T03:14:40.647684Z","end":"2026-05-20T03:14:40.841061Z","steps":["trace[1992807378] 'count revisions from in-memory index tree' (duration: 193.225322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.841329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.192578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.841371Z","caller":"traceutil/trace.go:171","msg":"trace[401557065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:632; }","duration":"179.774393ms","start":"2026-05-20T03:14:40.661587Z","end":"2026-05-20T03:14:40.841362Z","steps":["trace[401557065] 'range keys from in-memory index tree' (duration: 179.147316ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:40.84508Z","caller":"traceutil/trace.go:171","msg":"trace[837683] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"159.908128ms","start":"2026-05-20T03:14:40.685157Z","end":"2026-05-20T03:14:40.845065Z","steps":["trace[837683] 'read index received' (duration: 159.743454ms)","trace[837683] 'applied index is now lower than readState.Index' (duration: 163.914µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:14:40.845276Z","caller":"traceutil/trace.go:171","msg":"trace[735528406] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"180.547501ms","start":"2026-05-20T03:14:40.664718Z","end":"2026-05-20T03:14:40.845265Z","steps":["trace[735528406] 'process raft request' (duration: 180.250704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.845301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.041511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:40.846425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.688332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.846491Z","caller":"traceutil/trace.go:171","msg":"trace[342778929] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"105.753033ms","start":"2026-05-20T03:14:40.740714Z","end":"2026-05-20T03:14:40.846467Z","steps":["trace[342778929] 'agreement among raft nodes before linearized reading' (duration: 105.655651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.846454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.255092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.846623Z","caller":"traceutil/trace.go:171","msg":"trace[2071116320] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:633; }","duration":"161.468966ms","start":"2026-05-20T03:14:40.685125Z","end":"2026-05-20T03:14:40.846594Z","steps":["trace[2071116320] 'agreement among raft nodes before linearized reading' (duration: 161.238091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.846933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.291788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.846969Z","caller":"traceutil/trace.go:171","msg":"trace[95692797] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"106.352329ms","start":"2026-05-20T03:14:40.740601Z","end":"2026-05-20T03:14:40.846953Z","steps":["trace[95692797] 'agreement among raft nodes before linearized reading' (duration: 106.304088ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:40.84623Z","caller":"traceutil/trace.go:171","msg":"trace[1467384579] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:633; }","duration":"160.986645ms","start":"2026-05-20T03:14:40.68522Z","end":"2026-05-20T03:14:40.846207Z","steps":["trace[1467384579] 'agreement among raft nodes before linearized reading' (duration: 160.00248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:40.84696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.201991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:40.851495Z","caller":"traceutil/trace.go:171","msg":"trace[1163508403] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:633; }","duration":"165.750916ms","start":"2026-05-20T03:14:40.685713Z","end":"2026-05-20T03:14:40.851464Z","steps":["trace[1163508403] 'agreement among raft nodes before linearized reading' (duration: 161.198281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:41.787947Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18421303863043176573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T03:14:42.288092Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18421303863043176573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T03:14:42.508379Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.238068877s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T03:14:42.509701Z","caller":"traceutil/trace.go:171","msg":"trace[1104171381] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"1.222734087s","start":"2026-05-20T03:14:41.286946Z","end":"2026-05-20T03:14:42.50968Z","steps":["trace[1104171381] 'read index received' (duration: 1.221590758s)","trace[1104171381] 'applied index is now lower than readState.Index' (duration: 1.142379ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:14:42.509847Z","caller":"traceutil/trace.go:171","msg":"trace[1164650316] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.241110975s","start":"2026-05-20T03:14:41.268717Z","end":"2026-05-20T03:14:42.509828Z","steps":["trace[1164650316] 'process raft request' (duration: 1.240262434s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.509923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.222904552s","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-05-20T03:14:42.509966Z","caller":"traceutil/trace.go:171","msg":"trace[1089672879] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:635; }","duration":"1.223063976s","start":"2026-05-20T03:14:41.286892Z","end":"2026-05-20T03:14:42.509956Z","steps":["trace[1089672879] 'agreement among raft nodes before linearized reading' (duration: 1.222925993s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.510058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.286875Z","time spent":"1.223146188s","remote":"127.0.0.1:47854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:42.510162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123484019s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.510235Z","caller":"traceutil/trace.go:171","msg":"trace[347786876] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:635; }","duration":"1.123570992s","start":"2026-05-20T03:14:41.386652Z","end":"2026-05-20T03:14:42.510223Z","steps":["trace[347786876] 'agreement among raft nodes before linearized reading' (duration: 1.123471359s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.510229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09162426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.510295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.386644Z","time spent":"1.123639013s","remote":"127.0.0.1:47866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-20T03:14:42.510338Z","caller":"traceutil/trace.go:171","msg":"trace[9917180] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:635; }","duration":"1.091779924s","start":"2026-05-20T03:14:41.418534Z","end":"2026-05-20T03:14:42.510314Z","steps":["trace[9917180] 'agreement among raft nodes before linearized reading' (duration: 1.091526238s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.510329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056643643s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.510399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.418526Z","time spent":"1.091861106s","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:42.510435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156616469s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.510511Z","caller":"traceutil/trace.go:171","msg":"trace[470611419] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:635; }","duration":"1.156699861s","start":"2026-05-20T03:14:41.353785Z","end":"2026-05-20T03:14:42.510485Z","steps":["trace[470611419] 'agreement among raft nodes before linearized reading' (duration: 1.156623759s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.510587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.353769Z","time spent":"1.156804803s","remote":"127.0.0.1:47856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-20T03:14:42.510718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057500046s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.51071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044123567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.510833Z","caller":"traceutil/trace.go:171","msg":"trace[1331584098] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:635; }","duration":"1.057634609s","start":"2026-05-20T03:14:41.453162Z","end":"2026-05-20T03:14:42.510797Z","steps":["trace[1331584098] 'agreement among raft nodes before linearized reading' (duration: 1.057518796s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.510903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.453126Z","time spent":"1.057767142s","remote":"127.0.0.1:47902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-20T03:14:42.510883Z","caller":"traceutil/trace.go:171","msg":"trace[1663950204] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:635; }","duration":"1.044247879s","start":"2026-05-20T03:14:41.466559Z","end":"2026-05-20T03:14:42.510807Z","steps":["trace[1663950204] 'agreement among raft nodes before linearized reading' (duration: 1.044088724s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.510947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045256805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.510996Z","caller":"traceutil/trace.go:171","msg":"trace[117649866] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:635; }","duration":"1.045310117s","start":"2026-05-20T03:14:41.465673Z","end":"2026-05-20T03:14:42.510983Z","steps":["trace[117649866] 'agreement among raft nodes before linearized reading' (duration: 1.045237005s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.465641Z","time spent":"1.045384549s","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:42.511072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157650018s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07423824s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.511129Z","caller":"traceutil/trace.go:171","msg":"trace[1075151236] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:635; }","duration":"1.157734689s","start":"2026-05-20T03:14:41.353381Z","end":"2026-05-20T03:14:42.511116Z","steps":["trace[1075151236] 'agreement among raft nodes before linearized reading' (duration: 1.157650037s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.353362Z","time spent":"1.157804901s","remote":"127.0.0.1:47856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:42.511152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045411179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074683031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.511243Z","caller":"traceutil/trace.go:171","msg":"trace[1872666836] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:635; }","duration":"1.074710032s","start":"2026-05-20T03:14:41.436526Z","end":"2026-05-20T03:14:42.511236Z","steps":["trace[1872666836] 'agreement among raft nodes before linearized reading' (duration: 1.074671171s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.436506Z","time spent":"1.074759584s","remote":"127.0.0.1:47892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 "} {"level":"info","ts":"2026-05-20T03:14:42.51126Z","caller":"traceutil/trace.go:171","msg":"trace[58635601] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:635; }","duration":"1.045573993s","start":"2026-05-20T03:14:41.465658Z","end":"2026-05-20T03:14:42.511232Z","steps":["trace[58635601] 'agreement among raft nodes before linearized reading' (duration: 1.045315377s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.51134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.465648Z","time spent":"1.045680416s","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:42.51136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157982836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.510923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.268688Z","time spent":"1.241247668s","remote":"127.0.0.1:39838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:14:42.511419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074908647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.223853406s","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-05-20T03:14:42.51146Z","caller":"traceutil/trace.go:171","msg":"trace[1192736424] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:635; }","duration":"1.074960568s","start":"2026-05-20T03:14:41.436492Z","end":"2026-05-20T03:14:42.511452Z","steps":["trace[1192736424] 'agreement among raft nodes before linearized reading' (duration: 1.074905177s)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:42.511491Z","caller":"traceutil/trace.go:171","msg":"trace[539379368] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:635; }","duration":"1.223906448s","start":"2026-05-20T03:14:41.287575Z","end":"2026-05-20T03:14:42.511481Z","steps":["trace[539379368] 'agreement among raft nodes before linearized reading' (duration: 1.223845327s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.5115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110990034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091941599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.287568Z","time spent":"1.223958679s","remote":"127.0.0.1:47854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:42.511564Z","caller":"traceutil/trace.go:171","msg":"trace[487170738] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:635; }","duration":"1.09198635s","start":"2026-05-20T03:14:41.41957Z","end":"2026-05-20T03:14:42.511557Z","steps":["trace[487170738] 'agreement among raft nodes before linearized reading' (duration: 1.091942829s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111067245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.510727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092184235s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.419562Z","time spent":"1.092035252s","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:42.510439Z","caller":"traceutil/trace.go:171","msg":"trace[1780997612] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:635; }","duration":"1.056774257s","start":"2026-05-20T03:14:41.45364Z","end":"2026-05-20T03:14:42.510414Z","steps":["trace[1780997612] 'agreement among raft nodes before linearized reading' (duration: 1.056563711s)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:42.511626Z","caller":"traceutil/trace.go:171","msg":"trace[1531778204] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:635; }","duration":"1.093086287s","start":"2026-05-20T03:14:41.418522Z","end":"2026-05-20T03:14:42.511609Z","steps":["trace[1531778204] 'agreement among raft nodes before linearized reading' (duration: 1.092155704s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124222869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.141447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-20T03:14:42.510223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.223181969s","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-05-20T03:14:42.511611Z","caller":"traceutil/trace.go:171","msg":"trace[1879697715] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:635; }","duration":"1.111127016s","start":"2026-05-20T03:14:41.400476Z","end":"2026-05-20T03:14:42.511603Z","steps":["trace[1879697715] 'agreement among raft nodes before linearized reading' (duration: 1.111078575s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.51108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057915716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.511398Z","caller":"traceutil/trace.go:171","msg":"trace[164033724] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:635; }","duration":"1.158053537s","start":"2026-05-20T03:14:41.353333Z","end":"2026-05-20T03:14:42.511386Z","steps":["trace[164033724] 'agreement among raft nodes before linearized reading' (duration: 1.157992765s)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:42.511781Z","caller":"traceutil/trace.go:171","msg":"trace[925376] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:635; }","duration":"1.058636324s","start":"2026-05-20T03:14:41.453132Z","end":"2026-05-20T03:14:42.511768Z","steps":["trace[925376] 'agreement among raft nodes before linearized reading' (duration: 1.057919506s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.353318Z","time spent":"1.158475828s","remote":"127.0.0.1:47856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-20T03:14:42.511178Z","caller":"traceutil/trace.go:171","msg":"trace[984620867] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:635; }","duration":"1.074284922s","start":"2026-05-20T03:14:41.436865Z","end":"2026-05-20T03:14:42.51115Z","steps":["trace[984620867] 'agreement among raft nodes before linearized reading' (duration: 1.074238411s)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:42.511534Z","caller":"traceutil/trace.go:171","msg":"trace[405071757] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:635; }","duration":"1.111057664s","start":"2026-05-20T03:14:41.400466Z","end":"2026-05-20T03:14:42.511524Z","steps":["trace[405071757] 'agreement among raft nodes before linearized reading' (duration: 1.111010293s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.400447Z","time spent":"1.111396373s","remote":"127.0.0.1:47874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:42.511855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.436859Z","time spent":"1.074984739s","remote":"127.0.0.1:47892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 "} {"level":"warn","ts":"2026-05-20T03:14:42.510388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137921076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.511495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.436486Z","time spent":"1.075001399s","remote":"127.0.0.1:47892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:42.511802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.400458Z","time spent":"1.111291521s","remote":"127.0.0.1:47874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:42.511697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110306466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.511984Z","caller":"traceutil/trace.go:171","msg":"trace[598650694] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:635; }","duration":"1.225029885s","start":"2026-05-20T03:14:41.286942Z","end":"2026-05-20T03:14:42.511972Z","steps":["trace[598650694] 'agreement among raft nodes before linearized reading' (duration: 1.223114027s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.453611Z","time spent":"1.058024819s","remote":"127.0.0.1:47902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-20T03:14:42.511688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.418501Z","time spent":"1.09317009s","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:42.512032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.286924Z","time spent":"1.225094048s","remote":"127.0.0.1:47854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-20T03:14:42.511732Z","caller":"traceutil/trace.go:171","msg":"trace[759087170] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:635; }","duration":"1.124515606s","start":"2026-05-20T03:14:41.387201Z","end":"2026-05-20T03:14:42.511717Z","steps":["trace[759087170] 'agreement among raft nodes before linearized reading' (duration: 1.124214459s)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:42.512055Z","caller":"traceutil/trace.go:171","msg":"trace[2011786450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"103.568368ms","start":"2026-05-20T03:14:42.408434Z","end":"2026-05-20T03:14:42.512003Z","steps":["trace[2011786450] 'agreement among raft nodes before linearized reading' (duration: 102.998884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.512097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.387196Z","time spent":"1.124876175s","remote":"127.0.0.1:47858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:42.511927Z","caller":"traceutil/trace.go:171","msg":"trace[2147268170] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:635; }","duration":"1.139477326s","start":"2026-05-20T03:14:41.372437Z","end":"2026-05-20T03:14:42.511915Z","steps":["trace[2147268170] 'agreement among raft nodes before linearized reading' (duration: 1.137918766s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.51194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03172068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:42.512087Z","caller":"traceutil/trace.go:171","msg":"trace[220700713] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:635; }","duration":"1.110960952s","start":"2026-05-20T03:14:41.401041Z","end":"2026-05-20T03:14:42.512002Z","steps":["trace[220700713] 'agreement among raft nodes before linearized reading' (duration: 1.110014349s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.511006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.466549Z","time spent":"1.044437524s","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-05-20T03:14:42.512326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125621724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.510333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137848314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:14:42.512378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.401031Z","time spent":"1.111332501s","remote":"127.0.0.1:47874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"info","ts":"2026-05-20T03:14:42.512401Z","caller":"traceutil/trace.go:171","msg":"trace[1206738315] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:635; }","duration":"1.139920427s","start":"2026-05-20T03:14:41.372468Z","end":"2026-05-20T03:14:42.512388Z","steps":["trace[1206738315] 'agreement among raft nodes before linearized reading' (duration: 1.137834814s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.51245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.372465Z","time spent":"1.139970098s","remote":"127.0.0.1:47858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:14:42.512209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.372424Z","time spent":"1.139769633s","remote":"127.0.0.1:47858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-05-20T03:14:42.512277Z","caller":"traceutil/trace.go:171","msg":"trace[592439417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"1.03208332s","start":"2026-05-20T03:14:41.48018Z","end":"2026-05-20T03:14:42.512264Z","steps":["trace[592439417] 'agreement among raft nodes before linearized reading' (duration: 1.031654989s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.512609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.480167Z","time spent":"1.032430488s","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T03:14:42.511817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.453115Z","time spent":"1.058690045s","remote":"127.0.0.1:47902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-20T03:14:42.512372Z","caller":"traceutil/trace.go:171","msg":"trace[1994685984] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:635; }","duration":"1.125665185s","start":"2026-05-20T03:14:41.386692Z","end":"2026-05-20T03:14:42.512358Z","steps":["trace[1994685984] 'agreement among raft nodes before linearized reading' (duration: 1.125599874s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:42.515226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:41.386678Z","time spent":"1.128503147s","remote":"127.0.0.1:47866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T03:14:59.244997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.006653ms","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-05-20T03:14:59.245094Z","caller":"traceutil/trace.go:171","msg":"trace[402314712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:761; }","duration":"566.147096ms","start":"2026-05-20T03:14:58.678929Z","end":"2026-05-20T03:14:59.245076Z","steps":["trace[402314712] 'range keys from in-memory index tree' (duration: 565.774237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:59.245165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:58.678912Z","time spent":"566.244229ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T03:14:59.245317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.064765ms","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-05-20T03:14:59.245374Z","caller":"traceutil/trace.go:171","msg":"trace[1363869010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:761; }","duration":"581.153447ms","start":"2026-05-20T03:14:58.664205Z","end":"2026-05-20T03:14:59.245359Z","steps":["trace[1363869010] 'range keys from in-memory index tree' (duration: 580.758397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:59.245412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:58.664179Z","time spent":"581.225638ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T03:14:59.245376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.758641ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:14:59.245535Z","caller":"traceutil/trace.go:171","msg":"trace[1502778724] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:761; }","duration":"340.141661ms","start":"2026-05-20T03:14:58.905368Z","end":"2026-05-20T03:14:59.245509Z","steps":["trace[1502778724] 'range keys from in-memory index tree' (duration: 339.721581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:59.245552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.277826ms","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-05-20T03:14:59.245586Z","caller":"traceutil/trace.go:171","msg":"trace[1672472518] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"569.328007ms","start":"2026-05-20T03:14:58.676249Z","end":"2026-05-20T03:14:59.245577Z","steps":["trace[1672472518] 'range keys from in-memory index tree' (duration: 568.849895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:59.245611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:58.676238Z","time spent":"569.366837ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T03:14:59.245568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.745174ms","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-05-20T03:14:59.245711Z","caller":"traceutil/trace.go:171","msg":"trace[563079860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"585.99263ms","start":"2026-05-20T03:14:58.659673Z","end":"2026-05-20T03:14:59.245666Z","steps":["trace[563079860] 'range keys from in-memory index tree' (duration: 584.921082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:59.24581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:58.659623Z","time spent":"586.174054ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-20T03:14:59.363344Z","caller":"traceutil/trace.go:171","msg":"trace[1346750875] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"336.032027ms","start":"2026-05-20T03:14:59.027281Z","end":"2026-05-20T03:14:59.363313Z","steps":["trace[1346750875] 'read index received' (duration: 260.603833ms)","trace[1346750875] 'applied index is now lower than readState.Index' (duration: 75.426314ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:14:59.36373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.436468ms","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-05-20T03:14:59.363821Z","caller":"traceutil/trace.go:171","msg":"trace[1037377940] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:761; }","duration":"336.549362ms","start":"2026-05-20T03:14:59.027221Z","end":"2026-05-20T03:14:59.36377Z","steps":["trace[1037377940] 'agreement among raft nodes before linearized reading' (duration: 336.193702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:14:59.363919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:14:59.0272Z","time spent":"336.699915ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-20T03:14:59.394498Z","caller":"traceutil/trace.go:171","msg":"trace[1269471735] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"285.025912ms","start":"2026-05-20T03:14:59.109448Z","end":"2026-05-20T03:14:59.394474Z","steps":["trace[1269471735] 'process raft request' (duration: 284.811266ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:59.394733Z","caller":"traceutil/trace.go:171","msg":"trace[1580581287] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"144.740733ms","start":"2026-05-20T03:14:59.249962Z","end":"2026-05-20T03:14:59.394702Z","steps":["trace[1580581287] 'process raft request' (duration: 144.446505ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:59.394899Z","caller":"traceutil/trace.go:171","msg":"trace[593128104] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"144.853846ms","start":"2026-05-20T03:14:59.250027Z","end":"2026-05-20T03:14:59.394881Z","steps":["trace[593128104] 'process raft request' (duration: 144.550467ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:59.394908Z","caller":"traceutil/trace.go:171","msg":"trace[1490992402] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"144.541898ms","start":"2026-05-20T03:14:59.250347Z","end":"2026-05-20T03:14:59.394889Z","steps":["trace[1490992402] 'process raft request' (duration: 144.366284ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:14:59.39555Z","caller":"traceutil/trace.go:171","msg":"trace[1126686971] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"143.739108ms","start":"2026-05-20T03:14:59.251077Z","end":"2026-05-20T03:14:59.394816Z","steps":["trace[1126686971] 'process raft request' (duration: 143.689467ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:33.803164Z","caller":"traceutil/trace.go:171","msg":"trace[1188414492] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"245.113499ms","start":"2026-05-20T03:15:33.558032Z","end":"2026-05-20T03:15:33.803146Z","steps":["trace[1188414492] 'process raft request' (duration: 244.977256ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:33.944376Z","caller":"traceutil/trace.go:171","msg":"trace[652813274] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1007; }","duration":"382.930177ms","start":"2026-05-20T03:15:33.561426Z","end":"2026-05-20T03:15:33.944356Z","steps":["trace[652813274] 'read index received' (duration: 241.58672ms)","trace[652813274] 'applied index is now lower than readState.Index' (duration: 141.342767ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:15:33.944591Z","caller":"traceutil/trace.go:171","msg":"trace[1076198814] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"386.357014ms","start":"2026-05-20T03:15:33.558225Z","end":"2026-05-20T03:15:33.944582Z","steps":["trace[1076198814] 'process raft request' (duration: 372.160534ms)","trace[1076198814] 'compare' (duration: 13.875422ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:15:33.944668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:33.558185Z","time spent":"386.430285ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:15:33.944848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.424789ms","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-05-20T03:15:33.94487Z","caller":"traceutil/trace.go:171","msg":"trace[503501387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"383.463611ms","start":"2026-05-20T03:15:33.561401Z","end":"2026-05-20T03:15:33.944864Z","steps":["trace[503501387] 'agreement among raft nodes before linearized reading' (duration: 383.384249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:33.944888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:33.561388Z","time spent":"383.496071ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T03:15:33.945008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.179735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.30\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-20T03:15:33.945013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.63212ms","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-05-20T03:15:33.945056Z","caller":"traceutil/trace.go:171","msg":"trace[1428240526] range","detail":"{range_begin:/registry/masterleases/199.204.45.30; range_end:; response_count:1; response_revision:973; }","duration":"253.256607ms","start":"2026-05-20T03:15:33.691783Z","end":"2026-05-20T03:15:33.94504Z","steps":["trace[1428240526] 'agreement among raft nodes before linearized reading' (duration: 253.131394ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:33.9451Z","caller":"traceutil/trace.go:171","msg":"trace[1344501248] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:973; }","duration":"382.800034ms","start":"2026-05-20T03:15:33.56228Z","end":"2026-05-20T03:15:33.94508Z","steps":["trace[1344501248] 'agreement among raft nodes before linearized reading' (duration: 382.567338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:33.945144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:33.562259Z","time spent":"382.876936ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-20T03:15:33.9454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.159067ms","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-05-20T03:15:33.945466Z","caller":"traceutil/trace.go:171","msg":"trace[633044678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:973; }","duration":"380.252969ms","start":"2026-05-20T03:15:33.565197Z","end":"2026-05-20T03:15:33.94545Z","steps":["trace[633044678] 'agreement among raft nodes before linearized reading' (duration: 380.057644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:33.945498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:33.565189Z","time spent":"380.30075ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T03:15:34.152781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.161832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:15:34.152864Z","caller":"traceutil/trace.go:171","msg":"trace[1614903175] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"160.01186ms","start":"2026-05-20T03:15:33.992838Z","end":"2026-05-20T03:15:34.15285Z","steps":["trace[1614903175] 'process raft request' (duration: 59.716115ms)","trace[1614903175] 'compare' (duration: 99.968217ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:15:34.860289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.209761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:15:34.860849Z","caller":"traceutil/trace.go:171","msg":"trace[1408427761] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"609.251012ms","start":"2026-05-20T03:15:34.251578Z","end":"2026-05-20T03:15:34.860829Z","steps":["trace[1408427761] 'process raft request' (duration: 263.376384ms)","trace[1408427761] 'compare' (duration: 345.104308ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:15:34.861006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:34.251551Z","time spent":"609.341703ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:15:35.653421Z","caller":"traceutil/trace.go:171","msg":"trace[1681625950] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"171.686418ms","start":"2026-05-20T03:15:35.481708Z","end":"2026-05-20T03:15:35.653394Z","steps":["trace[1681625950] 'read index received' (duration: 149.669759ms)","trace[1681625950] 'applied index is now lower than readState.Index' (duration: 22.015509ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:15:35.653522Z","caller":"traceutil/trace.go:171","msg":"trace[1661340926] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"1.160858368s","start":"2026-05-20T03:15:34.492637Z","end":"2026-05-20T03:15:35.653495Z","steps":["trace[1661340926] 'process raft request' (duration: 1.138677815s)","trace[1661340926] 'compare' (duration: 21.820094ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:15:35.653574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.846531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:15:35.653613Z","caller":"traceutil/trace.go:171","msg":"trace[1949331467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"171.934644ms","start":"2026-05-20T03:15:35.481666Z","end":"2026-05-20T03:15:35.653601Z","steps":["trace[1949331467] 'agreement among raft nodes before linearized reading' (duration: 171.855062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:35.653657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:34.492614Z","time spent":"1.160960631s","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:15:54.285175Z","caller":"traceutil/trace.go:171","msg":"trace[478209681] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1080; }","duration":"164.006019ms","start":"2026-05-20T03:15:54.121149Z","end":"2026-05-20T03:15:54.285155Z","steps":["trace[478209681] 'read index received' (duration: 163.889145ms)","trace[478209681] 'applied index is now lower than readState.Index' (duration: 115.994µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:15:54.285218Z","caller":"traceutil/trace.go:171","msg":"trace[835598284] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"257.446248ms","start":"2026-05-20T03:15:54.027743Z","end":"2026-05-20T03:15:54.285189Z","steps":["trace[835598284] 'process raft request' (duration: 257.258703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:54.285381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.209855ms","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-05-20T03:15:54.285418Z","caller":"traceutil/trace.go:171","msg":"trace[1243356181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"164.309356ms","start":"2026-05-20T03:15:54.121101Z","end":"2026-05-20T03:15:54.28541Z","steps":["trace[1243356181] 'agreement among raft nodes before linearized reading' (duration: 164.172633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:54.2855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.105624ms","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-05-20T03:15:54.285535Z","caller":"traceutil/trace.go:171","msg":"trace[1579282791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1040; }","duration":"157.182306ms","start":"2026-05-20T03:15:54.128342Z","end":"2026-05-20T03:15:54.285524Z","steps":["trace[1579282791] 'agreement among raft nodes before linearized reading' (duration: 157.053383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:54.285891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.441986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-20T03:15:54.285974Z","caller":"traceutil/trace.go:171","msg":"trace[651803935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"159.55831ms","start":"2026-05-20T03:15:54.126399Z","end":"2026-05-20T03:15:54.285958Z","steps":["trace[651803935] 'agreement among raft nodes before linearized reading' (duration: 158.983095ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:54.402593Z","caller":"traceutil/trace.go:171","msg":"trace[673603982] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"112.686656ms","start":"2026-05-20T03:15:54.289881Z","end":"2026-05-20T03:15:54.402568Z","steps":["trace[673603982] 'process raft request' (duration: 29.754567ms)","trace[673603982] 'compare' (duration: 82.735383ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:15:54.502261Z","caller":"traceutil/trace.go:171","msg":"trace[1648157164] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"212.356133ms","start":"2026-05-20T03:15:54.289884Z","end":"2026-05-20T03:15:54.50224Z","steps":["trace[1648157164] 'process raft request' (duration: 212.22888ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:54.502369Z","caller":"traceutil/trace.go:171","msg":"trace[781045486] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"212.240899ms","start":"2026-05-20T03:15:54.290094Z","end":"2026-05-20T03:15:54.502335Z","steps":["trace[781045486] 'process raft request' (duration: 212.101196ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:56.166366Z","caller":"traceutil/trace.go:171","msg":"trace[1537773943] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"268.239948ms","start":"2026-05-20T03:15:55.898101Z","end":"2026-05-20T03:15:56.16634Z","steps":["trace[1537773943] 'process raft request' (duration: 268.084964ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:56.599173Z","caller":"traceutil/trace.go:171","msg":"trace[1700127606] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1086; }","duration":"322.985403ms","start":"2026-05-20T03:15:56.276157Z","end":"2026-05-20T03:15:56.599143Z","steps":["trace[1700127606] 'read index received' (duration: 303.493981ms)","trace[1700127606] 'applied index is now lower than readState.Index' (duration: 19.490192ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:15:56.599184Z","caller":"traceutil/trace.go:171","msg":"trace[1599995239] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"642.488632ms","start":"2026-05-20T03:15:55.956664Z","end":"2026-05-20T03:15:56.599153Z","steps":["trace[1599995239] 'process raft request' (duration: 623.055322ms)","trace[1599995239] 'compare' (duration: 18.997227ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:15:56.599308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.132107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:15:56.599347Z","caller":"traceutil/trace.go:171","msg":"trace[2038647029] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1046; }","duration":"323.2295ms","start":"2026-05-20T03:15:56.276105Z","end":"2026-05-20T03:15:56.599334Z","steps":["trace[2038647029] 'agreement among raft nodes before linearized reading' (duration: 323.145047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:56.599348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:55.956627Z","time spent":"642.661226ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:15:56.599376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:56.276086Z","time spent":"323.280901ms","remote":"127.0.0.1:47902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:15:56.599835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.681789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:15:56.599867Z","caller":"traceutil/trace.go:171","msg":"trace[1784414703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"120.74469ms","start":"2026-05-20T03:15:56.479112Z","end":"2026-05-20T03:15:56.599857Z","steps":["trace[1784414703] 'agreement among raft nodes before linearized reading' (duration: 120.696739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:56.599935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.335974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-20T03:15:56.599957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.842508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T03:15:56.599992Z","caller":"traceutil/trace.go:171","msg":"trace[444147976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1046; }","duration":"193.438216ms","start":"2026-05-20T03:15:56.406537Z","end":"2026-05-20T03:15:56.599975Z","steps":["trace[444147976] 'agreement among raft nodes before linearized reading' (duration: 193.250371ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:56.599999Z","caller":"traceutil/trace.go:171","msg":"trace[804389252] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1046; }","duration":"242.949861ms","start":"2026-05-20T03:15:56.357038Z","end":"2026-05-20T03:15:56.599988Z","steps":["trace[804389252] 'agreement among raft nodes before linearized reading' (duration: 242.882769ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:56.600374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.685704ms","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-05-20T03:15:56.600422Z","caller":"traceutil/trace.go:171","msg":"trace[1643777425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"310.761926ms","start":"2026-05-20T03:15:56.289646Z","end":"2026-05-20T03:15:56.600408Z","steps":["trace[1643777425] 'agreement among raft nodes before linearized reading' (duration: 309.982975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:56.600463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:56.289628Z","time spent":"310.822957ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-20T03:15:56.755216Z","caller":"traceutil/trace.go:171","msg":"trace[1222420770] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"151.478324ms","start":"2026-05-20T03:15:56.603717Z","end":"2026-05-20T03:15:56.755196Z","steps":["trace[1222420770] 'process raft request' (duration: 143.228973ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:56.755448Z","caller":"traceutil/trace.go:171","msg":"trace[305509852] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1087; }","duration":"104.230469ms","start":"2026-05-20T03:15:56.6512Z","end":"2026-05-20T03:15:56.75543Z","steps":["trace[305509852] 'read index received' (duration: 7.863231ms)","trace[305509852] 'applied index is now lower than readState.Index' (duration: 96.366598ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:15:56.755478Z","caller":"traceutil/trace.go:171","msg":"trace[915688934] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"151.358501ms","start":"2026-05-20T03:15:56.604097Z","end":"2026-05-20T03:15:56.755455Z","steps":["trace[915688934] 'process raft request' (duration: 151.063303ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:56.755483Z","caller":"traceutil/trace.go:171","msg":"trace[757597947] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"150.800505ms","start":"2026-05-20T03:15:56.604654Z","end":"2026-05-20T03:15:56.755455Z","steps":["trace[757597947] 'process raft request' (duration: 150.710792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:56.755542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.332961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T03:15:56.755565Z","caller":"traceutil/trace.go:171","msg":"trace[1100647218] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1050; }","duration":"104.413644ms","start":"2026-05-20T03:15:56.651144Z","end":"2026-05-20T03:15:56.755558Z","steps":["trace[1100647218] 'agreement among raft nodes before linearized reading' (duration: 104.346623ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:58.818625Z","caller":"traceutil/trace.go:171","msg":"trace[576398490] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"153.772395ms","start":"2026-05-20T03:15:58.66483Z","end":"2026-05-20T03:15:58.818602Z","steps":["trace[576398490] 'process raft request' (duration: 153.601581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:59.284985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.624647ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:15:59.28512Z","caller":"traceutil/trace.go:171","msg":"trace[1718191153] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1053; }","duration":"379.764041ms","start":"2026-05-20T03:15:58.905334Z","end":"2026-05-20T03:15:59.285098Z","steps":["trace[1718191153] 'range keys from in-memory index tree' (duration: 379.611437ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:59.285473Z","caller":"traceutil/trace.go:171","msg":"trace[1822042761] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"462.470775ms","start":"2026-05-20T03:15:58.822985Z","end":"2026-05-20T03:15:59.285456Z","steps":["trace[1822042761] 'process raft request' (duration: 462.392993ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:59.28549Z","caller":"traceutil/trace.go:171","msg":"trace[470250120] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"462.509177ms","start":"2026-05-20T03:15:58.822964Z","end":"2026-05-20T03:15:59.285473Z","steps":["trace[470250120] 'process raft request' (duration: 456.711401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:59.285597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:58.822942Z","time spent":"462.593959ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:15:59.2856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:58.822968Z","time spent":"462.567698ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:15:59.331123Z","caller":"traceutil/trace.go:171","msg":"trace[720346919] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"507.931241ms","start":"2026-05-20T03:15:58.82317Z","end":"2026-05-20T03:15:59.331101Z","steps":["trace[720346919] 'process raft request' (duration: 507.715916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:59.331236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:58.823157Z","time spent":"508.023643ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:15:59.495564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.505443ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-20T03:15:59.495894Z","caller":"traceutil/trace.go:171","msg":"trace[1583072817] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"467.226082ms","start":"2026-05-20T03:15:59.028634Z","end":"2026-05-20T03:15:59.49586Z","steps":["trace[1583072817] 'process raft request' (duration: 467.056688ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:59.495917Z","caller":"traceutil/trace.go:171","msg":"trace[1613658646] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"169.830575ms","start":"2026-05-20T03:15:59.326064Z","end":"2026-05-20T03:15:59.495895Z","steps":["trace[1613658646] 'process raft request' (duration: 169.769014ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:15:59.49593Z","caller":"traceutil/trace.go:171","msg":"trace[151069974] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1094; }","duration":"421.93548ms","start":"2026-05-20T03:15:59.07397Z","end":"2026-05-20T03:15:59.495905Z","steps":["trace[151069974] 'read index received' (duration: 205.689963ms)","trace[151069974] 'applied index is now lower than readState.Index' (duration: 216.242527ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:15:59.496051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.064994ms","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-05-20T03:15:59.496088Z","caller":"traceutil/trace.go:171","msg":"trace[1921498203] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1058; }","duration":"422.168147ms","start":"2026-05-20T03:15:59.073905Z","end":"2026-05-20T03:15:59.496074Z","steps":["trace[1921498203] 'agreement among raft nodes before linearized reading' (duration: 422.088805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:15:59.496113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:59.073888Z","time spent":"422.218098ms","remote":"127.0.0.1:40244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:15:59.496099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:15:59.028604Z","time spent":"467.350876ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:16:13.982866Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18421303863043177671,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T03:16:14.008969Z","caller":"traceutil/trace.go:171","msg":"trace[197833381] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"560.617621ms","start":"2026-05-20T03:16:13.448297Z","end":"2026-05-20T03:16:14.008914Z","steps":["trace[197833381] 'process raft request' (duration: 560.495368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:14.009112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:13.44828Z","time spent":"560.759054ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:16:14.013712Z","caller":"traceutil/trace.go:171","msg":"trace[1961298643] linearizableReadLoop","detail":"{readStateIndex:1200; appliedIndex:1198; }","duration":"531.754298ms","start":"2026-05-20T03:16:13.481947Z","end":"2026-05-20T03:16:14.013702Z","steps":["trace[1961298643] 'read index received' (duration: 527.484815ms)","trace[1961298643] 'applied index is now lower than readState.Index' (duration: 4.268623ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:16:14.013867Z","caller":"traceutil/trace.go:171","msg":"trace[98114051] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"565.362879ms","start":"2026-05-20T03:16:13.448496Z","end":"2026-05-20T03:16:14.013859Z","steps":["trace[98114051] 'process raft request' (duration: 565.129682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:14.013925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:13.448489Z","time spent":"565.399699ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:16:14.014017Z","caller":"traceutil/trace.go:171","msg":"trace[1344758493] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"472.111783ms","start":"2026-05-20T03:16:13.541899Z","end":"2026-05-20T03:16:14.014011Z","steps":["trace[1344758493] 'process raft request' (duration: 471.777504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:14.014058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:13.541876Z","time spent":"472.161223ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:16:14.014149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.209861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:14.014173Z","caller":"traceutil/trace.go:171","msg":"trace[1421244085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1154; }","duration":"532.270173ms","start":"2026-05-20T03:16:13.481897Z","end":"2026-05-20T03:16:14.014167Z","steps":["trace[1421244085] 'agreement among raft nodes before linearized reading' (duration: 532.233002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:14.014192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:13.481878Z","time spent":"532.308973ms","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T03:16:14.014337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.735305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.30\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-20T03:16:14.01436Z","caller":"traceutil/trace.go:171","msg":"trace[445607627] range","detail":"{range_begin:/registry/masterleases/199.204.45.30; range_end:; response_count:1; response_revision:1154; }","duration":"319.792167ms","start":"2026-05-20T03:16:13.694562Z","end":"2026-05-20T03:16:14.014355Z","steps":["trace[445607627] 'agreement among raft nodes before linearized reading' (duration: 319.716405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:14.014379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:13.694543Z","time spent":"319.829728ms","remote":"127.0.0.1:39774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.30\" "} {"level":"info","ts":"2026-05-20T03:16:15.303738Z","caller":"traceutil/trace.go:171","msg":"trace[1454885691] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"355.966015ms","start":"2026-05-20T03:16:14.947754Z","end":"2026-05-20T03:16:15.30372Z","steps":["trace[1454885691] 'process raft request' (duration: 355.848541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:15.303869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:14.947743Z","time spent":"356.066909ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:16:15.809841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.793706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T03:16:15.809905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.042458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:15.809952Z","caller":"traceutil/trace.go:171","msg":"trace[2096546268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1157; }","duration":"328.097769ms","start":"2026-05-20T03:16:15.481843Z","end":"2026-05-20T03:16:15.809941Z","steps":["trace[2096546268] 'range keys from in-memory index tree' (duration: 327.992896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:15.809973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:15.481809Z","time spent":"328.160191ms","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T03:16:15.810028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.461342ms","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-05-20T03:16:15.809912Z","caller":"traceutil/trace.go:171","msg":"trace[1914888507] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1157; }","duration":"421.91651ms","start":"2026-05-20T03:16:15.387976Z","end":"2026-05-20T03:16:15.809892Z","steps":["trace[1914888507] 'count revisions from in-memory index tree' (duration: 421.689763ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:15.810058Z","caller":"traceutil/trace.go:171","msg":"trace[1855834933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1157; }","duration":"361.517974ms","start":"2026-05-20T03:16:15.448531Z","end":"2026-05-20T03:16:15.810049Z","steps":["trace[1855834933] 'range keys from in-memory index tree' (duration: 361.341569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:15.81008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:15.387952Z","time spent":"422.121634ms","remote":"127.0.0.1:47884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-20T03:16:15.81009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:15.448516Z","time spent":"361.565725ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-20T03:16:28.514689Z","caller":"traceutil/trace.go:171","msg":"trace[369539521] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"143.632463ms","start":"2026-05-20T03:16:28.371029Z","end":"2026-05-20T03:16:28.514661Z","steps":["trace[369539521] 'process raft request' (duration: 143.463148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:32.580283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.517212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:16:32.580393Z","caller":"traceutil/trace.go:171","msg":"trace[415956551] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"485.629576ms","start":"2026-05-20T03:16:32.094747Z","end":"2026-05-20T03:16:32.580376Z","steps":["trace[415956551] 'read index received' (duration: 181.96607ms)","trace[415956551] 'applied index is now lower than readState.Index' (duration: 303.662216ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:16:32.58046Z","caller":"traceutil/trace.go:171","msg":"trace[155869130] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"506.125483ms","start":"2026-05-20T03:16:32.074305Z","end":"2026-05-20T03:16:32.580431Z","steps":["trace[155869130] 'process raft request' (duration: 202.372365ms)","trace[155869130] 'compare' (duration: 303.366348ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:16:32.580607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:32.074278Z","time spent":"506.252147ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:16:32.580722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.967304ms","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-05-20T03:16:32.580788Z","caller":"traceutil/trace.go:171","msg":"trace[637105980] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1232; }","duration":"486.060896ms","start":"2026-05-20T03:16:32.094716Z","end":"2026-05-20T03:16:32.580777Z","steps":["trace[637105980] 'agreement among raft nodes before linearized reading' (duration: 485.843561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:32.580869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:32.094698Z","time spent":"486.161309ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-20T03:16:32.581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.889315ms","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-05-20T03:16:32.581047Z","caller":"traceutil/trace.go:171","msg":"trace[1733208458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1232; }","duration":"484.945856ms","start":"2026-05-20T03:16:32.09609Z","end":"2026-05-20T03:16:32.581036Z","steps":["trace[1733208458] 'agreement among raft nodes before linearized reading' (duration: 484.808892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:32.581083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:32.096084Z","time spent":"484.992657ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T03:16:32.581398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.222913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:32.581441Z","caller":"traceutil/trace.go:171","msg":"trace[645324822] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1232; }","duration":"223.306155ms","start":"2026-05-20T03:16:32.358125Z","end":"2026-05-20T03:16:32.581431Z","steps":["trace[645324822] 'agreement among raft nodes before linearized reading' (duration: 223.246074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:32.581626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.437448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:32.581659Z","caller":"traceutil/trace.go:171","msg":"trace[1283081798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1232; }","duration":"482.48584ms","start":"2026-05-20T03:16:32.099166Z","end":"2026-05-20T03:16:32.581652Z","steps":["trace[1283081798] 'agreement among raft nodes before linearized reading' (duration: 482.434569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:32.581674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:32.09916Z","time spent":"482.511041ms","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T03:16:33.253754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.785567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:33.253829Z","caller":"traceutil/trace.go:171","msg":"trace[23710387] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1237; }","duration":"171.90798ms","start":"2026-05-20T03:16:33.081905Z","end":"2026-05-20T03:16:33.253813Z","steps":["trace[23710387] 'range keys from in-memory index tree' (duration: 171.716975ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:33.421015Z","caller":"traceutil/trace.go:171","msg":"trace[1349689553] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"163.209887ms","start":"2026-05-20T03:16:33.257776Z","end":"2026-05-20T03:16:33.420982Z","steps":["trace[1349689553] 'process raft request' (duration: 162.610461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:33.761158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.848906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T03:16:33.761236Z","caller":"traceutil/trace.go:171","msg":"trace[1332732991] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"335.422354ms","start":"2026-05-20T03:16:33.4258Z","end":"2026-05-20T03:16:33.761222Z","steps":["trace[1332732991] 'process raft request' (duration: 82.449376ms)","trace[1332732991] 'compare' (duration: 252.754083ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T03:16:33.761276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:33.425775Z","time spent":"335.482777ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T03:16:33.771393Z","caller":"traceutil/trace.go:171","msg":"trace[1118159865] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1288; }","duration":"289.527336ms","start":"2026-05-20T03:16:33.481847Z","end":"2026-05-20T03:16:33.771374Z","steps":["trace[1118159865] 'read index received' (duration: 26.437417ms)","trace[1118159865] 'applied index is now lower than readState.Index' (duration: 263.089089ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:16:33.771476Z","caller":"traceutil/trace.go:171","msg":"trace[480577582] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"344.309573ms","start":"2026-05-20T03:16:33.427157Z","end":"2026-05-20T03:16:33.771467Z","steps":["trace[480577582] 'process raft request' (duration: 344.097237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:33.771541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:33.427139Z","time spent":"344.359455ms","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T03:16:33.771831Z","caller":"traceutil/trace.go:171","msg":"trace[2067349267] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"342.468793ms","start":"2026-05-20T03:16:33.429352Z","end":"2026-05-20T03:16:33.771821Z","steps":["trace[2067349267] 'process raft request' (duration: 341.97507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:33.771888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:33.429341Z","time spent":"342.513265ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:16:33.772076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.239736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:33.772105Z","caller":"traceutil/trace.go:171","msg":"trace[584901273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1241; }","duration":"290.313589ms","start":"2026-05-20T03:16:33.481783Z","end":"2026-05-20T03:16:33.772096Z","steps":["trace[584901273] 'agreement among raft nodes before linearized reading' (duration: 290.265087ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:33.787364Z","caller":"traceutil/trace.go:171","msg":"trace[1917014168] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"273.322084ms","start":"2026-05-20T03:16:33.513983Z","end":"2026-05-20T03:16:33.787305Z","steps":["trace[1917014168] 'process raft request' (duration: 273.144588ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:34.837619Z","caller":"traceutil/trace.go:171","msg":"trace[1466113295] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"170.851892ms","start":"2026-05-20T03:16:34.666742Z","end":"2026-05-20T03:16:34.837594Z","steps":["trace[1466113295] 'process raft request' (duration: 120.253038ms)","trace[1466113295] 'compare' (duration: 50.310206ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:16:44.456812Z","caller":"traceutil/trace.go:171","msg":"trace[2133323331] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"246.984734ms","start":"2026-05-20T03:16:44.209804Z","end":"2026-05-20T03:16:44.456789Z","steps":["trace[2133323331] 'process raft request' (duration: 246.82041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:44.760325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.340763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-20T03:16:44.760408Z","caller":"traceutil/trace.go:171","msg":"trace[1830527126] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1319; }","duration":"221.464157ms","start":"2026-05-20T03:16:44.538927Z","end":"2026-05-20T03:16:44.760391Z","steps":["trace[1830527126] 'range keys from in-memory index tree' (duration: 221.183839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:44.760398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.641899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-20T03:16:44.760403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.752281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T03:16:44.760491Z","caller":"traceutil/trace.go:171","msg":"trace[1515242529] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1319; }","duration":"105.779422ms","start":"2026-05-20T03:16:44.654678Z","end":"2026-05-20T03:16:44.760458Z","steps":["trace[1515242529] 'count revisions from in-memory index tree' (duration: 105.555858ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:44.760509Z","caller":"traceutil/trace.go:171","msg":"trace[1796848594] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1319; }","duration":"252.968496ms","start":"2026-05-20T03:16:44.507515Z","end":"2026-05-20T03:16:44.760484Z","steps":["trace[1796848594] 'count revisions from in-memory index tree' (duration: 252.679439ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:44.986343Z","caller":"traceutil/trace.go:171","msg":"trace[129189836] linearizableReadLoop","detail":"{readStateIndex:1373; appliedIndex:1372; }","duration":"296.033527ms","start":"2026-05-20T03:16:44.690282Z","end":"2026-05-20T03:16:44.986316Z","steps":["trace[129189836] 'read index received' (duration: 295.808332ms)","trace[129189836] 'applied index is now lower than readState.Index' (duration: 224.245µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:16:44.986425Z","caller":"traceutil/trace.go:171","msg":"trace[881671242] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"324.997033ms","start":"2026-05-20T03:16:44.661395Z","end":"2026-05-20T03:16:44.986392Z","steps":["trace[881671242] 'process raft request' (duration: 324.711086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:44.986612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.297174ms","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-05-20T03:16:44.986698Z","caller":"traceutil/trace.go:171","msg":"trace[129591669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1320; }","duration":"296.396916ms","start":"2026-05-20T03:16:44.690278Z","end":"2026-05-20T03:16:44.986675Z","steps":["trace[129591669] 'agreement among raft nodes before linearized reading' (duration: 296.130599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:44.986871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T03:16:44.661368Z","time spent":"325.278569ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T03:16:44.990484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.840691ms","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-05-20T03:16:44.990562Z","caller":"traceutil/trace.go:171","msg":"trace[762656277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"233.971295ms","start":"2026-05-20T03:16:44.756573Z","end":"2026-05-20T03:16:44.990544Z","steps":["trace[762656277] 'agreement among raft nodes before linearized reading' (duration: 233.754489ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:16:44.99117Z","caller":"traceutil/trace.go:171","msg":"trace[1592559278] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"226.804212ms","start":"2026-05-20T03:16:44.764338Z","end":"2026-05-20T03:16:44.991142Z","steps":["trace[1592559278] 'process raft request' (duration: 225.888649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:16:44.991419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.640212ms","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-05-20T03:16:44.991556Z","caller":"traceutil/trace.go:171","msg":"trace[278108689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"113.736785ms","start":"2026-05-20T03:16:44.877725Z","end":"2026-05-20T03:16:44.991462Z","steps":["trace[278108689] 'agreement among raft nodes before linearized reading' (duration: 113.493558ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:20:18.27003Z","caller":"traceutil/trace.go:171","msg":"trace[455412831] transaction","detail":"{read_only:false; response_revision:2319; number_of_response:1; }","duration":"229.195577ms","start":"2026-05-20T03:20:18.040802Z","end":"2026-05-20T03:20:18.269998Z","steps":["trace[455412831] 'process raft request' (duration: 229.014173ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:20:18.271785Z","caller":"traceutil/trace.go:171","msg":"trace[866294390] linearizableReadLoop","detail":"{readStateIndex:2416; appliedIndex:2414; }","duration":"210.315422ms","start":"2026-05-20T03:20:18.061445Z","end":"2026-05-20T03:20:18.27176Z","steps":["trace[866294390] 'read index received' (duration: 208.412884ms)","trace[866294390] 'applied index is now lower than readState.Index' (duration: 1.901568ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T03:20:18.271823Z","caller":"traceutil/trace.go:171","msg":"trace[431138832] transaction","detail":"{read_only:false; response_revision:2320; number_of_response:1; }","duration":"229.621869ms","start":"2026-05-20T03:20:18.042174Z","end":"2026-05-20T03:20:18.271796Z","steps":["trace[431138832] 'process raft request' (duration: 229.429314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T03:20:18.272057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.226064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-20T03:20:18.272053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.581459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-05-20T03:20:18.272098Z","caller":"traceutil/trace.go:171","msg":"trace[1875959103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2320; }","duration":"205.309095ms","start":"2026-05-20T03:20:18.066779Z","end":"2026-05-20T03:20:18.272088Z","steps":["trace[1875959103] 'agreement among raft nodes before linearized reading' (duration: 205.142491ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:20:18.272125Z","caller":"traceutil/trace.go:171","msg":"trace[1644946414] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2320; }","duration":"210.688522ms","start":"2026-05-20T03:20:18.061418Z","end":"2026-05-20T03:20:18.272106Z","steps":["trace[1644946414] 'agreement among raft nodes before linearized reading' (duration: 210.494177ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T03:20:25.928424Z","caller":"traceutil/trace.go:171","msg":"trace[801652011] transaction","detail":"{read_only:false; response_revision:2361; number_of_response:1; }","duration":"195.892129ms","start":"2026-05-20T03:20:25.732504Z","end":"2026-05-20T03:20:25.928397Z","steps":["trace[801652011] 'process raft request' (duration: 195.749995ms)"],"step_count":1}