{"level":"warn","ts":"2026-04-17T04:10:29.113574Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T04:10:29.113696Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-04-17T04:10:29.114392Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T04:10:29.114415Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-17T04:10:29.114509Z","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-04-17T04:10:29.115403Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-04-17T04:10:29.115589Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-04-17T04:10:29.120338Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.369085ms"} {"level":"info","ts":"2026-04-17T04:10:29.133037Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-04-17T04:10:29.133118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T04:10:29.133136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-04-17T04:10:29.133148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T04:10:29.133154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-04-17T04:10:29.133183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-04-17T04:10:29.139323Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T04:10:29.141097Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T04:10:29.1434Z","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-04-17T04:10:29.145949Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T04:10:29.14644Z","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-04-17T04:10:29.148927Z","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-04-17T04:10:29.148952Z","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-04-17T04:10:29.150294Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T04:10:29.151394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-04-17T04:10:29.151814Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-17T04:10:29.153769Z","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-04-17T04:10:29.153919Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-17T04:10:29.153967Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-17T04:10:29.154182Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T04:10:29.154221Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T04:10:29.733819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T04:10:29.733875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T04:10:29.733902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-04-17T04:10:29.733913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-04-17T04:10:29.733918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-17T04:10:29.733926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-04-17T04:10:29.733934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-17T04:10:29.73472Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:10:29.735377Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T04:10:29.735637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T04:10:29.735716Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T04:10:29.735751Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T04:10:29.735823Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T04:10:29.738926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-04-17T04:10:29.739633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T04:10:29.751992Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:10:29.752191Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:10:29.752223Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:10:55.053644Z","caller":"traceutil/trace.go:171","msg":"trace[1200030963] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"192.251957ms","start":"2026-04-17T04:10:54.861365Z","end":"2026-04-17T04:10:55.053617Z","steps":["trace[1200030963] 'process raft request' (duration: 165.747344ms)","trace[1200030963] 'compare' (duration: 26.396941ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:10:57.439959Z","caller":"traceutil/trace.go:171","msg":"trace[773706525] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"152.532335ms","start":"2026-04-17T04:10:57.287399Z","end":"2026-04-17T04:10:57.439931Z","steps":["trace[773706525] 'read index received' (duration: 151.89153ms)","trace[773706525] 'applied index is now lower than readState.Index' (duration: 639.785µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:10:57.440016Z","caller":"traceutil/trace.go:171","msg":"trace[948695481] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"428.472939ms","start":"2026-04-17T04:10:57.011496Z","end":"2026-04-17T04:10:57.439969Z","steps":["trace[948695481] 'process raft request' (duration: 428.022128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:57.440109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.691948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:10:57.440176Z","caller":"traceutil/trace.go:171","msg":"trace[1905847925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"152.815431ms","start":"2026-04-17T04:10:57.287349Z","end":"2026-04-17T04:10:57.440164Z","steps":["trace[1905847925] 'agreement among raft nodes before linearized reading' (duration: 152.685638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:57.441037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:57.011453Z","time spent":"428.652333ms","remote":"127.0.0.1:46572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:10:59.573839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.010885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:10:59.574039Z","caller":"traceutil/trace.go:171","msg":"trace[942108488] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"424.467964ms","start":"2026-04-17T04:10:59.149547Z","end":"2026-04-17T04:10:59.574015Z","steps":["trace[942108488] 'process raft request' (duration: 190.494536ms)","trace[942108488] 'compare' (duration: 232.862312ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:10:59.574222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.149529Z","time spent":"424.598648ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:10:59.575192Z","caller":"traceutil/trace.go:171","msg":"trace[874914071] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"425.414017ms","start":"2026-04-17T04:10:59.149746Z","end":"2026-04-17T04:10:59.57516Z","steps":["trace[874914071] 'process raft request' (duration: 425.245933ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:10:59.575213Z","caller":"traceutil/trace.go:171","msg":"trace[1415597848] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"425.219312ms","start":"2026-04-17T04:10:59.149965Z","end":"2026-04-17T04:10:59.575185Z","steps":["trace[1415597848] 'process raft request' (duration: 425.12071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:59.575311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.149947Z","time spent":"425.320824ms","remote":"127.0.0.1:47006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:10:59.575383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.149719Z","time spent":"425.543979ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:10:59.575481Z","caller":"traceutil/trace.go:171","msg":"trace[238870871] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:499; }","duration":"286.976844ms","start":"2026-04-17T04:10:59.288484Z","end":"2026-04-17T04:10:59.575461Z","steps":["trace[238870871] 'read index received' (duration: 51.655394ms)","trace[238870871] 'applied index is now lower than readState.Index' (duration: 235.32073ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:10:59.575579Z","caller":"traceutil/trace.go:171","msg":"trace[1996186531] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"414.871549ms","start":"2026-04-17T04:10:59.160694Z","end":"2026-04-17T04:10:59.575565Z","steps":["trace[1996186531] 'process raft request' (duration: 414.511541ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:10:59.575624Z","caller":"traceutil/trace.go:171","msg":"trace[247441961] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"414.724125ms","start":"2026-04-17T04:10:59.160891Z","end":"2026-04-17T04:10:59.575615Z","steps":["trace[247441961] 'process raft request' (duration: 414.345477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:59.575682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.160672Z","time spent":"414.952601ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:10:59.575691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.160862Z","time spent":"414.781727ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:10:59.575835Z","caller":"traceutil/trace.go:171","msg":"trace[1163851184] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"414.482059ms","start":"2026-04-17T04:10:59.161344Z","end":"2026-04-17T04:10:59.575826Z","steps":["trace[1163851184] 'process raft request' (duration: 413.931016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:59.575887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.161327Z","time spent":"414.530481ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:10:59.575977Z","caller":"traceutil/trace.go:171","msg":"trace[1494250029] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"399.467757ms","start":"2026-04-17T04:10:59.176454Z","end":"2026-04-17T04:10:59.575922Z","steps":["trace[1494250029] 'process raft request' (duration: 398.860462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:59.576011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.176439Z","time spent":"399.558228ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:10:59.576009Z","caller":"traceutil/trace.go:171","msg":"trace[39017997] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"277.46081ms","start":"2026-04-17T04:10:59.298521Z","end":"2026-04-17T04:10:59.575982Z","steps":["trace[39017997] 'process raft request' (duration: 276.839956ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:10:59.576072Z","caller":"traceutil/trace.go:171","msg":"trace[1804135264] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"415.391461ms","start":"2026-04-17T04:10:59.160676Z","end":"2026-04-17T04:10:59.576067Z","steps":["trace[1804135264] 'process raft request' (duration: 414.5011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:59.575592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.091716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:10:59.576275Z","caller":"traceutil/trace.go:171","msg":"trace[590037266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:489; }","duration":"287.810283ms","start":"2026-04-17T04:10:59.288439Z","end":"2026-04-17T04:10:59.57625Z","steps":["trace[590037266] 'agreement among raft nodes before linearized reading' (duration: 287.097047ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:10:59.582935Z","caller":"traceutil/trace.go:171","msg":"trace[1473352232] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"416.690212ms","start":"2026-04-17T04:10:59.160053Z","end":"2026-04-17T04:10:59.576743Z","steps":["trace[1473352232] 'process raft request' (duration: 415.070354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:10:59.583223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.160026Z","time spent":"422.98507ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:10:59.58373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:10:59.160626Z","time spent":"415.460183ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:11:00.954706Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310742525383015,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T04:11:01.268708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.33881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:01.268795Z","caller":"traceutil/trace.go:171","msg":"trace[2049332933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"978.463203ms","start":"2026-04-17T04:11:00.29031Z","end":"2026-04-17T04:11:01.268773Z","steps":["trace[2049332933] 'range keys from in-memory index tree' (duration: 978.243037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:01.268857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:00.290296Z","time spent":"978.548114ms","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:11:01.337818Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.03451726s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T04:11:01.338469Z","caller":"traceutil/trace.go:171","msg":"trace[1962115992] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"883.826159ms","start":"2026-04-17T04:11:00.45462Z","end":"2026-04-17T04:11:01.338446Z","steps":["trace[1962115992] 'read index received' (duration: 883.377068ms)","trace[1962115992] 'applied index is now lower than readState.Index' (duration: 448.271µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:11:01.338533Z","caller":"traceutil/trace.go:171","msg":"trace[401475752] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.036199209s","start":"2026-04-17T04:11:00.302311Z","end":"2026-04-17T04:11:01.33851Z","steps":["trace[401475752] 'process raft request' (duration: 1.035871052s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:01.338625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:00.302276Z","time spent":"1.036289942s","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:11:01.33868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.041114ms","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-04-17T04:11:01.338717Z","caller":"traceutil/trace.go:171","msg":"trace[1770250143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"884.127196ms","start":"2026-04-17T04:11:00.454579Z","end":"2026-04-17T04:11:01.338706Z","steps":["trace[1770250143] 'agreement among raft nodes before linearized reading' (duration: 884.003013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:01.33877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:00.45456Z","time spent":"884.199127ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T04:11:01.339469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.967838ms","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-04-17T04:11:01.339516Z","caller":"traceutil/trace.go:171","msg":"trace[1902209231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"480.071701ms","start":"2026-04-17T04:11:00.859436Z","end":"2026-04-17T04:11:01.339508Z","steps":["trace[1902209231] 'agreement among raft nodes before linearized reading' (duration: 479.965628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:01.339533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.463691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:11:01.339619Z","caller":"traceutil/trace.go:171","msg":"trace[1903371709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"789.538333ms","start":"2026-04-17T04:11:00.550021Z","end":"2026-04-17T04:11:01.339559Z","steps":["trace[1903371709] 'agreement among raft nodes before linearized reading' (duration: 789.303848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:01.339686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:00.859416Z","time spent":"480.261176ms","remote":"127.0.0.1:46726","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-04-17T04:11:01.339702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:00.549993Z","time spent":"789.647676ms","remote":"127.0.0.1:46726","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-04-17T04:11:01.512694Z","caller":"traceutil/trace.go:171","msg":"trace[171760659] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:552; }","duration":"163.088192ms","start":"2026-04-17T04:11:01.349587Z","end":"2026-04-17T04:11:01.512675Z","steps":["trace[171760659] 'read index received' (duration: 121.31295ms)","trace[171760659] 'applied index is now lower than readState.Index' (duration: 41.774112ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:11:01.512722Z","caller":"traceutil/trace.go:171","msg":"trace[510831682] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"170.272142ms","start":"2026-04-17T04:11:01.342416Z","end":"2026-04-17T04:11:01.512688Z","steps":["trace[510831682] 'process raft request' (duration: 128.405237ms)","trace[510831682] 'compare' (duration: 41.633259ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:11:01.512792Z","caller":"traceutil/trace.go:171","msg":"trace[381732515] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"169.468352ms","start":"2026-04-17T04:11:01.343298Z","end":"2026-04-17T04:11:01.512766Z","steps":["trace[381732515] 'process raft request' (duration: 169.300749ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:01.513026Z","caller":"traceutil/trace.go:171","msg":"trace[157568046] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"170.116408ms","start":"2026-04-17T04:11:01.342899Z","end":"2026-04-17T04:11:01.513016Z","steps":["trace[157568046] 'process raft request' (duration: 169.662768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:01.513275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.205315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:01.513328Z","caller":"traceutil/trace.go:171","msg":"trace[554449407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"163.746377ms","start":"2026-04-17T04:11:01.349569Z","end":"2026-04-17T04:11:01.513315Z","steps":["trace[554449407] 'agreement among raft nodes before linearized reading' (duration: 163.184724ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:06.829072Z","caller":"traceutil/trace.go:171","msg":"trace[1715645305] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"221.438423ms","start":"2026-04-17T04:11:06.607602Z","end":"2026-04-17T04:11:06.829041Z","steps":["trace[1715645305] 'process raft request' (duration: 220.88567ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:07.166828Z","caller":"traceutil/trace.go:171","msg":"trace[1365514183] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"273.877716ms","start":"2026-04-17T04:11:06.89293Z","end":"2026-04-17T04:11:07.166807Z","steps":["trace[1365514183] 'process raft request' (duration: 217.217484ms)","trace[1365514183] 'compare' (duration: 56.311443ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:11:08.127161Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310742525383128,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T04:11:08.143798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.812209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:08.143924Z","caller":"traceutil/trace.go:171","msg":"trace[492661182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"855.927472ms","start":"2026-04-17T04:11:07.287932Z","end":"2026-04-17T04:11:08.14386Z","steps":["trace[492661182] 'range keys from in-memory index tree' (duration: 855.745658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.143811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.976797ms","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-04-17T04:11:08.14408Z","caller":"traceutil/trace.go:171","msg":"trace[1008572397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"608.279974ms","start":"2026-04-17T04:11:07.535775Z","end":"2026-04-17T04:11:08.144055Z","steps":["trace[1008572397] 'range keys from in-memory index tree' (duration: 607.797203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.144171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:07.535753Z","time spent":"608.401506ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T04:11:08.143947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.647846ms","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-04-17T04:11:08.144505Z","caller":"traceutil/trace.go:171","msg":"trace[250990105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"610.25138ms","start":"2026-04-17T04:11:07.534236Z","end":"2026-04-17T04:11:08.144487Z","steps":["trace[250990105] 'range keys from in-memory index tree' (duration: 609.075152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.144584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:07.534217Z","time spent":"610.350873ms","remote":"127.0.0.1:46726","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-04-17T04:11:08.143967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.892435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:11:08.144803Z","caller":"traceutil/trace.go:171","msg":"trace[745321438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"608.722815ms","start":"2026-04-17T04:11:07.536045Z","end":"2026-04-17T04:11:08.144768Z","steps":["trace[745321438] 'range keys from in-memory index tree' (duration: 607.650349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.144913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:07.536004Z","time spent":"608.879398ms","remote":"127.0.0.1:46726","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-04-17T04:11:08.143996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:07.287917Z","time spent":"856.049695ms","remote":"127.0.0.1:46462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:11:08.498791Z","caller":"traceutil/trace.go:171","msg":"trace[1772937739] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"938.79082ms","start":"2026-04-17T04:11:07.559899Z","end":"2026-04-17T04:11:08.49869Z","steps":["trace[1772937739] 'process raft request' (duration: 936.445815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.499074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:07.559846Z","time spent":"939.084807ms","remote":"127.0.0.1:46572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:08.535292Z","caller":"traceutil/trace.go:171","msg":"trace[1348723227] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"382.842226ms","start":"2026-04-17T04:11:08.152426Z","end":"2026-04-17T04:11:08.535268Z","steps":["trace[1348723227] 'process raft request' (duration: 382.663762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.53544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:08.152402Z","time spent":"382.96358ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:08.535458Z","caller":"traceutil/trace.go:171","msg":"trace[1818520411] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"382.872107ms","start":"2026-04-17T04:11:08.152562Z","end":"2026-04-17T04:11:08.535434Z","steps":["trace[1818520411] 'process raft request' (duration: 382.669152ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:08.535669Z","caller":"traceutil/trace.go:171","msg":"trace[87450467] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"909.37347ms","start":"2026-04-17T04:11:07.62625Z","end":"2026-04-17T04:11:08.535623Z","steps":["trace[87450467] 'read index received' (duration: 869.84262ms)","trace[87450467] 'applied index is now lower than readState.Index' (duration: 39.53017ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:11:08.535671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:08.152545Z","time spent":"383.009571ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:08.535726Z","caller":"traceutil/trace.go:171","msg":"trace[239601397] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"383.070212ms","start":"2026-04-17T04:11:08.152606Z","end":"2026-04-17T04:11:08.535677Z","steps":["trace[239601397] 'process raft request' (duration: 382.773635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.535791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.327702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:08.535811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.560314ms","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-04-17T04:11:08.535837Z","caller":"traceutil/trace.go:171","msg":"trace[482034328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:579; }","duration":"909.615076ms","start":"2026-04-17T04:11:07.626215Z","end":"2026-04-17T04:11:08.535831Z","steps":["trace[482034328] 'agreement among raft nodes before linearized reading' (duration: 909.510903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.535862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:07.626202Z","time spent":"909.655586ms","remote":"127.0.0.1:46726","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-04-17T04:11:08.535837Z","caller":"traceutil/trace.go:171","msg":"trace[985109343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"247.380183ms","start":"2026-04-17T04:11:08.288429Z","end":"2026-04-17T04:11:08.535809Z","steps":["trace[985109343] 'agreement among raft nodes before linearized reading' (duration: 247.337002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:08.535922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:08.152587Z","time spent":"383.223986ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:11:10.101384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.108983ms","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-04-17T04:11:10.101465Z","caller":"traceutil/trace.go:171","msg":"trace[1047199943] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:590; }","duration":"506.232545ms","start":"2026-04-17T04:11:09.595218Z","end":"2026-04-17T04:11:10.10145Z","steps":["trace[1047199943] 'range keys from in-memory index tree' (duration: 506.057921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.101517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.595211Z","time spent":"506.294068ms","remote":"127.0.0.1:42740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-17T04:11:10.101517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.237155ms","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-04-17T04:11:10.101513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.705583ms","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":"info","ts":"2026-04-17T04:11:10.101563Z","caller":"traceutil/trace.go:171","msg":"trace[1408591022] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:590; }","duration":"200.311937ms","start":"2026-04-17T04:11:09.901239Z","end":"2026-04-17T04:11:10.101551Z","steps":["trace[1408591022] 'count revisions from in-memory index tree' (duration: 200.147303ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.101597Z","caller":"traceutil/trace.go:171","msg":"trace[25524513] 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:590; }","duration":"139.819535ms","start":"2026-04-17T04:11:09.961759Z","end":"2026-04-17T04:11:10.101579Z","steps":["trace[25524513] 'range keys from in-memory index tree' (duration: 139.62142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.101621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.553307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.101718Z","caller":"traceutil/trace.go:171","msg":"trace[1953774318] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:590; }","duration":"270.719591ms","start":"2026-04-17T04:11:09.830984Z","end":"2026-04-17T04:11:10.101703Z","steps":["trace[1953774318] 'count revisions from in-memory index tree' (duration: 270.395043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.101735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.529757ms","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-04-17T04:11:10.101783Z","caller":"traceutil/trace.go:171","msg":"trace[1492283358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:590; }","duration":"247.610999ms","start":"2026-04-17T04:11:09.854157Z","end":"2026-04-17T04:11:10.101768Z","steps":["trace[1492283358] 'range keys from in-memory index tree' (duration: 247.443265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.101807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.303526ms","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-04-17T04:11:10.101821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.788903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.101882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.708823ms","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":"info","ts":"2026-04-17T04:11:10.101891Z","caller":"traceutil/trace.go:171","msg":"trace[1590585983] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:590; }","duration":"213.887306ms","start":"2026-04-17T04:11:09.887986Z","end":"2026-04-17T04:11:10.101873Z","steps":["trace[1590585983] 'count revisions from in-memory index tree' (duration: 213.669671ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.101911Z","caller":"traceutil/trace.go:171","msg":"trace[1453713020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"159.741464ms","start":"2026-04-17T04:11:09.942163Z","end":"2026-04-17T04:11:10.101904Z","steps":["trace[1453713020] 'range keys from in-memory index tree' (duration: 159.625061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.101937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.46027ms","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-04-17T04:11:10.101941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.59006ms","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-04-17T04:11:10.101948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.791423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.102007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.561811ms","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-04-17T04:11:10.102023Z","caller":"traceutil/trace.go:171","msg":"trace[354390083] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:590; }","duration":"270.883136ms","start":"2026-04-17T04:11:09.83113Z","end":"2026-04-17T04:11:10.102014Z","steps":["trace[354390083] 'range keys from in-memory index tree' (duration: 270.748622ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.102036Z","caller":"traceutil/trace.go:171","msg":"trace[1003387323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:590; }","duration":"248.616382ms","start":"2026-04-17T04:11:09.85341Z","end":"2026-04-17T04:11:10.102026Z","steps":["trace[1003387323] 'range keys from in-memory index tree' (duration: 248.462018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.375745ms","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":"info","ts":"2026-04-17T04:11:10.102068Z","caller":"traceutil/trace.go:171","msg":"trace[1427645465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"159.418106ms","start":"2026-04-17T04:11:09.942644Z","end":"2026-04-17T04:11:10.102062Z","steps":["trace[1427645465] 'range keys from in-memory index tree' (duration: 159.340344ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.102065Z","caller":"traceutil/trace.go:171","msg":"trace[663992987] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"159.846997ms","start":"2026-04-17T04:11:09.942168Z","end":"2026-04-17T04:11:10.102015Z","steps":["trace[663992987] 'count revisions from in-memory index tree' (duration: 159.451697ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.101987Z","caller":"traceutil/trace.go:171","msg":"trace[194473445] 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:590; }","duration":"140.543333ms","start":"2026-04-17T04:11:09.96143Z","end":"2026-04-17T04:11:10.101973Z","steps":["trace[194473445] 'range keys from in-memory index tree' (duration: 140.362348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.330666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.102399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.158416ms","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":"warn","ts":"2026-04-17T04:11:10.10242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.92516ms","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-04-17T04:11:10.102453Z","caller":"traceutil/trace.go:171","msg":"trace[641646335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:590; }","duration":"248.999272ms","start":"2026-04-17T04:11:09.853445Z","end":"2026-04-17T04:11:10.102444Z","steps":["trace[641646335] 'count revisions from in-memory index tree' (duration: 248.847778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.721377ms","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-04-17T04:11:10.10243Z","caller":"traceutil/trace.go:171","msg":"trace[1792513739] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:590; }","duration":"201.221518ms","start":"2026-04-17T04:11:09.901199Z","end":"2026-04-17T04:11:10.102421Z","steps":["trace[1792513739] 'range keys from in-memory index tree' (duration: 201.000473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.910573ms","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-04-17T04:11:10.102686Z","caller":"traceutil/trace.go:171","msg":"trace[2086326963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"352.954964ms","start":"2026-04-17T04:11:09.749721Z","end":"2026-04-17T04:11:10.102676Z","steps":["trace[2086326963] 'count revisions from in-memory index tree' (duration: 352.891242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.10269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.783874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.10272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.749718Z","time spent":"352.993365ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:11:10.102726Z","caller":"traceutil/trace.go:171","msg":"trace[1016812832] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:590; }","duration":"439.848236ms","start":"2026-04-17T04:11:09.662868Z","end":"2026-04-17T04:11:10.102717Z","steps":["trace[1016812832] 'range keys from in-memory index tree' (duration: 439.728903ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.101849Z","caller":"traceutil/trace.go:171","msg":"trace[1513974622] 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:590; }","duration":"140.375108ms","start":"2026-04-17T04:11:09.961461Z","end":"2026-04-17T04:11:10.101837Z","steps":["trace[1513974622] 'count revisions from in-memory index tree' (duration: 140.236405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.662852Z","time spent":"439.901537ms","remote":"127.0.0.1:42762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-17T04:11:10.102696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.991675ms","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":"info","ts":"2026-04-17T04:11:10.102421Z","caller":"traceutil/trace.go:171","msg":"trace[87794316] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:590; }","duration":"214.389858ms","start":"2026-04-17T04:11:09.888018Z","end":"2026-04-17T04:11:10.102408Z","steps":["trace[87794316] 'range keys from in-memory index tree' (duration: 214.264965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.252502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.1029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.657015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.102871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.284658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.102541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.315021ms","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-04-17T04:11:10.102962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.515674ms","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":"warn","ts":"2026-04-17T04:11:10.102959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.356992ms","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-04-17T04:11:10.103Z","caller":"traceutil/trace.go:171","msg":"trace[722287482] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"395.571635ms","start":"2026-04-17T04:11:09.707416Z","end":"2026-04-17T04:11:10.102988Z","steps":["trace[722287482] 'count revisions from in-memory index tree' (duration: 395.473103ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.10301Z","caller":"traceutil/trace.go:171","msg":"trace[604779777] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"290.408994ms","start":"2026-04-17T04:11:09.812586Z","end":"2026-04-17T04:11:10.102995Z","steps":["trace[604779777] 'count revisions from in-memory index tree' (duration: 290.23452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.10303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.707403Z","time spent":"395.620056ms","remote":"127.0.0.1:42768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:11:10.103007Z","caller":"traceutil/trace.go:171","msg":"trace[72055667] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:590; }","duration":"507.836353ms","start":"2026-04-17T04:11:09.595152Z","end":"2026-04-17T04:11:10.102988Z","steps":["trace[72055667] 'count revisions from in-memory index tree' (duration: 507.169638ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.102961Z","caller":"traceutil/trace.go:171","msg":"trace[1480324174] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"352.395901ms","start":"2026-04-17T04:11:09.750557Z","end":"2026-04-17T04:11:10.102953Z","steps":["trace[1480324174] 'range keys from in-memory index tree' (duration: 352.266428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.633547ms","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-04-17T04:11:10.103166Z","caller":"traceutil/trace.go:171","msg":"trace[1355339639] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"395.692928ms","start":"2026-04-17T04:11:09.707465Z","end":"2026-04-17T04:11:10.103158Z","steps":["trace[1355339639] 'range keys from in-memory index tree' (duration: 395.552565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.10319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.707449Z","time spent":"395.733649ms","remote":"127.0.0.1:42768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-17T04:11:10.102981Z","caller":"traceutil/trace.go:171","msg":"trace[1770696419] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"176.2059ms","start":"2026-04-17T04:11:09.926673Z","end":"2026-04-17T04:11:10.102879Z","steps":["trace[1770696419] 'range keys from in-memory index tree' (duration: 175.930794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.105967ms","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-04-17T04:11:10.103364Z","caller":"traceutil/trace.go:171","msg":"trace[1904636192] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:590; }","duration":"353.669471ms","start":"2026-04-17T04:11:09.74968Z","end":"2026-04-17T04:11:10.10335Z","steps":["trace[1904636192] 'range keys from in-memory index tree' (duration: 353.021465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.749671Z","time spent":"353.722552ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-17T04:11:10.102926Z","caller":"traceutil/trace.go:171","msg":"trace[1961900544] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:590; }","duration":"439.293833ms","start":"2026-04-17T04:11:09.663623Z","end":"2026-04-17T04:11:10.102917Z","steps":["trace[1961900544] 'range keys from in-memory index tree' (duration: 439.214621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.663617Z","time spent":"439.849236ms","remote":"127.0.0.1:42762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-17T04:11:10.102999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.762644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.103542Z","caller":"traceutil/trace.go:171","msg":"trace[1872872174] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:590; }","duration":"463.337147ms","start":"2026-04-17T04:11:09.640194Z","end":"2026-04-17T04:11:10.103531Z","steps":["trace[1872872174] 'range keys from in-memory index tree' (duration: 462.699392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.102664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.679687ms","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-04-17T04:11:10.103624Z","caller":"traceutil/trace.go:171","msg":"trace[1895308559] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:590; }","duration":"507.660079ms","start":"2026-04-17T04:11:09.595953Z","end":"2026-04-17T04:11:10.103613Z","steps":["trace[1895308559] 'range keys from in-memory index tree' (duration: 506.605715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.595927Z","time spent":"507.723151ms","remote":"127.0.0.1:42740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-17T04:11:10.101979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.344143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.102564Z","caller":"traceutil/trace.go:171","msg":"trace[1570320682] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:590; }","duration":"200.803158ms","start":"2026-04-17T04:11:09.901752Z","end":"2026-04-17T04:11:10.102555Z","steps":["trace[1570320682] 'range keys from in-memory index tree' (duration: 200.678735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.268498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.103748Z","caller":"traceutil/trace.go:171","msg":"trace[46116652] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:590; }","duration":"272.129624ms","start":"2026-04-17T04:11:09.831602Z","end":"2026-04-17T04:11:10.103731Z","steps":["trace[46116652] 'range keys from in-memory index tree' (duration: 270.290022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.750553Z","time spent":"352.566675ms","remote":"127.0.0.1:42768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-17T04:11:10.103081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.59509Z","time spent":"507.969886ms","remote":"127.0.0.1:42740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:11:10.102862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.554839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.103994Z","caller":"traceutil/trace.go:171","msg":"trace[774181495] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:590; }","duration":"440.715106ms","start":"2026-04-17T04:11:09.66327Z","end":"2026-04-17T04:11:10.103985Z","steps":["trace[774181495] 'count revisions from in-memory index tree' (duration: 439.472297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.104023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.663252Z","time spent":"440.761668ms","remote":"127.0.0.1:42762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:11:10.10293Z","caller":"traceutil/trace.go:171","msg":"trace[1145199528] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:590; }","duration":"463.712906ms","start":"2026-04-17T04:11:09.639209Z","end":"2026-04-17T04:11:10.102921Z","steps":["trace[1145199528] 'range keys from in-memory index tree' (duration: 463.603224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.104114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.639195Z","time spent":"464.901534ms","remote":"127.0.0.1:42750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-17T04:11:10.103595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.640175Z","time spent":"463.404069ms","remote":"127.0.0.1:42750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-17T04:11:10.103775Z","caller":"traceutil/trace.go:171","msg":"trace[347244404] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:590; }","duration":"215.31863ms","start":"2026-04-17T04:11:09.88845Z","end":"2026-04-17T04:11:10.103769Z","steps":["trace[347244404] 'range keys from in-memory index tree' (duration: 213.228571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.103217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.812618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.104203Z","caller":"traceutil/trace.go:171","msg":"trace[1824764577] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"318.821852ms","start":"2026-04-17T04:11:09.785363Z","end":"2026-04-17T04:11:10.104185Z","steps":["trace[1824764577] 'range keys from in-memory index tree' (duration: 317.728716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.104275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.785345Z","time spent":"318.908574ms","remote":"127.0.0.1:42774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-17T04:11:10.103212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.475956ms","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-04-17T04:11:10.103253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.852469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:11:10.103285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.071399ms","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-04-17T04:11:10.103291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.402144ms","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":"warn","ts":"2026-04-17T04:11:10.102961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.494302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:11:10.104348Z","caller":"traceutil/trace.go:171","msg":"trace[1952731037] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:590; }","duration":"464.888694ms","start":"2026-04-17T04:11:09.639446Z","end":"2026-04-17T04:11:10.104335Z","steps":["trace[1952731037] 'count revisions from in-memory index tree' (duration: 463.451091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.104409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.639441Z","time spent":"464.947295ms","remote":"127.0.0.1:42750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:11:10.104436Z","caller":"traceutil/trace.go:171","msg":"trace[19479312] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"319.035977ms","start":"2026-04-17T04:11:09.785393Z","end":"2026-04-17T04:11:10.104429Z","steps":["trace[19479312] 'count revisions from in-memory index tree' (duration: 317.763567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:10.104466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:09.785336Z","time spent":"319.118849ms","remote":"127.0.0.1:42774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:11:10.104539Z","caller":"traceutil/trace.go:171","msg":"trace[1499294907] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"177.825159ms","start":"2026-04-17T04:11:09.926708Z","end":"2026-04-17T04:11:10.104533Z","steps":["trace[1499294907] 'count revisions from in-memory index tree' (duration: 176.422055ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.104719Z","caller":"traceutil/trace.go:171","msg":"trace[923788388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"291.851198ms","start":"2026-04-17T04:11:09.81286Z","end":"2026-04-17T04:11:10.104711Z","steps":["trace[923788388] 'range keys from in-memory index tree' (duration: 290.359353ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:10.104518Z","caller":"traceutil/trace.go:171","msg":"trace[1111476721] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"292.321639ms","start":"2026-04-17T04:11:09.812183Z","end":"2026-04-17T04:11:10.104505Z","steps":["trace[1111476721] 'range keys from in-memory index tree' (duration: 291.022498ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:13.738025Z","caller":"traceutil/trace.go:171","msg":"trace[212206765] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"130.547678ms","start":"2026-04-17T04:11:13.607422Z","end":"2026-04-17T04:11:13.73797Z","steps":["trace[212206765] 'process raft request' (duration: 130.414495ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:24.632209Z","caller":"traceutil/trace.go:171","msg":"trace[1659304304] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"129.102214ms","start":"2026-04-17T04:11:24.503089Z","end":"2026-04-17T04:11:24.632192Z","steps":["trace[1659304304] 'read index received' (duration: 128.889619ms)","trace[1659304304] 'applied index is now lower than readState.Index' (duration: 211.905µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:11:24.632291Z","caller":"traceutil/trace.go:171","msg":"trace[782871985] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"183.750738ms","start":"2026-04-17T04:11:24.44851Z","end":"2026-04-17T04:11:24.632261Z","steps":["trace[782871985] 'process raft request' (duration: 183.556444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:24.632487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.36985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ws9zc\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-04-17T04:11:24.632606Z","caller":"traceutil/trace.go:171","msg":"trace[1521350051] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ws9zc; range_end:; response_count:1; response_revision:739; }","duration":"129.527544ms","start":"2026-04-17T04:11:24.503053Z","end":"2026-04-17T04:11:24.63258Z","steps":["trace[1521350051] 'agreement among raft nodes before linearized reading' (duration: 129.221647ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:25.227051Z","caller":"traceutil/trace.go:171","msg":"trace[223635801] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"590.762743ms","start":"2026-04-17T04:11:24.636262Z","end":"2026-04-17T04:11:25.227025Z","steps":["trace[223635801] 'process raft request' (duration: 578.764241ms)","trace[223635801] 'compare' (duration: 11.607592ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:11:25.227175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:24.636246Z","time spent":"590.873255ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:25.227512Z","caller":"traceutil/trace.go:171","msg":"trace[1356443789] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"589.896102ms","start":"2026-04-17T04:11:24.637606Z","end":"2026-04-17T04:11:25.227502Z","steps":["trace[1356443789] 'process raft request' (duration: 589.82036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:25.227575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:24.637589Z","time spent":"589.960153ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:25.227763Z","caller":"traceutil/trace.go:171","msg":"trace[380559996] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"589.890252ms","start":"2026-04-17T04:11:24.637866Z","end":"2026-04-17T04:11:25.227756Z","steps":["trace[380559996] 'process raft request' (duration: 589.606815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:25.227805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:24.637853Z","time spent":"589.933332ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:25.228019Z","caller":"traceutil/trace.go:171","msg":"trace[1668861174] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"586.87544ms","start":"2026-04-17T04:11:24.641121Z","end":"2026-04-17T04:11:25.227996Z","steps":["trace[1668861174] 'process raft request' (duration: 586.720757ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:11:25.228017Z","caller":"traceutil/trace.go:171","msg":"trace[140704595] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"590.046155ms","start":"2026-04-17T04:11:24.637952Z","end":"2026-04-17T04:11:25.227998Z","steps":["trace[140704595] 'process raft request' (duration: 589.771549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:25.22818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:24.637937Z","time spent":"590.205999ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:11:25.228253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:24.641112Z","time spent":"586.971362ms","remote":"127.0.0.1:46658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4026,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:59.628837Z","caller":"traceutil/trace.go:171","msg":"trace[1391795665] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"175.896215ms","start":"2026-04-17T04:11:59.45292Z","end":"2026-04-17T04:11:59.628817Z","steps":["trace[1391795665] 'process raft request' (duration: 159.927737ms)","trace[1391795665] 'compare' (duration: 15.846326ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:11:59.875461Z","caller":"traceutil/trace.go:171","msg":"trace[1066633055] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"421.91051ms","start":"2026-04-17T04:11:59.453531Z","end":"2026-04-17T04:11:59.875442Z","steps":["trace[1066633055] 'process raft request' (duration: 421.86947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:11:59.875581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:59.453525Z","time spent":"421.994933ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:11:59.875682Z","caller":"traceutil/trace.go:171","msg":"trace[1826795911] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"422.352491ms","start":"2026-04-17T04:11:59.453323Z","end":"2026-04-17T04:11:59.875675Z","steps":["trace[1826795911] 'process raft request' (duration: 351.37859ms)","trace[1826795911] 'compare' (duration: 70.595382ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:11:59.875713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:59.4533Z","time spent":"422.395362ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:00.06093Z","caller":"traceutil/trace.go:171","msg":"trace[1703588489] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:989; }","duration":"238.751439ms","start":"2026-04-17T04:11:59.822147Z","end":"2026-04-17T04:12:00.060899Z","steps":["trace[1703588489] 'read index received' (duration: 237.769386ms)","trace[1703588489] 'applied index is now lower than readState.Index' (duration: 980.722µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:00.061121Z","caller":"traceutil/trace.go:171","msg":"trace[2022180172] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"402.41374ms","start":"2026-04-17T04:11:59.658639Z","end":"2026-04-17T04:12:00.061053Z","steps":["trace[2022180172] 'process raft request' (duration: 401.289924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:00.061226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.049805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T04:12:00.061302Z","caller":"traceutil/trace.go:171","msg":"trace[163631235] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:955; }","duration":"239.226939ms","start":"2026-04-17T04:11:59.82204Z","end":"2026-04-17T04:12:00.061267Z","steps":["trace[163631235] 'agreement among raft nodes before linearized reading' (duration: 238.976703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:00.061403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:11:59.658609Z","time spent":"402.640266ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:22.407753Z","caller":"traceutil/trace.go:171","msg":"trace[700964216] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1065; }","duration":"120.673478ms","start":"2026-04-17T04:12:22.28705Z","end":"2026-04-17T04:12:22.407724Z","steps":["trace[700964216] 'read index received' (duration: 120.487884ms)","trace[700964216] 'applied index is now lower than readState.Index' (duration: 184.064µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:22.407803Z","caller":"traceutil/trace.go:171","msg":"trace[1996641755] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"268.050114ms","start":"2026-04-17T04:12:22.139718Z","end":"2026-04-17T04:12:22.407768Z","steps":["trace[1996641755] 'process raft request' (duration: 267.813059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:22.407929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.861093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:22.40798Z","caller":"traceutil/trace.go:171","msg":"trace[1095913792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1027; }","duration":"120.960346ms","start":"2026-04-17T04:12:22.287003Z","end":"2026-04-17T04:12:22.407964Z","steps":["trace[1095913792] 'agreement among raft nodes before linearized reading' (duration: 120.836013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:23.776369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.703657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:23.776464Z","caller":"traceutil/trace.go:171","msg":"trace[1421746901] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1030; }","duration":"132.84828ms","start":"2026-04-17T04:12:23.643592Z","end":"2026-04-17T04:12:23.77644Z","steps":["trace[1421746901] 'count revisions from in-memory index tree' (duration: 132.632165ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:24.00988Z","caller":"traceutil/trace.go:171","msg":"trace[1137990905] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1070; }","duration":"282.511589ms","start":"2026-04-17T04:12:23.727349Z","end":"2026-04-17T04:12:24.009861Z","steps":["trace[1137990905] 'read index received' (duration: 281.450374ms)","trace[1137990905] 'applied index is now lower than readState.Index' (duration: 1.060315ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:24.009981Z","caller":"traceutil/trace.go:171","msg":"trace[498735500] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"345.348922ms","start":"2026-04-17T04:12:23.664597Z","end":"2026-04-17T04:12:24.009946Z","steps":["trace[498735500] 'process raft request' (duration: 345.109816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:24.010119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.750505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:12:24.010162Z","caller":"traceutil/trace.go:171","msg":"trace[1289062564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"282.848257ms","start":"2026-04-17T04:12:23.727303Z","end":"2026-04-17T04:12:24.010152Z","steps":["trace[1289062564] 'agreement among raft nodes before linearized reading' (duration: 282.676083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:24.010168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:23.664563Z","time spent":"345.517816ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:25.466072Z","caller":"traceutil/trace.go:171","msg":"trace[1738677692] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"555.540079ms","start":"2026-04-17T04:12:24.910498Z","end":"2026-04-17T04:12:25.466039Z","steps":["trace[1738677692] 'process raft request' (duration: 555.272743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:25.466353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:24.910471Z","time spent":"555.748614ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:36.27866Z","caller":"traceutil/trace.go:171","msg":"trace[1880682865] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1166; }","duration":"165.825982ms","start":"2026-04-17T04:12:36.112814Z","end":"2026-04-17T04:12:36.27864Z","steps":["trace[1880682865] 'read index received' (duration: 160.496939ms)","trace[1880682865] 'applied index is now lower than readState.Index' (duration: 5.328233ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:36.278801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.974126ms","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-04-17T04:12:36.278824Z","caller":"traceutil/trace.go:171","msg":"trace[1558916016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1124; }","duration":"166.032887ms","start":"2026-04-17T04:12:36.112782Z","end":"2026-04-17T04:12:36.278814Z","steps":["trace[1558916016] 'agreement among raft nodes before linearized reading' (duration: 165.929995ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:36.27883Z","caller":"traceutil/trace.go:171","msg":"trace[785723525] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"166.58279ms","start":"2026-04-17T04:12:36.11222Z","end":"2026-04-17T04:12:36.278803Z","steps":["trace[785723525] 'process raft request' (duration: 161.059563ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:37.862576Z","caller":"traceutil/trace.go:171","msg":"trace[1563627079] linearizableReadLoop","detail":"{readStateIndex:1171; appliedIndex:1170; }","duration":"269.747165ms","start":"2026-04-17T04:12:37.592805Z","end":"2026-04-17T04:12:37.862552Z","steps":["trace[1563627079] 'read index received' (duration: 269.706834ms)","trace[1563627079] 'applied index is now lower than readState.Index' (duration: 39.421µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:37.862673Z","caller":"traceutil/trace.go:171","msg":"trace[1352376228] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"331.171594ms","start":"2026-04-17T04:12:37.53147Z","end":"2026-04-17T04:12:37.862642Z","steps":["trace[1352376228] 'process raft request' (duration: 330.945778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:37.862726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.892978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:37.862801Z","caller":"traceutil/trace.go:171","msg":"trace[923722174] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1128; }","duration":"270.01994ms","start":"2026-04-17T04:12:37.592765Z","end":"2026-04-17T04:12:37.862784Z","steps":["trace[923722174] 'agreement among raft nodes before linearized reading' (duration: 269.897047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:37.862861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:37.53145Z","time spent":"331.295276ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:12:38.363508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310742525384397,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T04:12:38.461113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.983882ms","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-04-17T04:12:38.461099Z","caller":"traceutil/trace.go:171","msg":"trace[1724049029] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1171; }","duration":"598.405371ms","start":"2026-04-17T04:12:37.862638Z","end":"2026-04-17T04:12:38.461043Z","steps":["trace[1724049029] 'read index received' (duration: 588.155433ms)","trace[1724049029] 'applied index is now lower than readState.Index' (duration: 10.248397ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:38.461163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.362298ms","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-04-17T04:12:38.46119Z","caller":"traceutil/trace.go:171","msg":"trace[1684181228] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1128; }","duration":"678.42424ms","start":"2026-04-17T04:12:37.782757Z","end":"2026-04-17T04:12:38.461181Z","steps":["trace[1684181228] 'agreement among raft nodes before linearized reading' (duration: 678.391979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:38.461213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:37.782736Z","time spent":"678.47102ms","remote":"127.0.0.1:42778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:12:38.461303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.597559ms","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-04-17T04:12:38.461321Z","caller":"traceutil/trace.go:171","msg":"trace[1333134831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1128; }","duration":"741.651321ms","start":"2026-04-17T04:12:37.719666Z","end":"2026-04-17T04:12:38.461317Z","steps":["trace[1333134831] 'agreement among raft nodes before linearized reading' (duration: 741.575059ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:38.461164Z","caller":"traceutil/trace.go:171","msg":"trace[1939000276] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1128; }","duration":"711.075874ms","start":"2026-04-17T04:12:37.750076Z","end":"2026-04-17T04:12:38.461152Z","steps":["trace[1939000276] 'agreement among raft nodes before linearized reading' (duration: 710.984142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:38.461418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:37.75006Z","time spent":"711.317799ms","remote":"127.0.0.1:46850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:12:38.461341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:37.719646Z","time spent":"741.692061ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T04:12:38.46111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.992705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:38.461546Z","caller":"traceutil/trace.go:171","msg":"trace[1901403304] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1128; }","duration":"712.469266ms","start":"2026-04-17T04:12:37.749069Z","end":"2026-04-17T04:12:38.461539Z","steps":["trace[1901403304] 'agreement among raft nodes before linearized reading' (duration: 711.989765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:38.461567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:37.749049Z","time spent":"712.511418ms","remote":"127.0.0.1:42694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:12:38.461637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.668355ms","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-04-17T04:12:38.461674Z","caller":"traceutil/trace.go:171","msg":"trace[1082528157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1128; }","duration":"170.746866ms","start":"2026-04-17T04:12:38.290917Z","end":"2026-04-17T04:12:38.461664Z","steps":["trace[1082528157] 'agreement among raft nodes before linearized reading' (duration: 170.579182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:38.461679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.336304ms","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-04-17T04:12:38.461703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.530333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:12:38.461702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.652099ms","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-04-17T04:12:38.461726Z","caller":"traceutil/trace.go:171","msg":"trace[1297707978] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1128; }","duration":"331.578483ms","start":"2026-04-17T04:12:38.130141Z","end":"2026-04-17T04:12:38.461719Z","steps":["trace[1297707978] 'agreement among raft nodes before linearized reading' (duration: 331.544672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:38.461741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:38.130127Z","time spent":"331.610174ms","remote":"127.0.0.1:46624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:12:38.461735Z","caller":"traceutil/trace.go:171","msg":"trace[1271650388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1128; }","duration":"349.425865ms","start":"2026-04-17T04:12:38.112292Z","end":"2026-04-17T04:12:38.461718Z","steps":["trace[1271650388] 'agreement among raft nodes before linearized reading' (duration: 349.18528ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:38.461743Z","caller":"traceutil/trace.go:171","msg":"trace[1660983668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1128; }","duration":"178.71677ms","start":"2026-04-17T04:12:38.283009Z","end":"2026-04-17T04:12:38.461725Z","steps":["trace[1660983668] 'agreement among raft nodes before linearized reading' (duration: 178.634028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:38.461788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:38.112275Z","time spent":"349.498867ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T04:12:54.393797Z","caller":"traceutil/trace.go:171","msg":"trace[1249729935] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1244; }","duration":"446.502059ms","start":"2026-04-17T04:12:53.947277Z","end":"2026-04-17T04:12:54.39378Z","steps":["trace[1249729935] 'read index received' (duration: 52.017322ms)","trace[1249729935] 'applied index is now lower than readState.Index' (duration: 394.483957ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:54.394026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.161883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:54.394054Z","caller":"traceutil/trace.go:171","msg":"trace[900695260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1199; }","duration":"106.243365ms","start":"2026-04-17T04:12:54.287803Z","end":"2026-04-17T04:12:54.394046Z","steps":["trace[900695260] 'agreement among raft nodes before linearized reading' (duration: 106.185974ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:54.394149Z","caller":"traceutil/trace.go:171","msg":"trace[1094208520] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"484.970898ms","start":"2026-04-17T04:12:53.909158Z","end":"2026-04-17T04:12:54.394129Z","steps":["trace[1094208520] 'process raft request' (duration: 390.29946ms)","trace[1094208520] 'compare' (duration: 93.780168ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:54.394213Z","caller":"traceutil/trace.go:171","msg":"trace[899021749] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"480.836973ms","start":"2026-04-17T04:12:53.913366Z","end":"2026-04-17T04:12:54.394203Z","steps":["trace[899021749] 'process raft request' (duration: 480.342642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:54.394196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.897558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-17T04:12:54.394291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:53.913357Z","time spent":"480.883934ms","remote":"127.0.0.1:46938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:54.394303Z","caller":"traceutil/trace.go:171","msg":"trace[442176203] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1199; }","duration":"447.010361ms","start":"2026-04-17T04:12:53.947263Z","end":"2026-04-17T04:12:54.394274Z","steps":["trace[442176203] 'agreement among raft nodes before linearized reading' (duration: 446.675383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:54.394304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:53.909147Z","time spent":"485.06657ms","remote":"127.0.0.1:46742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:12:54.394358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:53.947246Z","time spent":"447.099583ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T04:12:54.859012Z","caller":"traceutil/trace.go:171","msg":"trace[34358224] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1248; }","duration":"312.214735ms","start":"2026-04-17T04:12:54.546777Z","end":"2026-04-17T04:12:54.858991Z","steps":["trace[34358224] 'read index received' (duration: 267.045251ms)","trace[34358224] 'applied index is now lower than readState.Index' (duration: 45.168754ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:54.859099Z","caller":"traceutil/trace.go:171","msg":"trace[1849021264] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"326.28734ms","start":"2026-04-17T04:12:54.532785Z","end":"2026-04-17T04:12:54.859073Z","steps":["trace[1849021264] 'process raft request' (duration: 281.125606ms)","trace[1849021264] 'compare' (duration: 44.9805ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:54.859209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.427319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-17T04:12:54.85922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.532761Z","time spent":"326.391853ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:54.85924Z","caller":"traceutil/trace.go:171","msg":"trace[478432801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1201; }","duration":"312.518181ms","start":"2026-04-17T04:12:54.546713Z","end":"2026-04-17T04:12:54.859231Z","steps":["trace[478432801] 'agreement among raft nodes before linearized reading' (duration: 312.395199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:54.859268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.546687Z","time spent":"312.574483ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T04:12:54.859388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.730332ms","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-04-17T04:12:54.859436Z","caller":"traceutil/trace.go:171","msg":"trace[1160030691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1201; }","duration":"304.802634ms","start":"2026-04-17T04:12:54.554621Z","end":"2026-04-17T04:12:54.859424Z","steps":["trace[1160030691] 'agreement among raft nodes before linearized reading' (duration: 304.667241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:54.859467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.554582Z","time spent":"304.878576ms","remote":"127.0.0.1:46726","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-04-17T04:12:54.859516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.610055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-17T04:12:54.859568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.947877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:12:54.859644Z","caller":"traceutil/trace.go:171","msg":"trace[1052215472] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1201; }","duration":"306.808089ms","start":"2026-04-17T04:12:54.552811Z","end":"2026-04-17T04:12:54.859619Z","steps":["trace[1052215472] 'agreement among raft nodes before linearized reading' (duration: 306.426581ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:54.859654Z","caller":"traceutil/trace.go:171","msg":"trace[403209345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1201; }","duration":"305.07312ms","start":"2026-04-17T04:12:54.554561Z","end":"2026-04-17T04:12:54.859634Z","steps":["trace[403209345] 'agreement among raft nodes before linearized reading' (duration: 304.789943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:54.859708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.554551Z","time spent":"305.147701ms","remote":"127.0.0.1:46726","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-04-17T04:12:54.859706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.552789Z","time spent":"306.907152ms","remote":"127.0.0.1:46726","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-04-17T04:12:55.829396Z","caller":"traceutil/trace.go:171","msg":"trace[1538024690] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"966.974028ms","start":"2026-04-17T04:12:54.86239Z","end":"2026-04-17T04:12:55.829364Z","steps":["trace[1538024690] 'process raft request' (duration: 930.903835ms)","trace[1538024690] 'compare' (duration: 35.267505ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:55.829719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.862365Z","time spent":"967.221874ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:55.850354Z","caller":"traceutil/trace.go:171","msg":"trace[965034101] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"986.583971ms","start":"2026-04-17T04:12:54.863737Z","end":"2026-04-17T04:12:55.850321Z","steps":["trace[965034101] 'process raft request' (duration: 986.416067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:55.850501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.863721Z","time spent":"986.698854ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:55.850352Z","caller":"traceutil/trace.go:171","msg":"trace[1518672736] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"985.572788ms","start":"2026-04-17T04:12:54.864748Z","end":"2026-04-17T04:12:55.85032Z","steps":["trace[1518672736] 'process raft request' (duration: 985.517197ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:55.850632Z","caller":"traceutil/trace.go:171","msg":"trace[726093001] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"880.422818ms","start":"2026-04-17T04:12:54.970196Z","end":"2026-04-17T04:12:55.850619Z","steps":["trace[726093001] 'process raft request' (duration: 880.338616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:55.850644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.864741Z","time spent":"985.878665ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:55.85066Z","caller":"traceutil/trace.go:171","msg":"trace[74700103] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"984.585385ms","start":"2026-04-17T04:12:54.866065Z","end":"2026-04-17T04:12:55.850651Z","steps":["trace[74700103] 'process raft request' (duration: 984.227487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:55.850685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.970171Z","time spent":"880.487329ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:12:55.850762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:54.866058Z","time spent":"984.635366ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:12:57.140311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.304591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:12:57.140403Z","caller":"traceutil/trace.go:171","msg":"trace[758046004] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"275.238221ms","start":"2026-04-17T04:12:56.865146Z","end":"2026-04-17T04:12:57.140384Z","steps":["trace[758046004] 'process raft request' (duration: 19.788957ms)","trace[758046004] 'compare' (duration: 255.034284ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:58.303599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.017103627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:58.303662Z","caller":"traceutil/trace.go:171","msg":"trace[997431815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1209; }","duration":"1.01720668s","start":"2026-04-17T04:12:57.286441Z","end":"2026-04-17T04:12:58.303648Z","steps":["trace[997431815] 'range keys from in-memory index tree' (duration: 1.017018505s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.303691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.286424Z","time spent":"1.01725874s","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:12:58.303935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.638449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:12:58.304131Z","caller":"traceutil/trace.go:171","msg":"trace[757372178] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"949.091565ms","start":"2026-04-17T04:12:57.355007Z","end":"2026-04-17T04:12:58.304098Z","steps":["trace[757372178] 'process raft request' (duration: 368.147729ms)","trace[757372178] 'compare' (duration: 580.356032ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:58.304283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.354984Z","time spent":"949.214997ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:12:58.304635Z","caller":"traceutil/trace.go:171","msg":"trace[1697401249] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1257; }","duration":"873.821465ms","start":"2026-04-17T04:12:57.430797Z","end":"2026-04-17T04:12:58.304619Z","steps":["trace[1697401249] 'read index received' (duration: 292.314666ms)","trace[1697401249] 'applied index is now lower than readState.Index' (duration: 581.505229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:58.420148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.316263ms","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":"info","ts":"2026-04-17T04:12:58.420221Z","caller":"traceutil/trace.go:171","msg":"trace[1037600325] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1210; }","duration":"989.409925ms","start":"2026-04-17T04:12:57.430792Z","end":"2026-04-17T04:12:58.420202Z","steps":["trace[1037600325] 'agreement among raft nodes before linearized reading' (duration: 873.908837ms)","trace[1037600325] 'count revisions from in-memory index tree' (duration: 115.379246ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:58.420259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.430737Z","time spent":"989.513487ms","remote":"127.0.0.1:42864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:12:58.420227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.167694ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-17T04:12:58.420362Z","caller":"traceutil/trace.go:171","msg":"trace[783311318] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1258; }","duration":"115.674592ms","start":"2026-04-17T04:12:58.304664Z","end":"2026-04-17T04:12:58.420339Z","steps":["trace[783311318] 'read index received' (duration: 29.781µs)","trace[783311318] 'applied index is now lower than readState.Index' (duration: 115.642971ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:12:58.420491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.530619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:12:58.42057Z","caller":"traceutil/trace.go:171","msg":"trace[722547302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1210; }","duration":"565.711423ms","start":"2026-04-17T04:12:57.854838Z","end":"2026-04-17T04:12:58.420549Z","steps":["trace[722547302] 'agreement among raft nodes before linearized reading' (duration: 565.519579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.420609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.854816Z","time spent":"565.784035ms","remote":"127.0.0.1:46726","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-04-17T04:12:58.420618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.857407ms","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-04-17T04:12:58.420654Z","caller":"traceutil/trace.go:171","msg":"trace[238319795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1210; }","duration":"565.924958ms","start":"2026-04-17T04:12:57.854717Z","end":"2026-04-17T04:12:58.420642Z","steps":["trace[238319795] 'agreement among raft nodes before linearized reading' (duration: 565.731804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.420699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.85471Z","time spent":"565.977439ms","remote":"127.0.0.1:46726","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-04-17T04:12:58.420705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.104898ms","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-04-17T04:12:58.420731Z","caller":"traceutil/trace.go:171","msg":"trace[123410732] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1210; }","duration":"587.175829ms","start":"2026-04-17T04:12:57.833548Z","end":"2026-04-17T04:12:58.420724Z","steps":["trace[123410732] 'agreement among raft nodes before linearized reading' (duration: 587.044206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.420751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.833528Z","time spent":"587.219071ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T04:12:58.420779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.487718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:58.420813Z","caller":"traceutil/trace.go:171","msg":"trace[1626613282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1210; }","duration":"115.537719ms","start":"2026-04-17T04:12:58.305264Z","end":"2026-04-17T04:12:58.420802Z","steps":["trace[1626613282] 'agreement among raft nodes before linearized reading' (duration: 115.479008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.42084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.913641ms","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-04-17T04:12:58.420857Z","caller":"traceutil/trace.go:171","msg":"trace[1079574636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1210; }","duration":"566.958372ms","start":"2026-04-17T04:12:57.853893Z","end":"2026-04-17T04:12:58.420851Z","steps":["trace[1079574636] 'agreement among raft nodes before linearized reading' (duration: 566.909441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.420874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:57.853877Z","time spent":"566.992563ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T04:12:58.536141Z","caller":"traceutil/trace.go:171","msg":"trace[804917405] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"111.373384ms","start":"2026-04-17T04:12:58.424746Z","end":"2026-04-17T04:12:58.536119Z","steps":["trace[804917405] 'process raft request' (duration: 111.332163ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:58.536229Z","caller":"traceutil/trace.go:171","msg":"trace[1250712799] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"111.448426ms","start":"2026-04-17T04:12:58.424746Z","end":"2026-04-17T04:12:58.536194Z","steps":["trace[1250712799] 'process raft request' (duration: 111.18156ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:58.58284Z","caller":"traceutil/trace.go:171","msg":"trace[518222568] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1259; }","duration":"153.985988ms","start":"2026-04-17T04:12:58.428831Z","end":"2026-04-17T04:12:58.582817Z","steps":["trace[518222568] 'read index received' (duration: 107.108645ms)","trace[518222568] 'applied index is now lower than readState.Index' (duration: 46.876393ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:12:58.582976Z","caller":"traceutil/trace.go:171","msg":"trace[589505479] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"158.169736ms","start":"2026-04-17T04:12:58.424792Z","end":"2026-04-17T04:12:58.582961Z","steps":["trace[589505479] 'process raft request' (duration: 157.858939ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:12:58.583152Z","caller":"traceutil/trace.go:171","msg":"trace[2137985603] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"158.287348ms","start":"2026-04-17T04:12:58.424856Z","end":"2026-04-17T04:12:58.583143Z","steps":["trace[2137985603] 'process raft request' (duration: 157.909909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.583363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.525981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:12:58.583413Z","caller":"traceutil/trace.go:171","msg":"trace[1180195175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1214; }","duration":"154.619873ms","start":"2026-04-17T04:12:58.428781Z","end":"2026-04-17T04:12:58.583401Z","steps":["trace[1180195175] 'agreement among raft nodes before linearized reading' (duration: 154.47402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:12:58.760417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.952753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:12:58.76053Z","caller":"traceutil/trace.go:171","msg":"trace[11446970] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"173.10387ms","start":"2026-04-17T04:12:58.587407Z","end":"2026-04-17T04:12:58.760511Z","steps":["trace[11446970] 'process raft request' (duration: 71.956123ms)","trace[11446970] 'compare' (duration: 100.82953ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:13:00.109032Z","caller":"traceutil/trace.go:171","msg":"trace[27654205] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"963.660742ms","start":"2026-04-17T04:12:59.145347Z","end":"2026-04-17T04:13:00.109008Z","steps":["trace[27654205] 'process raft request' (duration: 898.166078ms)","trace[27654205] 'compare' (duration: 65.366161ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:13:00.109134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:12:59.145326Z","time spent":"963.752314ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:13:00.669711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.036102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:13:00.669795Z","caller":"traceutil/trace.go:171","msg":"trace[1245487313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1222; }","duration":"129.181315ms","start":"2026-04-17T04:13:00.540591Z","end":"2026-04-17T04:13:00.669773Z","steps":["trace[1245487313] 'range keys from in-memory index tree' (duration: 128.844988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:00.66982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.077846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:13:00.669879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.78855ms","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-04-17T04:13:00.669967Z","caller":"traceutil/trace.go:171","msg":"trace[470277112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1222; }","duration":"129.934383ms","start":"2026-04-17T04:13:00.540013Z","end":"2026-04-17T04:13:00.669947Z","steps":["trace[470277112] 'range keys from in-memory index tree' (duration: 129.524923ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:00.669909Z","caller":"traceutil/trace.go:171","msg":"trace[1621378453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"384.20287ms","start":"2026-04-17T04:13:00.285684Z","end":"2026-04-17T04:13:00.669887Z","steps":["trace[1621378453] 'range keys from in-memory index tree' (duration: 383.998715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:00.670119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:00.285666Z","time spent":"384.440685ms","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:13:01.077057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.372585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:13:01.0772Z","caller":"traceutil/trace.go:171","msg":"trace[646053705] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"310.327052ms","start":"2026-04-17T04:13:00.766825Z","end":"2026-04-17T04:13:01.077152Z","steps":["trace[646053705] 'process raft request' (duration: 156.776033ms)","trace[646053705] 'compare' (duration: 153.056208ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:13:01.077286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:00.766813Z","time spent":"310.436074ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:13:10.788359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232310742525384747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T04:13:11.060137Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.125992003s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T04:13:11.060535Z","caller":"traceutil/trace.go:171","msg":"trace[205554747] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"1.126457614s","start":"2026-04-17T04:13:09.934058Z","end":"2026-04-17T04:13:11.060515Z","steps":["trace[205554747] 'process raft request' (duration: 1.126339031s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:11.06067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:09.934034Z","time spent":"1.126564597s","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:13:11.303033Z","caller":"traceutil/trace.go:171","msg":"trace[1627660040] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1345; }","duration":"1.014891765s","start":"2026-04-17T04:13:10.288115Z","end":"2026-04-17T04:13:11.303007Z","steps":["trace[1627660040] 'read index received' (duration: 772.309809ms)","trace[1627660040] 'applied index is now lower than readState.Index' (duration: 242.581006ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:13:11.303441Z","caller":"traceutil/trace.go:171","msg":"trace[121637474] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"1.163637534s","start":"2026-04-17T04:13:10.139765Z","end":"2026-04-17T04:13:11.303403Z","steps":["trace[121637474] 'process raft request' (duration: 1.158362742s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:11.303588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.309617ms","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":"warn","ts":"2026-04-17T04:13:11.303616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.892926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-17T04:13:11.303617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.167996ms","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-04-17T04:13:11.303667Z","caller":"traceutil/trace.go:171","msg":"trace[790538643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1296; }","duration":"548.983047ms","start":"2026-04-17T04:13:10.75467Z","end":"2026-04-17T04:13:11.303653Z","steps":["trace[790538643] 'agreement among raft nodes before linearized reading' (duration: 548.782743ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:11.303673Z","caller":"traceutil/trace.go:171","msg":"trace[1536156481] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1296; }","duration":"187.284799ms","start":"2026-04-17T04:13:11.116376Z","end":"2026-04-17T04:13:11.30366Z","steps":["trace[1536156481] 'agreement among raft nodes before linearized reading' (duration: 187.067994ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:11.303666Z","caller":"traceutil/trace.go:171","msg":"trace[325825911] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1296; }","duration":"254.43813ms","start":"2026-04-17T04:13:11.049206Z","end":"2026-04-17T04:13:11.303644Z","steps":["trace[325825911] 'agreement among raft nodes before linearized reading' (duration: 254.190554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:11.303684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.722822ms","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-04-17T04:13:11.303712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:10.754663Z","time spent":"549.04051ms","remote":"127.0.0.1:46726","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-04-17T04:13:11.303627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:10.139741Z","time spent":"1.163802667s","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:13:11.303756Z","caller":"traceutil/trace.go:171","msg":"trace[1488695916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1296; }","duration":"548.809353ms","start":"2026-04-17T04:13:10.754926Z","end":"2026-04-17T04:13:11.303735Z","steps":["trace[1488695916] 'agreement among raft nodes before linearized reading' (duration: 548.552637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:11.303628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01550391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:13:11.303796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.288734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-17T04:13:11.30382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:10.754915Z","time spent":"548.891346ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T04:13:11.303814Z","caller":"traceutil/trace.go:171","msg":"trace[457249765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"1.015739005s","start":"2026-04-17T04:13:10.288065Z","end":"2026-04-17T04:13:11.303804Z","steps":["trace[457249765] 'agreement among raft nodes before linearized reading' (duration: 1.015496259s)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:11.303906Z","caller":"traceutil/trace.go:171","msg":"trace[1101343756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1296; }","duration":"549.351086ms","start":"2026-04-17T04:13:10.754494Z","end":"2026-04-17T04:13:11.303845Z","steps":["trace[1101343756] 'agreement among raft nodes before linearized reading' (duration: 549.207623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:11.303929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:10.288047Z","time spent":"1.015871469s","remote":"127.0.0.1:46476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:13:11.303968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:10.754434Z","time spent":"549.51977ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T04:13:11.304366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.734524ms","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-04-17T04:13:11.304415Z","caller":"traceutil/trace.go:171","msg":"trace[2065507074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1296; }","duration":"555.817326ms","start":"2026-04-17T04:13:10.748583Z","end":"2026-04-17T04:13:11.3044Z","steps":["trace[2065507074] 'agreement among raft nodes before linearized reading' (duration: 555.227972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:11.304519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:13:10.748562Z","time spent":"555.876818ms","remote":"127.0.0.1:46726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T04:13:25.526257Z","caller":"traceutil/trace.go:171","msg":"trace[604119278] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"162.141018ms","start":"2026-04-17T04:13:25.364079Z","end":"2026-04-17T04:13:25.52622Z","steps":["trace[604119278] 'read index received' (duration: 161.753669ms)","trace[604119278] 'applied index is now lower than readState.Index' (duration: 386.219µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:13:25.526375Z","caller":"traceutil/trace.go:171","msg":"trace[1994864741] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"182.190391ms","start":"2026-04-17T04:13:25.344145Z","end":"2026-04-17T04:13:25.526336Z","steps":["trace[1994864741] 'process raft request' (duration: 181.831792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:25.526557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.429514ms","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-04-17T04:13:25.526608Z","caller":"traceutil/trace.go:171","msg":"trace[368162731] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1360; }","duration":"162.567248ms","start":"2026-04-17T04:13:25.364028Z","end":"2026-04-17T04:13:25.526595Z","steps":["trace[368162731] 'agreement among raft nodes before linearized reading' (duration: 162.382563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:25.526983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.306235ms","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-04-17T04:13:25.527066Z","caller":"traceutil/trace.go:171","msg":"trace[1807772401] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1360; }","duration":"147.474208ms","start":"2026-04-17T04:13:25.37957Z","end":"2026-04-17T04:13:25.527045Z","steps":["trace[1807772401] 'agreement among raft nodes before linearized reading' (duration: 147.041368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:25.527111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.685889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-17T04:13:25.527133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.4495ms","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-04-17T04:13:25.526983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.041105ms","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-04-17T04:13:25.527192Z","caller":"traceutil/trace.go:171","msg":"trace[1055936734] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1360; }","duration":"152.825012ms","start":"2026-04-17T04:13:25.374348Z","end":"2026-04-17T04:13:25.527173Z","steps":["trace[1055936734] 'agreement among raft nodes before linearized reading' (duration: 152.548836ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:25.527196Z","caller":"traceutil/trace.go:171","msg":"trace[1925593724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1360; }","duration":"154.521031ms","start":"2026-04-17T04:13:25.372658Z","end":"2026-04-17T04:13:25.527179Z","steps":["trace[1925593724] 'agreement among raft nodes before linearized reading' (duration: 154.379638ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:25.52723Z","caller":"traceutil/trace.go:171","msg":"trace[1600342583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1360; }","duration":"149.339022ms","start":"2026-04-17T04:13:25.377877Z","end":"2026-04-17T04:13:25.527216Z","steps":["trace[1600342583] 'agreement among raft nodes before linearized reading' (duration: 148.711287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:25.526996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.702947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T04:13:25.52734Z","caller":"traceutil/trace.go:171","msg":"trace[717669215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1360; }","duration":"149.054215ms","start":"2026-04-17T04:13:25.378264Z","end":"2026-04-17T04:13:25.527318Z","steps":["trace[717669215] 'agreement among raft nodes before linearized reading' (duration: 148.612705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:25.52753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.579489ms","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-04-17T04:13:25.527595Z","caller":"traceutil/trace.go:171","msg":"trace[1704853029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1360; }","duration":"156.658251ms","start":"2026-04-17T04:13:25.370921Z","end":"2026-04-17T04:13:25.527579Z","steps":["trace[1704853029] 'agreement among raft nodes before linearized reading' (duration: 155.650288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:13:31.492904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.271187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:13:31.492909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.163655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:13:31.492968Z","caller":"traceutil/trace.go:171","msg":"trace[1211111472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1387; }","duration":"206.38003ms","start":"2026-04-17T04:13:31.286573Z","end":"2026-04-17T04:13:31.492953Z","steps":["trace[1211111472] 'range keys from in-memory index tree' (duration: 206.208956ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:13:31.492977Z","caller":"traceutil/trace.go:171","msg":"trace[1460393026] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1387; }","duration":"254.280907ms","start":"2026-04-17T04:13:31.238682Z","end":"2026-04-17T04:13:31.492963Z","steps":["trace[1460393026] 'count revisions from in-memory index tree' (duration: 254.076233ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:38.59617Z","caller":"traceutil/trace.go:171","msg":"trace[1260133656] transaction","detail":"{read_only:false; response_revision:1699; number_of_response:1; }","duration":"122.596316ms","start":"2026-04-17T04:14:38.473554Z","end":"2026-04-17T04:14:38.596151Z","steps":["trace[1260133656] 'process raft request' (duration: 122.455433ms)"],"step_count":1}